builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0024 starttime: 1492445738.54 results: success (0) buildid: 20170417075506 builduid: cc2a3ad608454d1f9f535d80cd6017de revision: 5049738b566005c47b8b6e4c07639340ff09a15a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-17 09:15:38.541771) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-17 09:15:38.542217) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-17 09:15:38.542499) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-17 09:15:38.567715) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 09:15:38.568073) ========= 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.B3gshzoLBo/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.G8p66e2YDu/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 --2017-04-17 09:15:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 39.8M=0s 2017-04-17 09:15:38 (39.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129753 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 09:15:38.721396) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 09:15:38.721721) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.B3gshzoLBo/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.G8p66e2YDu/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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.022386 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 09:15:38.770572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-17 09:15:38.770932) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5049738b566005c47b8b6e4c07639340ff09a15a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5049738b566005c47b8b6e4c07639340ff09a15a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.B3gshzoLBo/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.G8p66e2YDu/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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 2017-04-17 09:15:38,864 truncating revision to first 12 chars 2017-04-17 09:15:38,864 Setting DEBUG logging. 2017-04-17 09:15:38,864 attempt 1/10 2017-04-17 09:15:38,864 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5049738b5660?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-17 09:15:39,735 unpacking tar archive at: mozilla-aurora-5049738b5660/testing/mozharness/ program finished with exit code 0 elapsedTime=1.131257 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-17 09:15:39.926045) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-17 09:15:39.926367) ========= script_repo_revision: 5049738b566005c47b8b6e4c07639340ff09a15a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-17 09:15:39.926767) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-17 09:15:39.927036) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-17 09:15:39.946821) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-17 09:15:39.947141) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.B3gshzoLBo/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.G8p66e2YDu/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:15:40 INFO - MultiFileLogger online at 20170417 09:15:40 in /builds/slave/test 09:15:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:15:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:15:40 INFO - {'append_to_log': False, 09:15:40 INFO - 'base_work_dir': '/builds/slave/test', 09:15:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:15:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:15:40 INFO - 'branch': 'Mozilla-Aurora', 09:15:40 INFO - 'buildbot_json_path': 'buildprops.json', 09:15:40 INFO - 'config_files': ('talos/mac_config.py',), 09:15:40 INFO - 'default_actions': ('clobber', 09:15:40 INFO - 'read-buildbot-config', 09:15:40 INFO - 'download-and-extract', 09:15:40 INFO - 'populate-webroot', 09:15:40 INFO - 'create-virtualenv', 09:15:40 INFO - 'install', 09:15:40 INFO - 'run-tests'), 09:15:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:15:40 INFO - 'download_minidump_stackwalk': True, 09:15:40 INFO - 'download_symbols': 'ondemand', 09:15:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:15:40 INFO - 'tooltool.py': '/tools/tooltool.py', 09:15:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:15:40 INFO - '/tools/misc-python/virtualenv.py')}, 09:15:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:15:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:15:40 INFO - 'gecko_profile': False, 09:15:40 INFO - 'gecko_profile_interval': 0, 09:15:40 INFO - 'installer_path': 'installer.exe', 09:15:40 INFO - 'log_level': 'info', 09:15:40 INFO - 'log_name': 'talos', 09:15:40 INFO - 'log_to_console': True, 09:15:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:15:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:15:40 INFO - 'opt_config_files': (), 09:15:40 INFO - 'pip_index': False, 09:15:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:15:40 INFO - 'cmd': ('bash', 09:15:40 INFO - '-c', 09:15:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:15:40 INFO - 'enabled': True, 09:15:40 INFO - 'halt_on_failure': False, 09:15:40 INFO - 'name': 'check_screen_resolution'},), 09:15:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:15:40 INFO - 'cmd': ('bash', 09:15:40 INFO - '-c', 09:15:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:15:40 INFO - 'enabled': True, 09:15:40 INFO - 'halt_on_failure': False, 09:15:40 INFO - 'name': 'check_screen_resolution'},), 09:15:40 INFO - 'run_cmd_checks_enabled': True, 09:15:40 INFO - 'suite': 'dromaeojs-e10s', 09:15:40 INFO - 'system_bits': '32', 09:15:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:15:40 INFO - 'title': 't-yosemite-r7-0024', 09:15:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:15:40 INFO - 'use_talos_json': True, 09:15:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:15:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:15:40 INFO - 'work_dir': 'build'} 09:15:40 INFO - [mozharness: 2017-04-17 16:15:40.164774Z] Running clobber step. 09:15:40 INFO - Running pre-action listener: _resource_record_pre_action 09:15:40 INFO - Running main action method: clobber 09:15:40 INFO - rmtree: /builds/slave/test/build 09:15:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:15:41 INFO - Running post-action listener: _resource_record_post_action 09:15:41 INFO - [mozharness: 2017-04-17 16:15:41.912693Z] Finished clobber step (success) 09:15:41 INFO - [mozharness: 2017-04-17 16:15:41.912816Z] Running read-buildbot-config step. 09:15:41 INFO - Running pre-action listener: _resource_record_pre_action 09:15:41 INFO - Running main action method: read_buildbot_config 09:15:41 INFO - Using buildbot properties: 09:15:41 INFO - { 09:15:41 INFO - "project": "", 09:15:41 INFO - "product": "firefox", 09:15:41 INFO - "script_repo_revision": "production", 09:15:41 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 09:15:41 INFO - "repository": "", 09:15:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 09:15:41 INFO - "buildid": "20170417075506", 09:15:41 INFO - "pgo_build": "False", 09:15:41 INFO - "basedir": "/builds/slave/test", 09:15:41 INFO - "buildnumber": 20, 09:15:41 INFO - "slavename": "t-yosemite-r7-0024", 09:15:41 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 09:15:41 INFO - "platform": "yosemite_r7", 09:15:41 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:15:41 INFO - "branch": "mozilla-aurora", 09:15:41 INFO - "repo_path": "releases/mozilla-aurora", 09:15:41 INFO - "revision": "5049738b566005c47b8b6e4c07639340ff09a15a", 09:15:41 INFO - "stage_platform": "macosx64", 09:15:41 INFO - "builduid": "cc2a3ad608454d1f9f535d80cd6017de", 09:15:41 INFO - "slavebuilddir": "test" 09:15:41 INFO - } 09:15:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/Mtc4L6VNT2KGKvYdfK9MIg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 09:15:41 INFO - Running post-action listener: _resource_record_post_action 09:15:41 INFO - [mozharness: 2017-04-17 16:15:41.916302Z] Finished read-buildbot-config step (success) 09:15:41 INFO - [mozharness: 2017-04-17 16:15:41.916433Z] Running download-and-extract step. 09:15:41 INFO - Running pre-action listener: _resource_record_pre_action 09:15:41 INFO - Running main action method: download_and_extract 09:15:41 INFO - mkdir: /builds/slave/test/build/tests 09:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:41 INFO - trying https://queue.taskcluster.net/v1/task/Mtc4L6VNT2KGKvYdfK9MIg/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 09:15:41 INFO - Downloading https://queue.taskcluster.net/v1/task/Mtc4L6VNT2KGKvYdfK9MIg/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 09:15:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Mtc4L6VNT2KGKvYdfK9MIg/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 09:15:42 INFO - Downloaded 1199 bytes. 09:15:42 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 09:15:42 INFO - Using the following test package requirements: 09:15:42 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 09:15:42 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:15:42 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 09:15:42 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:15:42 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 09:15:42 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:15:42 INFO - u'jsshell-mac.zip'], 09:15:42 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:15:42 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 09:15:42 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 09:15:42 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:15:42 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 09:15:42 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:15:42 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 09:15:42 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:15:42 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 09:15:42 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:15:42 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 09:15:42 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:15:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mtc4L6VNT2KGKvYdfK9MIg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 09:15:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mtc4L6VNT2KGKvYdfK9MIg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:15:42 INFO - Fetch https://queue.taskcluster.net/v1/task/Mtc4L6VNT2KGKvYdfK9MIg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 09:15:44 INFO - Expected file size: 51791786 09:15:44 INFO - Obtained file size: 51791786 09:16:00 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:16:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mtc4L6VNT2KGKvYdfK9MIg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 09:16:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mtc4L6VNT2KGKvYdfK9MIg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:16:00 INFO - Fetch https://queue.taskcluster.net/v1/task/Mtc4L6VNT2KGKvYdfK9MIg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 09:16:02 INFO - Expected file size: 51791786 09:16:02 INFO - Obtained file size: 51791786 09:16:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mtc4L6VNT2KGKvYdfK9MIg/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 09:16:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mtc4L6VNT2KGKvYdfK9MIg/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:16:17 INFO - Fetch https://queue.taskcluster.net/v1/task/Mtc4L6VNT2KGKvYdfK9MIg/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 09:16:19 INFO - Expected file size: 14404424 09:16:19 INFO - Obtained file size: 14404424 09:16:19 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:19 INFO - trying https://queue.taskcluster.net/v1/task/Mtc4L6VNT2KGKvYdfK9MIg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 09:16:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Mtc4L6VNT2KGKvYdfK9MIg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 09:16:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Mtc4L6VNT2KGKvYdfK9MIg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 09:16:21 INFO - Downloaded 74742244 bytes. 09:16:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Mtc4L6VNT2KGKvYdfK9MIg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 09:16:21 INFO - mkdir: /builds/slave/test/properties 09:16:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:16:21 INFO - Writing to file /builds/slave/test/properties/build_url 09:16:21 INFO - Contents: 09:16:21 INFO - build_url:https://queue.taskcluster.net/v1/task/Mtc4L6VNT2KGKvYdfK9MIg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 09:16:22 INFO - Running post-action listener: _resource_record_post_action 09:16:22 INFO - Running post-action listener: set_extra_try_arguments 09:16:22 INFO - [mozharness: 2017-04-17 16:16:22.278938Z] Finished download-and-extract step (success) 09:16:22 INFO - [mozharness: 2017-04-17 16:16:22.279100Z] Running populate-webroot step. 09:16:22 INFO - Running pre-action listener: _resource_record_pre_action 09:16:22 INFO - Running main action method: populate_webroot 09:16:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:16:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:16:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:16:22 INFO - '--tppagecycles', 09:16:22 INFO - '7'], 09:16:22 INFO - 'tests': ['tsvgm']}}, 09:16:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:16:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:16:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:16:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:16:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:16:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:16:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:16:22 INFO - 'talos_options': ['--disable-e10s'], 09:16:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:16:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:16:22 INFO - 'talos_options': ['--disable-e10s'], 09:16:22 INFO - 'tests': ['damp', 'tps']}, 09:16:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:16:22 INFO - 'tests': ['damp', 'tps']}, 09:16:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:16:22 INFO - 'tests': ['dromaeo_dom']}, 09:16:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:16:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:16:22 INFO - 'tests': ['basic_compositor_video']}, 09:16:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:16:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:16:22 INFO - 'tests': ['a11yr', 09:16:22 INFO - 'ts_paint', 09:16:22 INFO - 'tpaint', 09:16:22 INFO - 'sessionrestore', 09:16:22 INFO - 'sessionrestore_no_auto_restore', 09:16:22 INFO - 'tabpaint']}, 09:16:22 INFO - 'other-e10s': {'tests': ['a11yr', 09:16:22 INFO - 'ts_paint', 09:16:22 INFO - 'tpaint', 09:16:22 INFO - 'sessionrestore', 09:16:22 INFO - 'sessionrestore_no_auto_restore', 09:16:22 INFO - 'tabpaint']}, 09:16:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:16:22 INFO - 'ts_paint', 09:16:22 INFO - 'tpaint', 09:16:22 INFO - 'sessionrestore', 09:16:22 INFO - 'sessionrestore_no_auto_restore', 09:16:22 INFO - 'tabpaint']}, 09:16:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:16:22 INFO - 'ts_paint', 09:16:22 INFO - 'tpaint', 09:16:22 INFO - 'sessionrestore', 09:16:22 INFO - 'sessionrestore_no_auto_restore', 09:16:22 INFO - 'tabpaint']}, 09:16:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:16:22 INFO - 'tests': ['a11yr', 09:16:22 INFO - 'ts_paint', 09:16:22 INFO - 'tpaint', 09:16:22 INFO - 'sessionrestore', 09:16:22 INFO - 'sessionrestore_no_auto_restore', 09:16:22 INFO - 'tabpaint']}, 09:16:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:16:22 INFO - 'tests': ['a11yr', 09:16:22 INFO - 'ts_paint', 09:16:22 INFO - 'tpaint', 09:16:22 INFO - 'sessionrestore', 09:16:22 INFO - 'sessionrestore_no_auto_restore', 09:16:22 INFO - 'tabpaint']}, 09:16:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:16:22 INFO - 'tests': ['tsvgx', 09:16:22 INFO - 'tsvgr_opacity', 09:16:22 INFO - 'tart', 09:16:22 INFO - 'tscrollx', 09:16:22 INFO - 'cart', 09:16:22 INFO - 'tsvg_static']}, 09:16:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:16:22 INFO - 'tsvgr_opacity', 09:16:22 INFO - 'tart', 09:16:22 INFO - 'tscrollx', 09:16:22 INFO - 'cart', 09:16:22 INFO - 'tsvg_static']}, 09:16:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:16:22 INFO - 'talos_options': ['--disable-e10s'], 09:16:22 INFO - 'tests': ['tp5o']}, 09:16:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:16:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:16:22 INFO - 'talos_options': ['--disable-e10s', 09:16:22 INFO - '--xperf_path', 09:16:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:22 INFO - 'tests': ['tp5n']}, 09:16:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:16:22 INFO - 'talos_options': ['--xperf_path', 09:16:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:22 INFO - 'tests': ['tp5n']}}, 09:16:22 INFO - 'talos.zip': {'path': '', 09:16:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:16:22 INFO - Running post-action listener: _resource_record_post_action 09:16:22 INFO - [mozharness: 2017-04-17 16:16:22.297871Z] Finished populate-webroot step (success) 09:16:22 INFO - [mozharness: 2017-04-17 16:16:22.297995Z] Running create-virtualenv step. 09:16:22 INFO - Running pre-action listener: _resource_record_pre_action 09:16:22 INFO - Running main action method: create_virtualenv 09:16:22 INFO - Creating virtualenv /builds/slave/test/build/venv 09:16:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:16:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:16:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:16:22 INFO - Using real prefix '/tools/python27' 09:16:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:16:23 INFO - Installing distribute.............................................................................................................................................................................................done. 09:16:26 INFO - Installing pip.................done. 09:16:26 INFO - Return code: 0 09:16:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:16:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:16:26 INFO - Reading from file tmpfile_stdout 09:16:26 INFO - Output received: 09:16:26 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:16:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:26 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 0x10ce43b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce46768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8795a3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc21d30>, '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 0x10cb48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc16be8>, '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.B3gshzoLBo/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.G8p66e2YDu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:16:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:16:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:16:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B3gshzoLBo/Render', 09:16:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:26 INFO - 'HOME': '/Users/cltbld', 09:16:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:26 INFO - 'LOGNAME': 'cltbld', 09:16:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:26 INFO - 'MOZ_NO_REMOTE': '1', 09:16:26 INFO - 'NO_EM_RESTART': '1', 09:16:26 INFO - 'PAGER': '/bin/cat', 09:16:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:26 INFO - 'PWD': '/builds/slave/test', 09:16:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:26 INFO - 'SHELL': '/bin/bash', 09:16:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8p66e2YDu/Listeners', 09:16:26 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:16:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:26 INFO - 'USER': 'cltbld', 09:16:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:26 INFO - 'XPC_FLAGS': '0x0', 09:16:26 INFO - 'XPC_SERVICE_NAME': '0', 09:16:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:16:26 INFO - Cleaning up... 09:16:26 INFO - Return code: 0 09:16:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:26 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ce43b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce46768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8795a3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc21d30>, '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 0x10cb48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc16be8>, '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.B3gshzoLBo/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.G8p66e2YDu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:16:26 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>=3.1.1'] in /builds/slave/test/build 09:16:26 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>=3.1.1 09:16:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B3gshzoLBo/Render', 09:16:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:26 INFO - 'HOME': '/Users/cltbld', 09:16:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:26 INFO - 'LOGNAME': 'cltbld', 09:16:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:26 INFO - 'MOZ_NO_REMOTE': '1', 09:16:26 INFO - 'NO_EM_RESTART': '1', 09:16:26 INFO - 'PAGER': '/bin/cat', 09:16:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:26 INFO - 'PWD': '/builds/slave/test', 09:16:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:26 INFO - 'SHELL': '/bin/bash', 09:16:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8p66e2YDu/Listeners', 09:16:26 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:16:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:26 INFO - 'USER': 'cltbld', 09:16:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:26 INFO - 'XPC_FLAGS': '0x0', 09:16:26 INFO - 'XPC_SERVICE_NAME': '0', 09:16:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:26 INFO - Downloading/unpacking psutil>=3.1.1 09:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:16:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:30 INFO - Installing collected packages: psutil 09:16:30 INFO - Running setup.py install for psutil 09:16:30 INFO - building 'psutil._psutil_osx' extension 09:16:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:16:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:16:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:16:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:16:30 INFO - building 'psutil._psutil_posix' extension 09:16:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:16:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:16:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:16:31 INFO - ^ 09:16:31 INFO - 1 warning generated. 09:16:31 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:16:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:31 INFO - Successfully installed psutil 09:16:31 INFO - Cleaning up... 09:16:31 INFO - Return code: 0 09:16:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:16:31 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:31 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:31 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ce43b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce46768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8795a3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc21d30>, '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 0x10cb48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc16be8>, '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.B3gshzoLBo/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.G8p66e2YDu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:16:31 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.3'] in /builds/slave/test/build 09:16:31 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.3 09:16:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B3gshzoLBo/Render', 09:16:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:31 INFO - 'HOME': '/Users/cltbld', 09:16:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:31 INFO - 'LOGNAME': 'cltbld', 09:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:31 INFO - 'MOZ_NO_REMOTE': '1', 09:16:31 INFO - 'NO_EM_RESTART': '1', 09:16:31 INFO - 'PAGER': '/bin/cat', 09:16:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:31 INFO - 'PWD': '/builds/slave/test', 09:16:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:31 INFO - 'SHELL': '/bin/bash', 09:16:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8p66e2YDu/Listeners', 09:16:31 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:16:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:31 INFO - 'USER': 'cltbld', 09:16:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:31 INFO - 'XPC_FLAGS': '0x0', 09:16:31 INFO - 'XPC_SERVICE_NAME': '0', 09:16:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:16:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:16:34 INFO - Installing collected packages: mozsystemmonitor 09:16:34 INFO - Running setup.py install for mozsystemmonitor 09:16:34 INFO - Successfully installed mozsystemmonitor 09:16:34 INFO - Cleaning up... 09:16:34 INFO - Return code: 0 09:16:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:34 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ce43b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce46768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8795a3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc21d30>, '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 0x10cb48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc16be8>, '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.B3gshzoLBo/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.G8p66e2YDu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:16:34 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==2.5.1'] in /builds/slave/test/build 09:16:34 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==2.5.1 09:16:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B3gshzoLBo/Render', 09:16:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:34 INFO - 'HOME': '/Users/cltbld', 09:16:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:34 INFO - 'LOGNAME': 'cltbld', 09:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:34 INFO - 'MOZ_NO_REMOTE': '1', 09:16:34 INFO - 'NO_EM_RESTART': '1', 09:16:34 INFO - 'PAGER': '/bin/cat', 09:16:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:34 INFO - 'PWD': '/builds/slave/test', 09:16:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:34 INFO - 'SHELL': '/bin/bash', 09:16:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8p66e2YDu/Listeners', 09:16:34 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:16:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:34 INFO - 'USER': 'cltbld', 09:16:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:34 INFO - 'XPC_FLAGS': '0x0', 09:16:34 INFO - 'XPC_SERVICE_NAME': '0', 09:16:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:35 INFO - Downloading/unpacking jsonschema==2.5.1 09:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:16:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:38 INFO - Downloading functools32-3.2.3-2.tar.gz 09:16:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:16:38 INFO - warning: no files found matching '*.txt' 09:16:38 INFO - no previously-included directories found matching 'build' 09:16:38 INFO - no previously-included directories found matching 'dist' 09:16:38 INFO - no previously-included directories found matching '.git*' 09:16:38 INFO - Installing collected packages: jsonschema, functools32 09:16:38 INFO - Running setup.py install for functools32 09:16:38 INFO - warning: no files found matching '*.txt' 09:16:38 INFO - no previously-included directories found matching 'build' 09:16:38 INFO - no previously-included directories found matching 'dist' 09:16:38 INFO - no previously-included directories found matching '.git*' 09:16:38 INFO - Successfully installed jsonschema functools32 09:16:38 INFO - Cleaning up... 09:16:39 INFO - Return code: 0 09:16:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:39 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ce43b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce46768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8795a3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc21d30>, '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 0x10cb48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc16be8>, '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.B3gshzoLBo/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.G8p66e2YDu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:16:39 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:16:39 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 functools32==3.2.3-2 09:16:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B3gshzoLBo/Render', 09:16:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:39 INFO - 'HOME': '/Users/cltbld', 09:16:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:39 INFO - 'LOGNAME': 'cltbld', 09:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:39 INFO - 'MOZ_NO_REMOTE': '1', 09:16:39 INFO - 'NO_EM_RESTART': '1', 09:16:39 INFO - 'PAGER': '/bin/cat', 09:16:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:39 INFO - 'PWD': '/builds/slave/test', 09:16:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:39 INFO - 'SHELL': '/bin/bash', 09:16:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8p66e2YDu/Listeners', 09:16:39 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:16:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:39 INFO - 'USER': 'cltbld', 09:16:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:39 INFO - 'XPC_FLAGS': '0x0', 09:16:39 INFO - 'XPC_SERVICE_NAME': '0', 09:16:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:16:39 INFO - Cleaning up... 09:16:39 INFO - Return code: 0 09:16:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:39 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 0x10ce43b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce46768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8795a3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc21d30>, '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 0x10cb48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc16be8>, '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.B3gshzoLBo/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.G8p66e2YDu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:16:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:16:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B3gshzoLBo/Render', 09:16:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:39 INFO - 'HOME': '/Users/cltbld', 09:16:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:39 INFO - 'LOGNAME': 'cltbld', 09:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:39 INFO - 'MOZ_NO_REMOTE': '1', 09:16:39 INFO - 'NO_EM_RESTART': '1', 09:16:39 INFO - 'PAGER': '/bin/cat', 09:16:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:39 INFO - 'PWD': '/builds/slave/test', 09:16:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:39 INFO - 'SHELL': '/bin/bash', 09:16:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8p66e2YDu/Listeners', 09:16:39 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:16:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:39 INFO - 'USER': 'cltbld', 09:16:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:39 INFO - 'XPC_FLAGS': '0x0', 09:16:39 INFO - 'XPC_SERVICE_NAME': '0', 09:16:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:39 INFO - Downloading/unpacking blobuploader==1.2.4 09:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:42 INFO - Downloading blobuploader-1.2.4.tar.gz 09:16:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:16:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:16:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:43 INFO - Downloading docopt-0.6.1.tar.gz 09:16:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:16:43 INFO - Installing collected packages: blobuploader, requests, docopt 09:16:43 INFO - Running setup.py install for blobuploader 09:16:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:16:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:16:44 INFO - Running setup.py install for requests 09:16:44 INFO - Running setup.py install for docopt 09:16:44 INFO - Successfully installed blobuploader requests docopt 09:16:44 INFO - Cleaning up... 09:16:44 INFO - Return code: 0 09:16:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:44 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 0x10ce43b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce46768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8795a3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc21d30>, '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 0x10cb48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc16be8>, '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.B3gshzoLBo/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.G8p66e2YDu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:16:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:16:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:16:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B3gshzoLBo/Render', 09:16:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:44 INFO - 'HOME': '/Users/cltbld', 09:16:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:44 INFO - 'LOGNAME': 'cltbld', 09:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:44 INFO - 'MOZ_NO_REMOTE': '1', 09:16:44 INFO - 'NO_EM_RESTART': '1', 09:16:44 INFO - 'PAGER': '/bin/cat', 09:16:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:44 INFO - 'PWD': '/builds/slave/test', 09:16:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:44 INFO - 'SHELL': '/bin/bash', 09:16:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8p66e2YDu/Listeners', 09:16:44 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:16:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:44 INFO - 'USER': 'cltbld', 09:16:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:44 INFO - 'XPC_FLAGS': '0x0', 09:16:44 INFO - 'XPC_SERVICE_NAME': '0', 09:16:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:16:45 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-xRbuLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:16:45 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-TTmNgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:16:45 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-glygOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:16:45 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-olzKK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:16:45 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-sLyQ25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:16:45 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-wY62A7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:16:45 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-9CDoT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:16:45 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-Z7vfle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:16:45 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-nMfAP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:16:45 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-dFOmvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:16:46 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-WHLghN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:16:46 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-P92EqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:16:46 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-tED8zj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:16:46 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-_kBfSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:46 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-RQtWHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:16:46 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-ZwEX_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:16:46 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-jYiLIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:16:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:16:46 INFO - Running setup.py install for manifestparser 09:16:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:16:46 INFO - Running setup.py install for mozcrash 09:16:47 INFO - Running setup.py install for mozdebug 09:16:47 INFO - Running setup.py install for mozdevice 09:16:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:16:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:16:47 INFO - Running setup.py install for mozfile 09:16:47 INFO - Running setup.py install for mozhttpd 09:16:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:16:47 INFO - Running setup.py install for mozinfo 09:16:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:16:47 INFO - Running setup.py install for mozInstall 09:16:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:16:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:16:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:16:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:16:48 INFO - Running setup.py install for mozleak 09:16:48 INFO - Running setup.py install for mozlog 09:16:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:16:48 INFO - Running setup.py install for moznetwork 09:16:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:16:48 INFO - Running setup.py install for mozprocess 09:16:48 INFO - Running setup.py install for mozprofile 09:16:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:16:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:16:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:16:48 INFO - Running setup.py install for mozrunner 09:16:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:16:49 INFO - Running setup.py install for mozscreenshot 09:16:49 INFO - Running setup.py install for moztest 09:16:49 INFO - Running setup.py install for mozversion 09:16:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:16:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:16:49 INFO - Cleaning up... 09:16:49 INFO - Return code: 0 09:16:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:49 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:49 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:49 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 0x10ce43b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce46768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8795a3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc21d30>, '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 0x10cb48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc16be8>, '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.B3gshzoLBo/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.G8p66e2YDu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:16:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:16:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:16:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B3gshzoLBo/Render', 09:16:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:49 INFO - 'HOME': '/Users/cltbld', 09:16:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:49 INFO - 'LOGNAME': 'cltbld', 09:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:49 INFO - 'MOZ_NO_REMOTE': '1', 09:16:49 INFO - 'NO_EM_RESTART': '1', 09:16:49 INFO - 'PAGER': '/bin/cat', 09:16:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:49 INFO - 'PWD': '/builds/slave/test', 09:16:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:49 INFO - 'SHELL': '/bin/bash', 09:16:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8p66e2YDu/Listeners', 09:16:49 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:16:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:49 INFO - 'USER': 'cltbld', 09:16:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:49 INFO - 'XPC_FLAGS': '0x0', 09:16:49 INFO - 'XPC_SERVICE_NAME': '0', 09:16:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:16:49 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-3cK7qE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:16:49 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-pEg8fj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:16:49 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-SZj42l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:16:50 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-23Hus3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:16:50 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-wfploR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:16:50 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-Crrc2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:16:50 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-pxH6xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:16:50 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-Y5ukef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:16:50 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-nEt51I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:16:50 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-paY4ao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:16:50 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-VqIPna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:16:50 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-wxob8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:16:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:16:51 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-t_MsEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:16:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:16:51 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-rme3QH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:16:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:51 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-oXVyTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:16:51 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-m8ENAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:16:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:16:51 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-g0gsmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:16:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:16:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:16:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:16:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:16:51 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:16:51 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:16:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:54 INFO - Downloading blessings-1.6.tar.gz 09:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:16:54 INFO - Installing collected packages: blessings 09:16:54 INFO - Running setup.py install for blessings 09:16:54 INFO - Successfully installed blessings 09:16:54 INFO - Cleaning up... 09:16:54 INFO - Return code: 0 09:16:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:16:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:16:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:16:54 INFO - Reading from file tmpfile_stdout 09:16:54 INFO - Current package versions: 09:16:54 INFO - blessings == 1.6 09:16:54 INFO - blobuploader == 1.2.4 09:16:54 INFO - docopt == 0.6.1 09:16:54 INFO - functools32 == 3.2.3-2 09:16:54 INFO - jsonschema == 2.5.1 09:16:54 INFO - manifestparser == 1.1 09:16:54 INFO - mozInstall == 1.12 09:16:54 INFO - mozcrash == 1.0 09:16:54 INFO - mozdebug == 0.1 09:16:54 INFO - mozdevice == 0.49 09:16:54 INFO - mozfile == 1.2 09:16:54 INFO - mozhttpd == 0.7 09:16:54 INFO - mozinfo == 0.9 09:16:54 INFO - mozleak == 0.1 09:16:54 INFO - mozlog == 3.4 09:16:54 INFO - moznetwork == 0.27 09:16:54 INFO - mozprocess == 0.25 09:16:54 INFO - mozprofile == 0.28 09:16:54 INFO - mozrunner == 6.13 09:16:54 INFO - mozscreenshot == 0.1 09:16:54 INFO - mozsystemmonitor == 0.3 09:16:54 INFO - moztest == 0.8 09:16:54 INFO - mozversion == 1.4 09:16:54 INFO - psutil == 3.1.1 09:16:54 INFO - requests == 1.2.3 09:16:54 INFO - wsgiref == 0.1.2 09:16:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:54 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:54 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:54 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 0x10ce43b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce46768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8795a3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc21d30>, '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 0x10cb48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc16be8>, '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.B3gshzoLBo/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.G8p66e2YDu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:16:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:16:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:16:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B3gshzoLBo/Render', 09:16:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:54 INFO - 'HOME': '/Users/cltbld', 09:16:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:54 INFO - 'LOGNAME': 'cltbld', 09:16:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:54 INFO - 'MOZ_NO_REMOTE': '1', 09:16:54 INFO - 'NO_EM_RESTART': '1', 09:16:54 INFO - 'PAGER': '/bin/cat', 09:16:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:54 INFO - 'PWD': '/builds/slave/test', 09:16:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:54 INFO - 'SHELL': '/bin/bash', 09:16:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8p66e2YDu/Listeners', 09:16:54 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:16:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:54 INFO - 'USER': 'cltbld', 09:16:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:54 INFO - 'XPC_FLAGS': '0x0', 09:16:54 INFO - 'XPC_SERVICE_NAME': '0', 09:16:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:16:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:16:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:16:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:16:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:16:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:16:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:16:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:16:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:16:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:16:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:16:55 INFO - Cleaning up... 09:16:55 INFO - Return code: 0 09:16:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ce43b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce46768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8795a3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc21d30>, '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 0x10cb48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc16be8>, '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.B3gshzoLBo/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.G8p66e2YDu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:16: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', 'jsonschema'] in /builds/slave/test/build 09:16: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 jsonschema 09:16:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B3gshzoLBo/Render', 09:16:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:55 INFO - 'HOME': '/Users/cltbld', 09:16:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:55 INFO - 'LOGNAME': 'cltbld', 09:16:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:55 INFO - 'MOZ_NO_REMOTE': '1', 09:16:55 INFO - 'NO_EM_RESTART': '1', 09:16:55 INFO - 'PAGER': '/bin/cat', 09:16:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:55 INFO - 'PWD': '/builds/slave/test', 09:16:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:55 INFO - 'SHELL': '/bin/bash', 09:16:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8p66e2YDu/Listeners', 09:16:55 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:16:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:55 INFO - 'USER': 'cltbld', 09:16:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:55 INFO - 'XPC_FLAGS': '0x0', 09:16:55 INFO - 'XPC_SERVICE_NAME': '0', 09:16:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:16:55 INFO - Cleaning up... 09:16:55 INFO - Return code: 0 09:16:55 INFO - Running post-action listener: _resource_record_post_action 09:16:55 INFO - Running post-action listener: _start_resource_monitoring 09:16:55 INFO - Starting resource monitoring. 09:16:55 INFO - [mozharness: 2017-04-17 16:16:55.351448Z] Finished create-virtualenv step (success) 09:16:55 INFO - [mozharness: 2017-04-17 16:16:55.352430Z] Running install step. 09:16:55 INFO - Running pre-action listener: _resource_record_pre_action 09:16:55 INFO - Running main action method: install 09:16:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:16:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:16:55 INFO - Reading from file tmpfile_stdout 09:16:55 INFO - Detecting whether we're running mozinstall >=1.0... 09:16:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:16:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:16:55 INFO - Reading from file tmpfile_stdout 09:16:55 INFO - Output received: 09:16:55 INFO - Usage: mozinstall [options] installer 09:16:55 INFO - Options: 09:16:55 INFO - -h, --help show this help message and exit 09:16:55 INFO - -d DEST, --destination=DEST 09:16:55 INFO - Directory to install application into. [default: 09:16:55 INFO - "/builds/slave/test"] 09:16:55 INFO - --app=APP Application being installed. [default: firefox] 09:16:55 INFO - mkdir: /builds/slave/test/build/application 09:16:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:16:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:17:15 INFO - Reading from file tmpfile_stdout 09:17:15 INFO - Output received: 09:17:15 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:17:15 INFO - Running post-action listener: _resource_record_post_action 09:17:15 INFO - [mozharness: 2017-04-17 16:17:15.701849Z] Finished install step (success) 09:17:15 INFO - [mozharness: 2017-04-17 16:17:15.702002Z] Running run-tests step. 09:17:15 INFO - Running pre-action listener: _resource_record_pre_action 09:17:15 INFO - Running main action method: run_tests 09:17:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:17:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:17:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:17:15 INFO - 2017-04-17 09:17:15.716 screenresolution[3937:79805] starting screenresolution argv=screenresolution get 09:17:15 INFO - 2017-04-17 09:17:15.719 screenresolution[3937:79805] Display 0: 1600x1200x32@60 09:17:15 INFO - 2017-04-17 09:17:15.725 screenresolution[3938:79808] starting screenresolution argv=screenresolution list 09:17:15 INFO - Available Modes on Display 0 09:17:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:17:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:17:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:17:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:17:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:17:15 INFO - Intel Iris: 09:17:15 INFO - Chipset Model: Intel Iris 09:17:15 INFO - Type: GPU 09:17:15 INFO - Bus: Built-In 09:17:15 INFO - VRAM (Dynamic, Max): 1536 MB 09:17:15 INFO - Vendor: Intel (0x8086) 09:17:15 INFO - Device ID: 0x0a2e 09:17:15 INFO - Revision ID: 0x0009 09:17:15 INFO - Displays: 09:17:15 INFO - Display: 09:17:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:17:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:17:15 INFO - Display Serial Number: 1600x1200 60 09:17:15 INFO - Main Display: Yes 09:17:15 INFO - Mirror: Off 09:17:15 INFO - Online: Yes 09:17:15 INFO - Rotation: Supported 09:17:15 INFO - Return code: 0 09:17:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:17:15 INFO - Python 2.7.3 09:17:15 INFO - Return code: 0 09:17:15 INFO - grabbing minidump binary from tooltool 09:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:15 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc21d30>, '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 0x10cb48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc16be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:17:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:17:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:17:15 INFO - Calling ['/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'] with output_timeout 600 09:17:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:17:16 INFO - Return code: 0 09:17:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:17:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:17:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:17:16 INFO - ENV: RUST_BACKTRACE is now 1 09:17:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:17:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:17:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mtc4L6VNT2KGKvYdfK9MIg/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0024', '--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 09:17:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Mtc4L6VNT2KGKvYdfK9MIg/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0024 --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 09:17:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B3gshzoLBo/Render', 09:17:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:16 INFO - 'HOME': '/Users/cltbld', 09:17:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:16 INFO - 'LOGNAME': 'cltbld', 09:17:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:17:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:16 INFO - 'MOZ_NO_REMOTE': '1', 09:17:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:17:16 INFO - 'NO_EM_RESTART': '1', 09:17:16 INFO - 'PAGER': '/bin/cat', 09:17:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:16 INFO - 'PWD': '/builds/slave/test', 09:17:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:17:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:16 INFO - 'RUST_BACKTRACE': '1', 09:17:16 INFO - 'SHELL': '/bin/bash', 09:17:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G8p66e2YDu/Listeners', 09:17:16 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 09:17:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:16 INFO - 'USER': 'cltbld', 09:17:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:16 INFO - 'XPC_FLAGS': '0x0', 09:17:16 INFO - 'XPC_SERVICE_NAME': '0', 09:17:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mtc4L6VNT2KGKvYdfK9MIg/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0024', '--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 09:17:16 INFO - mozversion application_buildid: 20170417075506 09:17:16 INFO - mozversion application_changeset: 5049738b566005c47b8b6e4c07639340ff09a15a 09:17:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:17:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:17:16 INFO - mozversion application_name: Firefox 09:17:16 INFO - mozversion application_remotingname: firefox-dev 09:17:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:17:16 INFO - mozversion application_vendor: Mozilla 09:17:16 INFO - mozversion application_version: 54.0a2 09:17:16 INFO - mozversion platform_buildid: 20170417075506 09:17:16 INFO - mozversion platform_changeset: 5049738b566005c47b8b6e4c07639340ff09a15a 09:17:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:17:16 INFO - mozversion platform_version: 54.0a2 09:17:16 INFO - using testdate: 1492445836 09:17:16 INFO - actual date: 1492445836 09:17:16 INFO - starting webserver on 'localhost:54675' 09:17:16 INFO - SUITE-START | Running 2 tests 09:17:16 INFO - TEST-START | dromaeo_css 09:17:16 INFO - operating with platform_type : mac_ 09:17:16 INFO - Initialising browser for dromaeo_css test... 09:17:16 INFO - TEST-INFO | started process 3948 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmp2CBLjA/profile http://localhost:54675/getInfo.html) 09:17:19 INFO - PROCESS | 3948 | 2017-04-17 09:17:19.105 plugin-container[3950:79975] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x924f, name = 'com.apple.tsm.portname' 09:17:19 INFO - PROCESS | 3948 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:17:19 INFO - PROCESS | 3948 | 2017-04-17 09:17:19.108 plugin-container[3950:79975] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c0b, name = 'com.apple.CFPasteboardClient' 09:17:19 INFO - PROCESS | 3948 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:17:19 INFO - PROCESS | 3948 | 2017-04-17 09:17:19.108 plugin-container[3950:79975] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:17:19 INFO - PROCESS | 3948 | __metrics Screen width/height:1600/1200 09:17:19 INFO - PROCESS | 3948 | colorDepth:24 09:17:19 INFO - PROCESS | 3948 | Browser inner width/height: 1024/689 09:17:19 INFO - PROCESS | 3948 | __metrics 09:17:19 ERROR - PROCESS | 3948 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 09:17:19 INFO - TEST-INFO | 3948: exit 0 09:17:19 INFO - Browser initialized. 09:17:19 INFO - Running cycle 1/1 for dromaeo_css test... 09:17:19 INFO - TEST-INFO | started process 3951 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmp2CBLjA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:17:22 INFO - PROCESS | 3951 | 2017-04-17 09:17:22.457 plugin-container[3952:80102] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 09:17:22 INFO - PROCESS | 3951 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:17:22 INFO - PROCESS | 3951 | 2017-04-17 09:17:22.457 plugin-container[3952:80102] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 09:17:22 INFO - PROCESS | 3951 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:17:22 INFO - PROCESS | 3951 | 2017-04-17 09:17:22.457 plugin-container[3952:80102] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:17:32 INFO - PROCESS | 3951 | RSS: Main: 220491776 09:17:32 INFO - PROCESS | 3951 | 09:20:35 INFO - PROCESS | 3951 | Cycle 1(1): loaded http://localhost:54675/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54675/tests/dromaeo/cssquery-ext.html) 09:20:37 INFO - PROCESS | 3951 | RSS: Main: 238120960 09:20:37 INFO - PROCESS | 3951 | 09:22:20 INFO - PROCESS | 3951 | ************************* 09:22:20 INFO - PROCESS | 3951 | A coding exception was thrown and uncaught in a Task. 09:22:20 INFO - PROCESS | 3951 | 09:22:20 ERROR - PROCESS | 3951 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:22:20 INFO - PROCESS | 3951 | Full stack: 09:22:20 INFO - PROCESS | 3951 | ************************* 09:22:20 INFO - PROCESS | 3951 | ************************* 09:22:20 INFO - PROCESS | 3951 | A coding exception was thrown and uncaught in a Task. 09:22:20 INFO - PROCESS | 3951 | 09:22:20 ERROR - PROCESS | 3951 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:22:20 INFO - PROCESS | 3951 | Full stack: 09:22:20 INFO - PROCESS | 3951 | ************************* 09:22:20 INFO - PROCESS | 3951 | ************************* 09:22:20 INFO - PROCESS | 3951 | A coding exception was thrown and uncaught in a Task. 09:22:20 INFO - PROCESS | 3951 | 09:22:20 ERROR - PROCESS | 3951 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:22:20 INFO - PROCESS | 3951 | Full stack: 09:22:20 INFO - PROCESS | 3951 | ************************* 09:22:20 INFO - PROCESS | 3951 | ************************* 09:22:20 INFO - PROCESS | 3951 | A coding exception was thrown and uncaught in a Task. 09:22:20 INFO - PROCESS | 3951 | 09:22:20 ERROR - PROCESS | 3951 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:22:20 INFO - PROCESS | 3951 | Full stack: 09:22:20 INFO - PROCESS | 3951 | ************************* 09:23:39 INFO - PROCESS | 3951 | Cycle 1(1): loaded http://localhost:54675/tests/dromaeo/cssquery-ext.html (next: http://localhost:54675/tests/dromaeo/cssquery-jquery.html) 09:23:40 INFO - PROCESS | 3951 | RSS: Main: 248201216 09:23:40 INFO - PROCESS | 3951 | 09:26:42 INFO - PROCESS | 3951 | Cycle 1(1): loaded http://localhost:54675/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54675/tests/dromaeo/cssquery-mootools.html) 09:26:42 INFO - PROCESS | 3951 | RSS: Main: 255533056 09:26:42 INFO - PROCESS | 3951 | 09:29:44 INFO - PROCESS | 3951 | Cycle 1(1): loaded http://localhost:54675/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54675/tests/dromaeo/cssquery-prototype.html) 09:29:45 INFO - PROCESS | 3951 | RSS: Main: 251592704 09:29:45 INFO - PROCESS | 3951 | 09:32:48 INFO - PROCESS | 3951 | Cycle 1(1): loaded http://localhost:54675/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54675/tests/dromaeo/cssquery-yui.html) 09:32:49 INFO - PROCESS | 3951 | RSS: Main: 256745472 09:32:49 INFO - PROCESS | 3951 | 09:35:52 INFO - PROCESS | 3951 | Cycle 1(1): loaded http://localhost:54675/tests/dromaeo/cssquery-yui.html (next: http://localhost:54675/tests/dromaeo/cssquery-dojo.html) 09:35:52 INFO - PROCESS | 3951 | RSS: Main: 252915712 09:35:52 INFO - PROCESS | 3951 | 09:35:52 INFO - PROCESS | 3951 | __start_tp_report 09:35:52 INFO - PROCESS | 3951 | _x_x_mozilla_page_load 09:35:52 INFO - PROCESS | 3951 | _x_x_mozilla_page_load_details 09:35:52 INFO - PROCESS | 3951 | |i|pagename|runs| 09:35:52 INFO - PROCESS | 3951 | |0;dojo.html;3457.7752446091004;3462.169079420938;3503.982480087599;3505.404081306178;3514.8594056237753;5154.896902061956;6016.488598469125;6064.241969753781;6070.392960703927;6099.725512351954;6051.425114614116;6089.147519347295;6154.507639388849;6179.536534759888;6180.0420934755075;5452.236686863842;5475.151351540498;5533.418991005947;5592.7762889484375;5597.496225339719;5490.6431081979745;5591.440855914397;5596.992541342557;5599.832005039855;5630.352509461423;5338.839834804962;5356.0894647909945;5402.432744561824;5527.032769265363;5527.088030474967;5397.7031263280505;5409.134538473864;5488.231647569343;5488.368837583689;5498.3127109111365;5343.572514198893;5391.78432862685;5393.865153371158;5411.350637923474;5419.5393391561765;4707.611254679843;5773.451522105435;6128.908066379008;6135.9079613805825;6202.41077097675;6234.407731265523;6294.685265736741;6391.904121438182;6440.194975628046;6479.902801457982;6609.867802643968;6613.239477460105;6615.735370585219;6618.536702430832;6634.436072933807;6243.968780156161;6247.344028876993;6270.843228919313;6286;6289.433950944392;6420.293767685551;6511.446527045159;6638.601683898982;6656.034874943106;6717.9664101680155;6390.904136437957;6406.135171751847;6418.518611104186;6419.325970773095;6441.162648855712;6579.3420657934785;6587.604743715392;6593.80218593443;6597.30728273534;6598.868022639616;6237.345078766755;6333.936660633335;6384;6406.135171751754;6484.221893372825;6440.25937017249;6502.122213501211;6519;6523.804285871432;6563.704633291418;5240.895182096337;5250.317458730341;5251.894962100813;5272.9736351318;5299.099153143898;4520.909581808345;4579.038401935631;4600.677952543289;4668.486466488684;4670.8365207217585;6220.098085777537;6239.282482514478;6262.968685156545;6273.937260627426;6301.086342480315;6524.869502609921;6617.172853393326;6630.270670226271;6643.2360278568585;6651.600903945779;6039.667818270037;6085.36103709113;6116.969415152896;6240.282367527792;6277.968610157011;5695.686737229492;5700.743466544015;5761.711914404263;5789.131630255495;5828.970855145697;6822.283660215804;6828.829279268058;6868.072810170763;6876.17485901695;6881.793546193622;6306.2747784003595;6617.933820661732;6666.866662666623;6670.099536562502;6693.765718199839;6450.677466126581;6500.6424646643;6678.933210668026;6824.2152152503095;6887.345702158287;6446.64543450096;6450.838729031811;6505.837354066186;6514.609123452608;6526.4452521536205;6520.315366886409;6584.473242140713;6589.835254118685;6589.934100658932;6639.767608133692;6229.844253893689;6278.7488500461295;6290.654014029273;6416.230052393743;6422.389872962061;6299.716512757029;6314.84212894663;6413.551051426355;6420.454261387835;6447.516436267205;6225.501959843292;6240.095186198067;6332.366763323631;6335.936640633535;6340.175777148941;6307.716152773228;6376.266729326187;6396.624725684001;6437.25971513282;6442.194725659293;6214.347493513116;6215.254169499689;6230.626162430269;6306.810795676137;6306.9684651576445 09:35:52 INFO - PROCESS | 3951 | |1;ext.html;715.1596873673436;737.1338677054459;816.3713940265993;957.1242313283342;961.8268711631904;38271.42592861106;38839.80580097103;40050.59949400505;40232.19535609286;40279.59720402795;30912.690873091262;39044.41433378502;39292;39350;39401.40897886534;7868.2918537331625;8026.398020148483;10661.626843060494;10944.45277736114;11148.498317575728;9012.369134160612;9125.45247285165;10834.837477437844;10852;10874.565017399294;10863.782724345549;10870.565177392895;10897.782044359108;10900.836487452694;10918.235723499358;10815.83776243357;10830.025297723203;10884.673459796179;10885;10888.074513666348;10630.840537391945;10667.679969600924;10679.30584512012;10680.732981675443;10696.304740191863;33611.6638833611;33711.494327584864;33902.98291051272;33997.64009439644;34076.48885266723;3678.4114541673202;3697.1126929536986;3719.8699986562033;3774.941578285111;3784.3188226119287;25399.873000634878;26282;26300.605490917653;26317.21048368533;26336.73663263362;3009.8043627164166;3063.7089476499696;3075.415671022521;3158.589383380146;3258.96741032589;349957;351042.24478877697;351778;351780;352468;43083.35374969378;43099.35350969738;43111.35332970008;43204.567954320686;43275.567244327154;44600.3309950351;44914;44935;45008.54991450109;45155;11579.72623011468;13859.792103118461;13917.02580819333;13960.58118256454;13989.580312590435;11949.044076473861;12068.215565988183;12114.575989840314;12122.696932576757;12125.09061820367;10381.740456488496;11676.182667213214;11833.112516561292;11848.815118488083;11931.224470409396;4645.9303110453375;5662.17898404729;5710.314762228559;5716.542676585863;5813.302403711582;1083.5503266144462;1088.8421178929011;1112.9538234059958;1136.6476392318407;1213.878612138779;21161.78838211629;26828.195154145407;27324.59013114805;27349.906003760025;27398.726012740015;1233.8889499945049;1269.6127681057183;1277.9041571882146;1325.8541560428346;1338.578347820453;13709.040367174202;13891;13971.23158226287;14085.366158522891;14147.151170929777;372371;395458;473979;474063;474116;56558.151627724794;56874.14688779671;56960.43039569634;57207.56981075506;57342;1350.4935649131771;1354.7561438941086;1383.7855132454486;1402.2287741742;1403.3334166271143;23916;25353.239402817944;26766;26897.327566810985;26906;39288.21423571456;39510.20979580335;39514.802425987684;39686.40470393004;39708.205835883695;451347;451974.7401262973;453542;457243;457464.138037923;24335.51328973446;28215.858920705265;29307.974220902168;30185.698143019166;30375;37556;37927.462172149804;38592.8422147336;38775.8367248983;39455.60544394519;27527.86236068807;27749.86125069362;27843.02549410761;28275.434491309647;28811.423771524034;23573.882130589238;23583;27603.86198068997;27809;28429.857850710614;28564.857175713987;31244;32339.029829105166;32746.181345466553;32758.672413275563;28020;28340.149795506168;28498;28826.855865720536;28944.565831512966;21698.92344258701;21878.781212187674;22164.002619882467;23133.421664458525;23277.41806454852 09:35:52 INFO - PROCESS | 3951 | |2;jquery.html;412.84518305635385;428.51577717179583;431.81638930515015;441.6025576980717;442.6304036129831;17087.9747215167;19204.94372809495;19413.708794368096;20884.686729699068;20998.26506072288;19767.604647907032;20526.076326565304;21268.893655531738;21862.344129676094;21974.89012554939;6573.211214654249;6694.230163531208;6694.564853284521;6697.5981441113445;6713.899291510606;5954.166416701665;6149.2313460817395;6196.132541444202;6602.735890564371;6671.766488172915;6154.753809847601;6179.66011869347;6183.567150299458;6191.102290167923;6207.81376558704;6200.410960958701;6737.090492783461;6744.898826517606;6765.627890466047;6773.356531129535;6174.783882564088;6494.967525162344;6512.576682515669;6597.241317248482;6610.801675949681;26002.479950400884;26215.34461638455;26395.604065939027;26443.867780661167;26541.203763887115;2881.9423611527864;2945.381469891304;2975.79169458138;3238.5627940228237;3334.1831251343333;16320.510384688478;16465;16757.83242167575;16848.494545163663;17191.1404429778;2081.8230450411734;2082.83337333013;2103.7580678221893;2120.724305840231;2206.0403724379944;125887.37056314752;126315;126626.73373266241;128414;129944.350278248;19657.606847863248;20493.590128197353;21825.34523964252;22232.444188895082;22513.662295065587;34782.65217347845;35263.82368088143;35681.82159089188;35736.46395304072;35762.8211858939;9041.412308199946;10530;10538.631147909786;11251.874812518683;11261.718457038476;7384.667689953965;8859.29125669945;8939.910600893907;8980.191782739585;9150.542472876463;10279.640212592523;10678.62624808128;10684.038436540748;10895.019448249695;10982.505787239434;4280.700350975402;4357.281048627005;4396.3185706214945;4397.164538737629;4405.581469760367;875.4353442029983;1020.8162530744537;1057.6086847866186;1106.2145876427664;1115.3252282369212;17783.73324400135;20035.59928801445;20749.792502075088;20875;21283.78716212818;880.7842078690634;1043.5617040842865;1060.3743791163251;1080.400377790334;1085.3379438542484;9979.750506237402;11168.218224724355;11174.161937854693;11209.887901121048;11240.831387529193;629495;715952;734768;749799.2767987812;753933;105835;111028.88971110347;120399;121562;121654.56690866133;1234.8765123487578;1244.5457408045997;1264.7091169030991;1267.2776517385003;1269.0101720657901;14275.357608907416;14478.782818257945;16199.491255646666;18284.817151828844;18437.446876593724;42716.718498445094;43680.56319436892;47035;48740.02519949652;50664.74667626638;70582;70804.29195707977;71163.64418177876;72152.55694885968;72177;11637.88362116402;11763.117766167743;12167.878321216675;12240.693982650506;12338.629841104781;13001.609951701465;13115.934420327838;13173.60479185626;13419.664508387368;13476.79784803209;11136.164787640797;11378.829317560409;11466.197366184288;11729.882701173221;11817.763644727229;10497.212709047004;10528.684139475828;10564.788704226026;10754.516046777757;10908.563657453613;9113;11406.973372396524;11686;11825;11917.284962902253;10612.204084693833;11441.913018263253;12000.63998080059;12059.276443413422;12211.633650990485;11228.775424491301;11319.773604528027;11576.363300018244;11577.479013444246;11621.593244236412 09:35:52 INFO - PROCESS | 3951 | |3;mootools.html;1434.576799844046;1548.1175729833985;1553.3708847916598;1564.7965764450619;1596.8003999500065;9453.763655908606;9655.758606034853;10801.83797243041;11351.545938162464;11381.772364552715;9912.702618921443;10231.48842557873;10639.202059845504;10998.395088270141;11009.28439651424;2307.3078076577044;2368.3250273672006;2383.011050414076;2385.3082606044313;2387.128698025217;2333.7549557296493;2351.670766092748;2359.6932398788135;2384.2608791274674;2394.2577800881695;2302.9654555181687;2335.054303007285;2357.9528409431887;2373.477834876333;2376.989779343781;2300.3099070279018;2332.941676458085;2337.777911098443;2342.3324352559525;2360.97639023611;2043.8978051097533;2296.334063121693;2340.414896275931;2353.752855950118;2359.3275916363928;10844.31913053478;10969.341839489656;11074.778504429867;11090.946360095779;11091.611793587266;5454.481824226692;5500.7524661390335;5644.8024319148635;5692.146178073281;5778.42215778423;3363.226457914693;3519.753617246794;3596.0650230940146;3603.1172362771026;3605.5853576838736;1089.722120859176;1121.5177473686313;1153.089059642881;1170.9238899471593;1175;15497.922510387489;15628.609284767857;15631.296591653288;15698.686026279525;15703.979241349276;4496.325551167286;4737.549932756383;4789.44921334051;4812.205986012339;4827.034593081397;11662.825057624143;12397.566085186974;13162.60512184636;13170.341482925814;13506.662333441742;4900.72581128909;5546.057170281062;5642.492175704207;5679;5690.118031705092;4404.11917616478;4847.878803029953;4907.1167189905445;5188.092083885305;5270.578353731692;3871.9612803872164;3919.980400097981;4016.216837716676;4031.0930040741187;4078.408630748525;913.712180663089;1063.3407287481657;1067.7170549804307;1069.417167643636;1089.727568107973;916.6745805239044;931.6785708930408;933.5425641435647;937.9108984646448;967.4630580028152;6611.173603299588;6615.6030638161865;6676.933230667728;6682.164729408824;6921.792346229621;956.206348730552;978.7210644966151;1000.3847633705219;1005.8038682456997;1037.1650821088945;3649.379605467077;4128.422020917014;4148.958510414917;4157.812898419578;4281.850135245314;13197.53808616713;13755.243461609707;13767.173969561858;13774.035817492679;13782.241976691177;13686;13686.93156534231;13687.24720140382;13704.65738356549;13722.794158087636;8817.735467935972;10030.047145521165;10114.342567733222;10147.137493313152;10258.384496930208;6346.9682651586445;6456.870862582816;6483;6539.95360742279;6571.441427478718;12189;12199.316150446888;12230.205036672587;12276.754464910831;12302.015838732701;12522.686932826753;12541.561045363369;12550.87449125497;12635;12655.367231638565;7673.117591477052;9223.354365194373;9225.354225204172;9294.953525232331;9325.626974920928;10227.94886025565;10246.538905749409;10327.225458090523;10341.4312212829;10350.844737329096;8707.825843483222;8720.215180633773;8754.29965602763;8756.299496040174;8778.692745753868;8434.620442080244;8550.1449855014;8563.186497282748;8573.142685731376;8709.695160669346;7789.766307010798;7823.100343460575;7908.960455197687;7929.841403172019;7932.6430310637315;5905.645661260338;5949.077892926603;5951.613145145551;5991.161237426677;6030.185924900083;4924.2613607957655;5461.9076184764;5904.52763778888;5928.703564821828;6103.938960610337 09:35:52 INFO - PROCESS | 3951 | |4;prototype.html;367.6764447286388;379.6829647244551;390.74601509019135;393.7125898094393;396.95831937646545;4397.516273209948;4622.676412651116;4999.400071991357;5236.847893463437;5251.897101608667;4533.750643714594;4569.840055598055;5056.69659820411;5304.681719096857;5367.838964831051;4013.458183145282;4304.139172165564;4351.412559304485;4391.967887546424;4586.908261834761;3988.5811989741096;4120.578400451855;4219.810108545107;4504.436945381827;4679.953200468003;3937.8031098444962;4144.937825932599;4670.76646167692;4728.777474586938;4759.500252473493;4248.490181178278;4592.586667199935;4601.28680054592;4696.50686677899;4730.337752714623;3652.6347365263528;3780.8109594520165;4132.73137246081;4480.462344518646;4514.826145202271;4684.367610372624;5340.465953404668;5346.4118946915805;5353.544948679367;5358.955003774266;4501.167284052461;4968.850934471971;5373.811916582901;5514.53864725848;5575.386707462176;4858.902821943577;5158.97420512895;5386.064594795846;5398.947205294969;5727.284089488814;4235.724677895927;4972.328735620717;4990.251462280687;4991.925121123149;4994.550490455877;4830.396200474941;5058.4435712071645;5818.069108942549;5849.800790837868;6380.234371875358;4337.327714204303;4741.715497070187;4743.573078422958;4761.6429317645;4890.310329318861;4649.651276154302;4720.740359280204;5114.655185331338;5240.371155461369;5288.5143982328245;5131.435542090367;5371.543418809445;5450.4549545045975;5452.955141821817;5483.39394908271;5292.708901010481;5297.894042119136;5553.500184983371;5724.885502290014;5732.108404226596;1616.6928283626073;1721.741738739199;1807.41259090796;1817.6730986379753;1833.779946406413;1219;1326.9167407170648;1384.7715127003933;1470.0811992504684;1500.129924643704;4707.929381059287;5000.924986125211;5050.974745126251;5284.365876094893;5321.521063104339;5278.445763194886;5309.840704778863;5386.730663466811;5571.45354208803;5811.82564523065;4243.257429949746;4960.826371077067;5266.077327083505;5342.839714808562;5367.624266301399;2675.464907018604;2752.6146339512484;2941.1176647005814;3064.5709600655928;3148.354587309596;5475.616706830563;5721.713914304268;5739.913901291484;6184.443400094013;6209.96895015531;5738.540916726652;5939.821805345847;6028.788992385245;6147.694614519555;6172.629642221481;5609.467100625516;5869.442402971711;6216.720247588779;6230.971889638249;6331.936680633226;5042.520960508746;5238.869028274324;5247.370315562157;5717.885642287214;5812.302523697014;5260.237265596544;5355.813291091794;5595.860103497445;5904.084866845646;5984.760609575568;5292.391374991926;6269.62382257066;6272.5922815016875;6302.243730752339;6343.207099112611;4056.2822908650683;4377.927407785113;4543.568361005699;4654.813807447664;4704.1062198182235;5286.418493965738;5288.312519372457;5396.78412863481;5955.761769529344;5973.731182096729;5446.685158807571;5500.332338815751;5623.353314368736;5791.681457519709;5879.823605291848;5024.969881174424;5213.478652134908;5693.4021927696995;5747.5401967841635;5748.770049197985;5064.215046667772;5592.3862813178475;5675.120356344773;5697.857553561194;5754;4992.450830408579;5114.820981265638;5176.534111929945;5490.368607610176;5698.230738850202;5183.974080129575;5568.331800184003;5587.3015873015875;5614.6631202128;5645.379008309164 09:35:52 INFO - PROCESS | 3951 | |5;yui.html;711.1856923822227;754.3738696881587;770.8496843115591;827.635840230299;839.7438781171742;15126.470573529929;16457.67084658306;16511.339546418145;16512.917435412837;16529.33882644693;15021.248937553133;15049.172295523742;16081.597960051005;16864.747028794576;17405.91297043513;927.3184209605935;948.7817801905566;953.3136141977765;953.3564843730488;953.5708930981051;783.713944410289;908.500324821349;932.4125800745521;943.9292053096011;949.9667511637094;1000.3197825478671;1001.6994901529548;1001.7996400719849;1002.3534820041069;1003.4130033930123;985.5417230987625;997.760537471009;999.2755252441995;999.6701088640731;1001.1590264178053;728.5810658871118;728.5883475836189;741.903552538172;742.8811390177545;743.4498471131324;15986.76019859703;16314.83685163157;16426.42507512243;16849.241784119746;16886.408975685914;14269.357878895475;14283;14322.64193395163;14422.567322980327;14424.71150576993;10871.945640271748;11535.25020873649;11739.23694959825;11946.761064778655;12396.194247373893;3009.653889802657;3084.0901933929545;3096.071178646397;3174.682531746807;3182.4112539180096;114263.2860507093;120228;120803.3959830204;121549.78450215473;122295.99999999911;10419.583216671248;10571.312864663925;10652.40213967911;10878.40168790724;11211.495482703134;22089;22352.441188970082;22568.758718270325;22613.208537701103;22665.546689066126;7689.346405555479;7841.882371764428;7979.9227104341335;8016.398770092266;8086.1913808618665;4264.189803937242;4266.5946735060115;4326.913461730811;4328.5946263661;4424.115176964556;3424.33225521026;3443.8794642187404;3505.0361150683766;3505.9824700876334;3524.947125793115;645.3933302695451;650.629141389413;651.667649498759;652.7323797243107;661.3254480429935;658.5423130923962;665.986680266392;675.9526833121732;688.6728803818146;691.7025678958096;10199.18406527476;10252.487375631188;10265.384076955406;10576.17518597563;10595.152387808957;658.8188248231775;665.70043480434;682.5768023825161;684.4114061906756;684.4421796236052;4797.376341075707;5069.467705890902;5074.67014644047;5090.9236361454605;5104.795808167706;106150;106393;107791;109855.90144098617;111406;74900.62549687216;75999;76199.61900190463;80325.39349212984;93758.06241937629;73785.6310718443;74280.62859685667;75075;76206.23793762103;76367.85448218281;10217.846732298873;11025.944870275598;11029.669109926715;11146.554137834395;11300.434978251218;44369.89075273144;50247.748761255956;50878;51640.74179629078;51807.74096129495;64050.35949640444;64221.03668445071;64262;64567.677161613894;64655.353446464935;10711.196660250669;12424.503019879103;12490.250584964931;12679.302638354979;13117.840580284548;14082.225477598831;14260.71478570402;14296.642583935485;14620.12279263205;14772.18752968597;10842.783144337227;13415.262160581262;13849.584512464642;13881.097728647606;14276.785848212492;13288.800667989795;13298.468061277828;13724;13768.65578360549;14247.928760356132;11180.55277788912;12796.872031279569;13460.730785384434;13659;13937.930310348384;9171.495567743837;9468.905310946802;9539.379940303857;9693.273004524548;9733.124018838338;9913.702588922344;11325.660230193107;11327.773444531229;11339.603113890975;11347.886521135013 09:35:52 INFO - PROCESS | 3951 | __end_tp_report 09:35:52 INFO - PROCESS | 3951 | __start_cc_report 09:35:52 INFO - PROCESS | 3951 | _x_x_mozilla_cycle_collect,407 09:35:52 INFO - PROCESS | 3951 | __end_cc_report 09:35:52 INFO - PROCESS | 3951 | __startTimestamp1492446952271__endTimestamp 09:35:52 INFO - PROCESS | 3951 | 09:35:52 INFO - PROCESS | 3951 | ------- Summary: start ------- 09:35:52 INFO - PROCESS | 3951 | Number of tests: 6 09:35:52 INFO - PROCESS | 3951 | 09:35:52 INFO - PROCESS | 3951 | [#0] dojo.html Cycles:165 Average:6057.51 Median:6289.43 stddev:693.34 (11.0%) stddev-sans-first:664.80 09:35:52 INFO - PROCESS | 3951 | Values: 3457.8 3462.2 3504.0 3505.4 3514.9 5154.9 6016.5 6064.2 6070.4 6099.7 6051.4 6089.1 6154.5 6179.5 6180.0 5452.2 5475.2 5533.4 5592.8 5597.5 5490.6 5591.4 5597.0 5599.8 5630.4 5338.8 5356.1 5402.4 5527.0 5527.1 5397.7 5409.1 5488.2 5488.4 5498.3 5343.6 5391.8 5393.9 5411.4 5419.5 4707.6 5773.5 6128.9 6135.9 6202.4 6234.4 6294.7 6391.9 6440.2 6479.9 6609.9 6613.2 6615.7 6618.5 6634.4 6244.0 6247.3 6270.8 6286.0 6289.4 6420.3 6511.4 6638.6 6656.0 6718.0 6390.9 6406.1 6418.5 6419.3 6441.2 6579.3 6587.6 6593.8 6597.3 6598.9 6237.3 6333.9 6384.0 6406.1 6484.2 6440.3 6502.1 6519.0 6523.8 6563.7 5240.9 5250.3 5251.9 5273.0 5299.1 4520.9 4579.0 4600.7 4668.5 4670.8 6220.1 6239.3 6263.0 6273.9 6301.1 6524.9 6617.2 6630.3 6643.2 6651.6 6039.7 6085.4 6117.0 6240.3 6278.0 5695.7 5700.7 5761.7 5789.1 5829.0 6822.3 6828.8 6868.1 6876.2 6881.8 6306.3 6617.9 6666.9 6670.1 6693.8 6450.7 6500.6 6678.9 6824.2 6887.3 6446.6 6450.8 6505.8 6514.6 6526.4 6520.3 6584.5 6589.8 6589.9 6639.8 6229.8 6278.7 6290.7 6416.2 6422.4 6299.7 6314.8 6413.6 6420.5 6447.5 6225.5 6240.1 6332.4 6335.9 6340.2 6307.7 6376.3 6396.6 6437.3 6442.2 6214.3 6215.3 6230.6 6306.8 6307.0 09:35:52 INFO - PROCESS | 3951 | 09:35:52 INFO - PROCESS | 3951 | [#1] ext.html Cycles:180 Average:53928.09 Median:28688.14 stddev:111021.80 (387.0%) stddev-sans-first:111261.36 09:35:52 INFO - PROCESS | 3951 | Values: 715.2 737.1 816.4 957.1 961.8 38271.4 38839.8 40050.6 40232.2 40279.6 30912.7 39044.4 39292.0 39350.0 39401.4 7868.3 8026.4 10661.6 10944.5 11148.5 9012.4 9125.5 10834.8 10852.0 10874.6 10863.8 10870.6 10897.8 10900.8 10918.2 10815.8 10830.0 10884.7 10885.0 10888.1 10630.8 10667.7 10679.3 10680.7 10696.3 33611.7 33711.5 33903.0 33997.6 34076.5 3678.4 3697.1 3719.9 3774.9 3784.3 25399.9 26282.0 26300.6 26317.2 26336.7 3009.8 3063.7 3075.4 3158.6 3259.0 349957.0 351042.2 351778.0 351780.0 352468.0 43083.4 43099.4 43111.4 43204.6 43275.6 44600.3 44914.0 44935.0 45008.5 45155.0 11579.7 13859.8 13917.0 13960.6 13989.6 11949.0 12068.2 12114.6 12122.7 12125.1 10381.7 11676.2 11833.1 11848.8 11931.2 4645.9 5662.2 5710.3 5716.5 5813.3 1083.6 1088.8 1113.0 1136.6 1213.9 21161.8 26828.2 27324.6 27349.9 27398.7 1233.9 1269.6 1277.9 1325.9 1338.6 13709.0 13891.0 13971.2 14085.4 14147.2 372371.0 395458.0 473979.0 474063.0 474116.0 56558.2 56874.1 56960.4 57207.6 57342.0 1350.5 1354.8 1383.8 1402.2 1403.3 23916.0 25353.2 26766.0 26897.3 26906.0 39288.2 39510.2 39514.8 39686.4 39708.2 451347.0 451974.7 453542.0 457243.0 457464.1 24335.5 28215.9 29308.0 30185.7 30375.0 37556.0 37927.5 38592.8 38775.8 39455.6 27527.9 27749.9 27843.0 28275.4 28811.4 23573.9 23583.0 27603.9 27809.0 28429.9 28564.9 31244.0 32339.0 32746.2 32758.7 28020.0 28340.1 28498.0 28826.9 28944.6 21698.9 21878.8 22164.0 23133.4 23277.4 09:35:52 INFO - PROCESS | 3951 | 09:35:52 INFO - PROCESS | 3951 | [#2] jquery.html Cycles:180 Average:39538.06 Median:2082.33 stddev:118468.68 (5689.2%) stddev-sans-first:118764.59 09:35:52 INFO - PROCESS | 3951 | Values: 412.8 428.5 431.8 441.6 442.6 17088.0 19204.9 19413.7 20884.7 20998.3 19767.6 20526.1 21268.9 21862.3 21974.9 6573.2 6694.2 6694.6 6697.6 6713.9 5954.2 6149.2 6196.1 6602.7 6671.8 6154.8 6179.7 6183.6 6191.1 6207.8 6200.4 6737.1 6744.9 6765.6 6773.4 6174.8 6495.0 6512.6 6597.2 6610.8 26002.5 26215.3 26395.6 26443.9 26541.2 2881.9 2945.4 2975.8 3238.6 3334.2 16320.5 16465.0 16757.8 16848.5 17191.1 2081.8 2082.8 2103.8 2120.7 2206.0 125887.4 126315.0 126626.7 128414.0 129944.4 19657.6 20493.6 21825.3 22232.4 22513.7 34782.7 35263.8 35681.8 35736.5 35762.8 9041.4 10530.0 10538.6 11251.9 11261.7 7384.7 8859.3 8939.9 8980.2 9150.5 10279.6 10678.6 10684.0 10895.0 10982.5 4280.7 4357.3 4396.3 4397.2 4405.6 875.4 1020.8 1057.6 1106.2 1115.3 17783.7 20035.6 20749.8 20875.0 21283.8 880.8 1043.6 1060.4 1080.4 1085.3 9979.8 11168.2 11174.2 11209.9 11240.8 629495.0 715952.0 734768.0 749799.3 753933.0 105835.0 111028.9 120399.0 121562.0 121654.6 1234.9 1244.5 1264.7 1267.3 1269.0 14275.4 14478.8 16199.5 18284.8 18437.4 42716.7 43680.6 47035.0 48740.0 50664.7 70582.0 70804.3 71163.6 72152.6 72177.0 11637.9 11763.1 12167.9 12240.7 12338.6 13001.6 13115.9 13173.6 13419.7 13476.8 11136.2 11378.8 11466.2 11729.9 11817.8 10497.2 10528.7 10564.8 10754.5 10908.6 9113.0 11407.0 11686.0 11825.0 11917.3 10612.2 11441.9 12000.6 12059.3 12211.6 11228.8 11319.8 11576.4 11577.5 11621.6 09:35:52 INFO - PROCESS | 3951 | 09:35:52 INFO - PROCESS | 3951 | [#3] mootools.html Cycles:180 Average:6708.64 Median:2386.22 stddev:4271.64 (179.0%) stddev-sans-first:4265.24 09:35:52 INFO - PROCESS | 3951 | Values: 1434.6 1548.1 1553.4 1564.8 1596.8 9453.8 9655.8 10801.8 11351.5 11381.8 9912.7 10231.5 10639.2 10998.4 11009.3 2307.3 2368.3 2383.0 2385.3 2387.1 2333.8 2351.7 2359.7 2384.3 2394.3 2303.0 2335.1 2358.0 2373.5 2377.0 2300.3 2332.9 2337.8 2342.3 2361.0 2043.9 2296.3 2340.4 2353.8 2359.3 10844.3 10969.3 11074.8 11090.9 11091.6 5454.5 5500.8 5644.8 5692.1 5778.4 3363.2 3519.8 3596.1 3603.1 3605.6 1089.7 1121.5 1153.1 1170.9 1175.0 15497.9 15628.6 15631.3 15698.7 15704.0 4496.3 4737.5 4789.4 4812.2 4827.0 11662.8 12397.6 13162.6 13170.3 13506.7 4900.7 5546.1 5642.5 5679.0 5690.1 4404.1 4847.9 4907.1 5188.1 5270.6 3872.0 3920.0 4016.2 4031.1 4078.4 913.7 1063.3 1067.7 1069.4 1089.7 916.7 931.7 933.5 937.9 967.5 6611.2 6615.6 6676.9 6682.2 6921.8 956.2 978.7 1000.4 1005.8 1037.2 3649.4 4128.4 4149.0 4157.8 4281.9 13197.5 13755.2 13767.2 13774.0 13782.2 13686.0 13686.9 13687.2 13704.7 13722.8 8817.7 10030.0 10114.3 10147.1 10258.4 6347.0 6456.9 6483.0 6540.0 6571.4 12189.0 12199.3 12230.2 12276.8 12302.0 12522.7 12541.6 12550.9 12635.0 12655.4 7673.1 9223.4 9225.4 9295.0 9325.6 10227.9 10246.5 10327.2 10341.4 10350.8 8707.8 8720.2 8754.3 8756.3 8778.7 8434.6 8550.1 8563.2 8573.1 8709.7 7789.8 7823.1 7909.0 7929.8 7932.6 5905.6 5949.1 5951.6 5991.2 6030.2 4924.3 5461.9 5904.5 5928.7 6103.9 09:35:52 INFO - PROCESS | 3951 | 09:35:52 INFO - PROCESS | 3951 | [#4] prototype.html Cycles:180 Average:4805.32 Median:5237.86 stddev:1302.17 (24.9%) stddev-sans-first:1262.50 09:35:52 INFO - PROCESS | 3951 | Values: 367.7 379.7 390.7 393.7 397.0 4397.5 4622.7 4999.4 5236.8 5251.9 4533.8 4569.8 5056.7 5304.7 5367.8 4013.5 4304.1 4351.4 4392.0 4586.9 3988.6 4120.6 4219.8 4504.4 4680.0 3937.8 4144.9 4670.8 4728.8 4759.5 4248.5 4592.6 4601.3 4696.5 4730.3 3652.6 3780.8 4132.7 4480.5 4514.8 4684.4 5340.5 5346.4 5353.5 5359.0 4501.2 4968.9 5373.8 5514.5 5575.4 4858.9 5159.0 5386.1 5398.9 5727.3 4235.7 4972.3 4990.3 4991.9 4994.6 4830.4 5058.4 5818.1 5849.8 6380.2 4337.3 4741.7 4743.6 4761.6 4890.3 4649.7 4720.7 5114.7 5240.4 5288.5 5131.4 5371.5 5450.5 5453.0 5483.4 5292.7 5297.9 5553.5 5724.9 5732.1 1616.7 1721.7 1807.4 1817.7 1833.8 1219.0 1326.9 1384.8 1470.1 1500.1 4707.9 5000.9 5051.0 5284.4 5321.5 5278.4 5309.8 5386.7 5571.5 5811.8 4243.3 4960.8 5266.1 5342.8 5367.6 2675.5 2752.6 2941.1 3064.6 3148.4 5475.6 5721.7 5739.9 6184.4 6210.0 5738.5 5939.8 6028.8 6147.7 6172.6 5609.5 5869.4 6216.7 6231.0 6331.9 5042.5 5238.9 5247.4 5717.9 5812.3 5260.2 5355.8 5595.9 5904.1 5984.8 5292.4 6269.6 6272.6 6302.2 6343.2 4056.3 4377.9 4543.6 4654.8 4704.1 5286.4 5288.3 5396.8 5955.8 5973.7 5446.7 5500.3 5623.4 5791.7 5879.8 5025.0 5213.5 5693.4 5747.5 5748.8 5064.2 5592.4 5675.1 5697.9 5754.0 4992.5 5114.8 5176.5 5490.4 5698.2 5184.0 5568.3 5587.3 5614.7 5645.4 09:35:52 INFO - PROCESS | 3951 | 09:35:52 INFO - PROCESS | 3951 | [#5] yui.html Cycles:180 Average:20707.30 Median:3046.87 stddev:30202.78 (991.3%) stddev-sans-first:30250.19 09:35:52 INFO - PROCESS | 3951 | Values: 711.2 754.4 770.8 827.6 839.7 15126.5 16457.7 16511.3 16512.9 16529.3 15021.2 15049.2 16081.6 16864.7 17405.9 927.3 948.8 953.3 953.4 953.6 783.7 908.5 932.4 943.9 950.0 1000.3 1001.7 1001.8 1002.4 1003.4 985.5 997.8 999.3 999.7 1001.2 728.6 728.6 741.9 742.9 743.4 15986.8 16314.8 16426.4 16849.2 16886.4 14269.4 14283.0 14322.6 14422.6 14424.7 10871.9 11535.3 11739.2 11946.8 12396.2 3009.7 3084.1 3096.1 3174.7 3182.4 114263.3 120228.0 120803.4 121549.8 122296.0 10419.6 10571.3 10652.4 10878.4 11211.5 22089.0 22352.4 22568.8 22613.2 22665.5 7689.3 7841.9 7979.9 8016.4 8086.2 4264.2 4266.6 4326.9 4328.6 4424.1 3424.3 3443.9 3505.0 3506.0 3524.9 645.4 650.6 651.7 652.7 661.3 658.5 666.0 676.0 688.7 691.7 10199.2 10252.5 10265.4 10576.2 10595.2 658.8 665.7 682.6 684.4 684.4 4797.4 5069.5 5074.7 5090.9 5104.8 106150.0 106393.0 107791.0 109855.9 111406.0 74900.6 75999.0 76199.6 80325.4 93758.1 73785.6 74280.6 75075.0 76206.2 76367.9 10217.8 11025.9 11029.7 11146.6 11300.4 44369.9 50247.7 50878.0 51640.7 51807.7 64050.4 64221.0 64262.0 64567.7 64655.4 10711.2 12424.5 12490.3 12679.3 13117.8 14082.2 14260.7 14296.6 14620.1 14772.2 10842.8 13415.3 13849.6 13881.1 14276.8 13288.8 13298.5 13724.0 13768.7 14247.9 11180.6 12796.9 13460.7 13659.0 13937.9 9171.5 9468.9 9539.4 9693.3 9733.1 9913.7 11325.7 11327.8 11339.6 11347.9 09:35:52 INFO - PROCESS | 3951 | -------- Summary: end -------- 09:35:52 INFO - PROCESS | 3951 | 09:35:52 INFO - TEST-INFO | 3951: exit 0 09:35:52 INFO - TEST-OK | dromaeo_css | took 1116630ms 09:35:52 INFO - TEST-START | kraken 09:35:52 INFO - operating with platform_type : mac_ 09:35:52 INFO - Initialising browser for kraken test... 09:35:52 INFO - TEST-INFO | started process 3956 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpzGoOvn/profile http://localhost:54675/getInfo.html) 09:35:55 INFO - PROCESS | 3956 | 2017-04-17 09:35:55.857 plugin-container[3957:82286] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4743, name = 'com.apple.tsm.portname' 09:35:55 INFO - PROCESS | 3956 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:35:55 INFO - PROCESS | 3956 | 2017-04-17 09:35:55.860 plugin-container[3957:82286] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 09:35:55 INFO - PROCESS | 3956 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:35:55 INFO - PROCESS | 3956 | 2017-04-17 09:35:55.861 plugin-container[3957:82286] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:35:55 INFO - PROCESS | 3956 | __metrics Screen width/height:1600/1200 09:35:55 INFO - PROCESS | 3956 | colorDepth:24 09:35:55 INFO - PROCESS | 3956 | Browser inner width/height: 1024/689 09:35:55 INFO - PROCESS | 3956 | __metrics 09:35:55 ERROR - PROCESS | 3956 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 09:35:56 INFO - TEST-INFO | 3956: exit 0 09:35:56 INFO - Browser initialized. 09:35:56 INFO - Running cycle 1/1 for kraken test... 09:35:56 INFO - TEST-INFO | started process 3958 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpzGoOvn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:35:59 INFO - PROCESS | 3958 | 2017-04-17 09:35:59.256 plugin-container[3959:82414] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.tsm.portname' 09:35:59 INFO - PROCESS | 3958 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:35:59 INFO - PROCESS | 3958 | 2017-04-17 09:35:59.257 plugin-container[3959:82414] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 09:35:59 INFO - PROCESS | 3958 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:35:59 INFO - PROCESS | 3958 | 2017-04-17 09:35:59.257 plugin-container[3959:82414] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:36:09 INFO - PROCESS | 3958 | RSS: Main: 220659712 09:36:09 INFO - PROCESS | 3958 | 09:36:11 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:54675/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54675/tests/kraken/driver.html?testName=audio-beat-detection) 09:36:12 INFO - PROCESS | 3958 | RSS: Main: 235180032 09:36:12 INFO - PROCESS | 3958 | 09:36:15 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:54675/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54675/tests/kraken/driver.html?testName=audio-dft) 09:36:16 INFO - PROCESS | 3958 | RSS: Main: 243150848 09:36:16 INFO - PROCESS | 3958 | 09:36:19 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:54675/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54675/tests/kraken/driver.html?testName=audio-fft) 09:36:20 INFO - PROCESS | 3958 | RSS: Main: 246874112 09:36:20 INFO - PROCESS | 3958 | 09:36:22 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:54675/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54675/tests/kraken/driver.html?testName=audio-oscillator) 09:36:22 INFO - PROCESS | 3958 | RSS: Main: 247316480 09:36:22 INFO - PROCESS | 3958 | 09:36:24 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:54675/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54675/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:36:25 INFO - PROCESS | 3958 | RSS: Main: 248594432 09:36:25 INFO - PROCESS | 3958 | 09:36:28 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:54675/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54675/tests/kraken/driver.html?testName=imaging-darkroom) 09:36:29 INFO - PROCESS | 3958 | RSS: Main: 252710912 09:36:29 INFO - PROCESS | 3958 | 09:36:32 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:54675/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54675/tests/kraken/driver.html?testName=imaging-desaturate) 09:36:33 INFO - PROCESS | 3958 | RSS: Main: 252395520 09:36:33 INFO - PROCESS | 3958 | 09:36:36 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:54675/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54675/tests/kraken/driver.html?testName=json-parse-financial) 09:36:36 INFO - PROCESS | 3958 | RSS: Main: 252350464 09:36:36 INFO - PROCESS | 3958 | 09:36:38 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:54675/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54675/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:36:39 INFO - PROCESS | 3958 | RSS: Main: 251453440 09:36:39 INFO - PROCESS | 3958 | 09:36:40 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:54675/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54675/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:36:41 INFO - PROCESS | 3958 | RSS: Main: 251469824 09:36:41 INFO - PROCESS | 3958 | 09:36:43 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:54675/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54675/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:36:44 INFO - PROCESS | 3958 | RSS: Main: 251523072 09:36:44 INFO - PROCESS | 3958 | 09:36:47 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:54675/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:36:48 INFO - PROCESS | 3958 | RSS: Main: 251957248 09:36:48 INFO - PROCESS | 3958 | 09:36:50 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:54675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:36:51 INFO - PROCESS | 3958 | RSS: Main: 251674624 09:36:51 INFO - PROCESS | 3958 | 09:36:53 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:54675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54675/tests/kraken/driver.html?testName=ai-astar) 09:36:53 INFO - PROCESS | 3958 | RSS: Main: 253689856 09:36:53 INFO - PROCESS | 3958 | 09:36:53 INFO - PROCESS | 3958 | __start_tp_report 09:36:53 INFO - PROCESS | 3958 | _x_x_mozilla_page_load 09:36:53 INFO - PROCESS | 3958 | _x_x_mozilla_page_load_details 09:36:53 INFO - PROCESS | 3958 | |i|pagename|runs| 09:36:53 INFO - PROCESS | 3958 | |0;ai-astar;112;120;122;122;120;121;122;123;124;132 09:36:53 INFO - PROCESS | 3958 | |1;audio-beat-detection;144;111;112;191;123;114;111;97;129;135 09:36:53 INFO - PROCESS | 3958 | |2;audio-dft;274;279;197;196;205;201;200;202;197;194 09:36:53 INFO - PROCESS | 3958 | |3;audio-fft;82;61;62;93;60;62;62;62;78;65 09:36:53 INFO - PROCESS | 3958 | |4;audio-oscillator;89;71;82;59;73;87;91;58;58;85 09:36:53 INFO - PROCESS | 3958 | |5;imaging-gaussian-blur;108;136;89;137;136;100;89;90;96;110 09:36:53 INFO - PROCESS | 3958 | |6;imaging-darkroom;97;97;98;100;156;138;156;123;97;98 09:36:53 INFO - PROCESS | 3958 | |7;imaging-desaturate;92;91;90;135;92;90;92;92;92;93 09:36:53 INFO - PROCESS | 3958 | |8;json-parse-financial;66;67;66;68;69;69;68;69;70;70 09:36:53 INFO - PROCESS | 3958 | |9;json-stringify-tinderbox;60;58;65;64;62;59;61;60;59;59 09:36:53 INFO - PROCESS | 3958 | |10;stanford-crypto-aes;85;82;85;85;99;86;86;89;106;106 09:36:53 INFO - PROCESS | 3958 | |11;stanford-crypto-ccm;153;154;139;149;139;138;146;138;182;142 09:36:53 INFO - PROCESS | 3958 | |12;stanford-crypto-pbkdf2;169;186;170;169;168;170;170;197;165;223 09:36:53 INFO - PROCESS | 3958 | |13;stanford-crypto-sha256-iterative;67;70;86;86;86;83;84;65;65;65 09:36:53 INFO - PROCESS | 3958 | __end_tp_report 09:36:53 INFO - PROCESS | 3958 | __start_cc_report 09:36:53 INFO - PROCESS | 3958 | _x_x_mozilla_cycle_collect,1017 09:36:53 INFO - PROCESS | 3958 | __end_cc_report 09:36:53 INFO - PROCESS | 3958 | __startTimestamp1492447013652__endTimestamp 09:36:53 INFO - PROCESS | 3958 | 09:36:53 INFO - PROCESS | 3958 | ------- Summary: start ------- 09:36:53 INFO - PROCESS | 3958 | Number of tests: 14 09:36:53 INFO - PROCESS | 3958 | 09:36:53 INFO - PROCESS | 3958 | [#0] ai-astar Cycles:10 Average:121.80 Median:122.00 stddev:4.87 (4.0%) stddev-sans-first:3.66 09:36:53 INFO - PROCESS | 3958 | Values: 112.0 120.0 122.0 122.0 120.0 121.0 122.0 123.0 124.0 132.0 09:36:53 INFO - PROCESS | 3958 | 09:36:53 INFO - PROCESS | 3958 | [#1] audio-beat-detection Cycles:10 Average:126.70 Median:132.00 stddev:26.40 (20.0%) stddev-sans-first:27.25 09:36:53 INFO - PROCESS | 3958 | Values: 144.0 111.0 112.0 191.0 123.0 114.0 111.0 97.0 129.0 135.0 09:36:53 INFO - PROCESS | 3958 | 09:36:53 INFO - PROCESS | 3958 | [#2] audio-dft Cycles:10 Average:214.50 Median:201.50 stddev:32.85 (16.3%) stddev-sans-first:26.88 09:36:53 INFO - PROCESS | 3958 | Values: 274.0 279.0 197.0 196.0 205.0 201.0 200.0 202.0 197.0 194.0 09:36:53 INFO - PROCESS | 3958 | 09:36:53 INFO - PROCESS | 3958 | [#3] audio-fft Cycles:10 Average:68.70 Median:63.50 stddev:11.46 (18.0%) stddev-sans-first:11.10 09:36:53 INFO - PROCESS | 3958 | Values: 82.0 61.0 62.0 93.0 60.0 62.0 62.0 62.0 78.0 65.0 09:36:53 INFO - PROCESS | 3958 | 09:36:53 INFO - PROCESS | 3958 | [#4] audio-oscillator Cycles:10 Average:75.30 Median:83.50 stddev:13.33 (16.0%) stddev-sans-first:13.18 09:36:53 INFO - PROCESS | 3958 | Values: 89.0 71.0 82.0 59.0 73.0 87.0 91.0 58.0 58.0 85.0 09:36:53 INFO - PROCESS | 3958 | 09:36:53 INFO - PROCESS | 3958 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:113.00 stddev:20.15 (17.8%) stddev-sans-first:21.37 09:36:53 INFO - PROCESS | 3958 | Values: 108.0 136.0 89.0 137.0 136.0 100.0 89.0 90.0 96.0 110.0 09:36:53 INFO - PROCESS | 3958 | 09:36:53 INFO - PROCESS | 3958 | [#6] imaging-darkroom Cycles:10 Average:116.00 Median:97.00 stddev:25.21 (26.0%) stddev-sans-first:25.78 09:36:53 INFO - PROCESS | 3958 | Values: 97.0 97.0 98.0 100.0 156.0 138.0 156.0 123.0 97.0 98.0 09:36:53 INFO - PROCESS | 3958 | 09:36:53 INFO - PROCESS | 3958 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:92.00 stddev:13.77 (15.0%) stddev-sans-first:14.53 09:36:53 INFO - PROCESS | 3958 | Values: 92.0 91.0 90.0 135.0 92.0 90.0 92.0 92.0 92.0 93.0 09:36:53 INFO - PROCESS | 3958 | 09:36:53 INFO - PROCESS | 3958 | [#8] json-parse-financial Cycles:10 Average:68.20 Median:69.00 stddev:1.48 (2.1%) stddev-sans-first:1.33 09:36:53 INFO - PROCESS | 3958 | Values: 66.0 67.0 66.0 68.0 69.0 69.0 68.0 69.0 70.0 70.0 09:36:53 INFO - PROCESS | 3958 | 09:36:53 INFO - PROCESS | 3958 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:60.50 stddev:2.31 (3.8%) stddev-sans-first:2.44 09:36:53 INFO - PROCESS | 3958 | Values: 60.0 58.0 65.0 64.0 62.0 59.0 61.0 60.0 59.0 59.0 09:36:53 INFO - PROCESS | 3958 | 09:36:53 INFO - PROCESS | 3958 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:85.50 stddev:9.17 (10.7%) stddev-sans-first:9.48 09:36:53 INFO - PROCESS | 3958 | Values: 85.0 82.0 85.0 85.0 99.0 86.0 86.0 89.0 106.0 106.0 09:36:53 INFO - PROCESS | 3958 | 09:36:53 INFO - PROCESS | 3958 | [#11] stanford-crypto-ccm Cycles:10 Average:148.00 Median:147.50 stddev:13.42 (9.1%) stddev-sans-first:14.11 09:36:53 INFO - PROCESS | 3958 | Values: 153.0 154.0 139.0 149.0 139.0 138.0 146.0 138.0 182.0 142.0 09:36:53 INFO - PROCESS | 3958 | 09:36:53 INFO - PROCESS | 3958 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.70 Median:170.00 stddev:18.46 (10.9%) stddev-sans-first:19.25 09:36:53 INFO - PROCESS | 3958 | Values: 169.0 186.0 170.0 169.0 168.0 170.0 170.0 197.0 165.0 223.0 09:36:53 INFO - PROCESS | 3958 | 09:36:53 INFO - PROCESS | 3958 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.70 Median:83.50 stddev:9.96 (11.9%) stddev-sans-first:10.05 09:36:53 INFO - PROCESS | 3958 | Values: 67.0 70.0 86.0 86.0 86.0 83.0 84.0 65.0 65.0 65.0 09:36:53 INFO - PROCESS | 3958 | -------- Summary: end -------- 09:36:53 INFO - PROCESS | 3958 | 09:36:54 INFO - TEST-INFO | 3958: exit 0 09:36:54 INFO - TEST-OK | kraken | took 61672ms 09:36:54 INFO - SUITE-END | took 1178s 09:36:54 INFO - Completed test suite (00:19:38) 09:36:54 INFO - javascript benchmark 09:36:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7718.33096193047, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3457.7752446091004, 3462.169079420938, 3503.982480087599, 3505.404081306178, 3514.8594056237753, 5154.896902061956, 6016.488598469125, 6064.241969753781, 6070.392960703927, 6099.725512351954, 6051.425114614116, 6089.147519347295, 6154.507639388849, 6179.536534759888, 6180.0420934755075, 5452.236686863842, 5475.151351540498, 5533.418991005947, 5592.7762889484375, 5597.496225339719, 5490.6431081979745, 5591.440855914397, 5596.992541342557, 5599.832005039855, 5630.352509461423, 5338.839834804962, 5356.0894647909945, 5402.432744561824, 5527.032769265363, 5527.088030474967, 5397.7031263280505, 5409.134538473864, 5488.231647569343, 5488.368837583689, 5498.3127109111365, 5343.572514198893, 5391.78432862685, 5393.865153371158, 5411.350637923474, 5419.5393391561765, 4707.611254679843, 5773.451522105435, 6128.908066379008, 6135.9079613805825, 6202.41077097675, 6234.407731265523, 6294.685265736741, 6391.904121438182, 6440.194975628046, 6479.902801457982, 6609.867802643968, 6613.239477460105, 6615.735370585219, 6618.536702430832, 6634.436072933807, 6243.968780156161, 6247.344028876993, 6270.843228919313, 6286.0, 6289.433950944392, 6420.293767685551, 6511.446527045159, 6638.601683898982, 6656.034874943106, 6717.9664101680155, 6390.904136437957, 6406.135171751847, 6418.518611104186, 6419.325970773095, 6441.162648855712, 6579.3420657934785, 6587.604743715392, 6593.80218593443, 6597.30728273534, 6598.868022639616, 6237.345078766755, 6333.936660633335, 6384.0, 6406.135171751754, 6484.221893372825, 6440.25937017249, 6502.122213501211, 6519.0, 6523.804285871432, 6563.704633291418, 5240.895182096337, 5250.317458730341, 5251.894962100813, 5272.9736351318, 5299.099153143898, 4520.909581808345, 4579.038401935631, 4600.677952543289, 4668.486466488684, 4670.8365207217585, 6220.098085777537, 6239.282482514478, 6262.968685156545, 6273.937260627426, 6301.086342480315, 6524.869502609921, 6617.172853393326, 6630.270670226271, 6643.2360278568585, 6651.600903945779, 6039.667818270037, 6085.36103709113, 6116.969415152896, 6240.282367527792, 6277.968610157011, 5695.686737229492, 5700.743466544015, 5761.711914404263, 5789.131630255495, 5828.970855145697, 6822.283660215804, 6828.829279268058, 6868.072810170763, 6876.17485901695, 6881.793546193622, 6306.2747784003595, 6617.933820661732, 6666.866662666623, 6670.099536562502, 6693.765718199839, 6450.677466126581, 6500.6424646643, 6678.933210668026, 6824.2152152503095, 6887.345702158287, 6446.64543450096, 6450.838729031811, 6505.837354066186, 6514.609123452608, 6526.4452521536205, 6520.315366886409, 6584.473242140713, 6589.835254118685, 6589.934100658932, 6639.767608133692, 6229.844253893689, 6278.7488500461295, 6290.654014029273, 6416.230052393743, 6422.389872962061, 6299.716512757029, 6314.84212894663, 6413.551051426355, 6420.454261387835, 6447.516436267205, 6225.501959843292, 6240.095186198067, 6332.366763323631, 6335.936640633535, 6340.175777148941, 6307.716152773228, 6376.266729326187, 6396.624725684001, 6437.25971513282, 6442.194725659293, 6214.347493513116, 6215.254169499689, 6230.626162430269, 6306.810795676137, 6306.9684651576445], "value": 6011.82431116902, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.1596873673436, 737.1338677054459, 816.3713940265993, 957.1242313283342, 961.8268711631904, 38271.42592861106, 38839.80580097103, 40050.59949400505, 40232.19535609286, 40279.59720402795, 30912.690873091262, 39044.41433378502, 39292.0, 39350.0, 39401.40897886534, 7868.2918537331625, 8026.398020148483, 10661.626843060494, 10944.45277736114, 11148.498317575728, 9012.369134160612, 9125.45247285165, 10834.837477437844, 10852.0, 10874.565017399294, 10863.782724345549, 10870.565177392895, 10897.782044359108, 10900.836487452694, 10918.235723499358, 10815.83776243357, 10830.025297723203, 10884.673459796179, 10885.0, 10888.074513666348, 10630.840537391945, 10667.679969600924, 10679.30584512012, 10680.732981675443, 10696.304740191863, 33611.6638833611, 33711.494327584864, 33902.98291051272, 33997.64009439644, 34076.48885266723, 3678.4114541673202, 3697.1126929536986, 3719.8699986562033, 3774.941578285111, 3784.3188226119287, 25399.873000634878, 26282.0, 26300.605490917653, 26317.21048368533, 26336.73663263362, 3009.8043627164166, 3063.7089476499696, 3075.415671022521, 3158.589383380146, 3258.96741032589, 349957.0, 351042.24478877697, 351778.0, 351780.0, 352468.0, 43083.35374969378, 43099.35350969738, 43111.35332970008, 43204.567954320686, 43275.567244327154, 44600.3309950351, 44914.0, 44935.0, 45008.54991450109, 45155.0, 11579.72623011468, 13859.792103118461, 13917.02580819333, 13960.58118256454, 13989.580312590435, 11949.044076473861, 12068.215565988183, 12114.575989840314, 12122.696932576757, 12125.09061820367, 10381.740456488496, 11676.182667213214, 11833.112516561292, 11848.815118488083, 11931.224470409396, 4645.9303110453375, 5662.17898404729, 5710.314762228559, 5716.542676585863, 5813.302403711582, 1083.5503266144462, 1088.8421178929011, 1112.9538234059958, 1136.6476392318407, 1213.878612138779, 21161.78838211629, 26828.195154145407, 27324.59013114805, 27349.906003760025, 27398.726012740015, 1233.8889499945049, 1269.6127681057183, 1277.9041571882146, 1325.8541560428346, 1338.578347820453, 13709.040367174202, 13891.0, 13971.23158226287, 14085.366158522891, 14147.151170929777, 372371.0, 395458.0, 473979.0, 474063.0, 474116.0, 56558.151627724794, 56874.14688779671, 56960.43039569634, 57207.56981075506, 57342.0, 1350.4935649131771, 1354.7561438941086, 1383.7855132454486, 1402.2287741742, 1403.3334166271143, 23916.0, 25353.239402817944, 26766.0, 26897.327566810985, 26906.0, 39288.21423571456, 39510.20979580335, 39514.802425987684, 39686.40470393004, 39708.205835883695, 451347.0, 451974.7401262973, 453542.0, 457243.0, 457464.138037923, 24335.51328973446, 28215.858920705265, 29307.974220902168, 30185.698143019166, 30375.0, 37556.0, 37927.462172149804, 38592.8422147336, 38775.8367248983, 39455.60544394519, 27527.86236068807, 27749.86125069362, 27843.02549410761, 28275.434491309647, 28811.423771524034, 23573.882130589238, 23583.0, 27603.86198068997, 27809.0, 28429.857850710614, 28564.857175713987, 31244.0, 32339.029829105166, 32746.181345466553, 32758.672413275563, 28020.0, 28340.149795506168, 28498.0, 28826.855865720536, 28944.565831512966, 21698.92344258701, 21878.781212187674, 22164.002619882467, 23133.421664458525, 23277.41806454852], "value": 18000.011540508163, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.84518305635385, 428.51577717179583, 431.81638930515015, 441.6025576980717, 442.6304036129831, 17087.9747215167, 19204.94372809495, 19413.708794368096, 20884.686729699068, 20998.26506072288, 19767.604647907032, 20526.076326565304, 21268.893655531738, 21862.344129676094, 21974.89012554939, 6573.211214654249, 6694.230163531208, 6694.564853284521, 6697.5981441113445, 6713.899291510606, 5954.166416701665, 6149.2313460817395, 6196.132541444202, 6602.735890564371, 6671.766488172915, 6154.753809847601, 6179.66011869347, 6183.567150299458, 6191.102290167923, 6207.81376558704, 6200.410960958701, 6737.090492783461, 6744.898826517606, 6765.627890466047, 6773.356531129535, 6174.783882564088, 6494.967525162344, 6512.576682515669, 6597.241317248482, 6610.801675949681, 26002.479950400884, 26215.34461638455, 26395.604065939027, 26443.867780661167, 26541.203763887115, 2881.9423611527864, 2945.381469891304, 2975.79169458138, 3238.5627940228237, 3334.1831251343333, 16320.510384688478, 16465.0, 16757.83242167575, 16848.494545163663, 17191.1404429778, 2081.8230450411734, 2082.83337333013, 2103.7580678221893, 2120.724305840231, 2206.0403724379944, 125887.37056314752, 126315.0, 126626.73373266241, 128414.0, 129944.350278248, 19657.606847863248, 20493.590128197353, 21825.34523964252, 22232.444188895082, 22513.662295065587, 34782.65217347845, 35263.82368088143, 35681.82159089188, 35736.46395304072, 35762.8211858939, 9041.412308199946, 10530.0, 10538.631147909786, 11251.874812518683, 11261.718457038476, 7384.667689953965, 8859.29125669945, 8939.910600893907, 8980.191782739585, 9150.542472876463, 10279.640212592523, 10678.62624808128, 10684.038436540748, 10895.019448249695, 10982.505787239434, 4280.700350975402, 4357.281048627005, 4396.3185706214945, 4397.164538737629, 4405.581469760367, 875.4353442029983, 1020.8162530744537, 1057.6086847866186, 1106.2145876427664, 1115.3252282369212, 17783.73324400135, 20035.59928801445, 20749.792502075088, 20875.0, 21283.78716212818, 880.7842078690634, 1043.5617040842865, 1060.3743791163251, 1080.400377790334, 1085.3379438542484, 9979.750506237402, 11168.218224724355, 11174.161937854693, 11209.887901121048, 11240.831387529193, 629495.0, 715952.0, 734768.0, 749799.2767987812, 753933.0, 105835.0, 111028.88971110347, 120399.0, 121562.0, 121654.56690866133, 1234.8765123487578, 1244.5457408045997, 1264.7091169030991, 1267.2776517385003, 1269.0101720657901, 14275.357608907416, 14478.782818257945, 16199.491255646666, 18284.817151828844, 18437.446876593724, 42716.718498445094, 43680.56319436892, 47035.0, 48740.02519949652, 50664.74667626638, 70582.0, 70804.29195707977, 71163.64418177876, 72152.55694885968, 72177.0, 11637.88362116402, 11763.117766167743, 12167.878321216675, 12240.693982650506, 12338.629841104781, 13001.609951701465, 13115.934420327838, 13173.60479185626, 13419.664508387368, 13476.79784803209, 11136.164787640797, 11378.829317560409, 11466.197366184288, 11729.882701173221, 11817.763644727229, 10497.212709047004, 10528.684139475828, 10564.788704226026, 10754.516046777757, 10908.563657453613, 9113.0, 11406.973372396524, 11686.0, 11825.0, 11917.284962902253, 10612.204084693833, 11441.913018263253, 12000.63998080059, 12059.276443413422, 12211.633650990485, 11228.775424491301, 11319.773604528027, 11576.363300018244, 11577.479013444246, 11621.593244236412], "value": 11338.250309546485, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1434.576799844046, 1548.1175729833985, 1553.3708847916598, 1564.7965764450619, 1596.8003999500065, 9453.763655908606, 9655.758606034853, 10801.83797243041, 11351.545938162464, 11381.772364552715, 9912.702618921443, 10231.48842557873, 10639.202059845504, 10998.395088270141, 11009.28439651424, 2307.3078076577044, 2368.3250273672006, 2383.011050414076, 2385.3082606044313, 2387.128698025217, 2333.7549557296493, 2351.670766092748, 2359.6932398788135, 2384.2608791274674, 2394.2577800881695, 2302.9654555181687, 2335.054303007285, 2357.9528409431887, 2373.477834876333, 2376.989779343781, 2300.3099070279018, 2332.941676458085, 2337.777911098443, 2342.3324352559525, 2360.97639023611, 2043.8978051097533, 2296.334063121693, 2340.414896275931, 2353.752855950118, 2359.3275916363928, 10844.31913053478, 10969.341839489656, 11074.778504429867, 11090.946360095779, 11091.611793587266, 5454.481824226692, 5500.7524661390335, 5644.8024319148635, 5692.146178073281, 5778.42215778423, 3363.226457914693, 3519.753617246794, 3596.0650230940146, 3603.1172362771026, 3605.5853576838736, 1089.722120859176, 1121.5177473686313, 1153.089059642881, 1170.9238899471593, 1175.0, 15497.922510387489, 15628.609284767857, 15631.296591653288, 15698.686026279525, 15703.979241349276, 4496.325551167286, 4737.549932756383, 4789.44921334051, 4812.205986012339, 4827.034593081397, 11662.825057624143, 12397.566085186974, 13162.60512184636, 13170.341482925814, 13506.662333441742, 4900.72581128909, 5546.057170281062, 5642.492175704207, 5679.0, 5690.118031705092, 4404.11917616478, 4847.878803029953, 4907.1167189905445, 5188.092083885305, 5270.578353731692, 3871.9612803872164, 3919.980400097981, 4016.216837716676, 4031.0930040741187, 4078.408630748525, 913.712180663089, 1063.3407287481657, 1067.7170549804307, 1069.417167643636, 1089.727568107973, 916.6745805239044, 931.6785708930408, 933.5425641435647, 937.9108984646448, 967.4630580028152, 6611.173603299588, 6615.6030638161865, 6676.933230667728, 6682.164729408824, 6921.792346229621, 956.206348730552, 978.7210644966151, 1000.3847633705219, 1005.8038682456997, 1037.1650821088945, 3649.379605467077, 4128.422020917014, 4148.958510414917, 4157.812898419578, 4281.850135245314, 13197.53808616713, 13755.243461609707, 13767.173969561858, 13774.035817492679, 13782.241976691177, 13686.0, 13686.93156534231, 13687.24720140382, 13704.65738356549, 13722.794158087636, 8817.735467935972, 10030.047145521165, 10114.342567733222, 10147.137493313152, 10258.384496930208, 6346.9682651586445, 6456.870862582816, 6483.0, 6539.95360742279, 6571.441427478718, 12189.0, 12199.316150446888, 12230.205036672587, 12276.754464910831, 12302.015838732701, 12522.686932826753, 12541.561045363369, 12550.87449125497, 12635.0, 12655.367231638565, 7673.117591477052, 9223.354365194373, 9225.354225204172, 9294.953525232331, 9325.626974920928, 10227.94886025565, 10246.538905749409, 10327.225458090523, 10341.4312212829, 10350.844737329096, 8707.825843483222, 8720.215180633773, 8754.29965602763, 8756.299496040174, 8778.692745753868, 8434.620442080244, 8550.1449855014, 8563.186497282748, 8573.142685731376, 8709.695160669346, 7789.766307010798, 7823.100343460575, 7908.960455197687, 7929.841403172019, 7932.6430310637315, 5905.645661260338, 5949.077892926603, 5951.613145145551, 5991.161237426677, 6030.185924900083, 4924.2613607957655, 5461.9076184764, 5904.52763778888, 5928.703564821828, 6103.938960610337], "value": 5088.806567155736, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.6764447286388, 379.6829647244551, 390.74601509019135, 393.7125898094393, 396.95831937646545, 4397.516273209948, 4622.676412651116, 4999.400071991357, 5236.847893463437, 5251.897101608667, 4533.750643714594, 4569.840055598055, 5056.69659820411, 5304.681719096857, 5367.838964831051, 4013.458183145282, 4304.139172165564, 4351.412559304485, 4391.967887546424, 4586.908261834761, 3988.5811989741096, 4120.578400451855, 4219.810108545107, 4504.436945381827, 4679.953200468003, 3937.8031098444962, 4144.937825932599, 4670.76646167692, 4728.777474586938, 4759.500252473493, 4248.490181178278, 4592.586667199935, 4601.28680054592, 4696.50686677899, 4730.337752714623, 3652.6347365263528, 3780.8109594520165, 4132.73137246081, 4480.462344518646, 4514.826145202271, 4684.367610372624, 5340.465953404668, 5346.4118946915805, 5353.544948679367, 5358.955003774266, 4501.167284052461, 4968.850934471971, 5373.811916582901, 5514.53864725848, 5575.386707462176, 4858.902821943577, 5158.97420512895, 5386.064594795846, 5398.947205294969, 5727.284089488814, 4235.724677895927, 4972.328735620717, 4990.251462280687, 4991.925121123149, 4994.550490455877, 4830.396200474941, 5058.4435712071645, 5818.069108942549, 5849.800790837868, 6380.234371875358, 4337.327714204303, 4741.715497070187, 4743.573078422958, 4761.6429317645, 4890.310329318861, 4649.651276154302, 4720.740359280204, 5114.655185331338, 5240.371155461369, 5288.5143982328245, 5131.435542090367, 5371.543418809445, 5450.4549545045975, 5452.955141821817, 5483.39394908271, 5292.708901010481, 5297.894042119136, 5553.500184983371, 5724.885502290014, 5732.108404226596, 1616.6928283626073, 1721.741738739199, 1807.41259090796, 1817.6730986379753, 1833.779946406413, 1219.0, 1326.9167407170648, 1384.7715127003933, 1470.0811992504684, 1500.129924643704, 4707.929381059287, 5000.924986125211, 5050.974745126251, 5284.365876094893, 5321.521063104339, 5278.445763194886, 5309.840704778863, 5386.730663466811, 5571.45354208803, 5811.82564523065, 4243.257429949746, 4960.826371077067, 5266.077327083505, 5342.839714808562, 5367.624266301399, 2675.464907018604, 2752.6146339512484, 2941.1176647005814, 3064.5709600655928, 3148.354587309596, 5475.616706830563, 5721.713914304268, 5739.913901291484, 6184.443400094013, 6209.96895015531, 5738.540916726652, 5939.821805345847, 6028.788992385245, 6147.694614519555, 6172.629642221481, 5609.467100625516, 5869.442402971711, 6216.720247588779, 6230.971889638249, 6331.936680633226, 5042.520960508746, 5238.869028274324, 5247.370315562157, 5717.885642287214, 5812.302523697014, 5260.237265596544, 5355.813291091794, 5595.860103497445, 5904.084866845646, 5984.760609575568, 5292.391374991926, 6269.62382257066, 6272.5922815016875, 6302.243730752339, 6343.207099112611, 4056.2822908650683, 4377.927407785113, 4543.568361005699, 4654.813807447664, 4704.1062198182235, 5286.418493965738, 5288.312519372457, 5396.78412863481, 5955.761769529344, 5973.731182096729, 5446.685158807571, 5500.332338815751, 5623.353314368736, 5791.681457519709, 5879.823605291848, 5024.969881174424, 5213.478652134908, 5693.4021927696995, 5747.5401967841635, 5748.770049197985, 5064.215046667772, 5592.3862813178475, 5675.120356344773, 5697.857553561194, 5754.0, 4992.450830408579, 5114.820981265638, 5176.534111929945, 5490.368607610176, 5698.230738850202, 5183.974080129575, 5568.331800184003, 5587.3015873015875, 5614.6631202128, 5645.379008309164], "value": 4435.444963350584, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.1856923822227, 754.3738696881587, 770.8496843115591, 827.635840230299, 839.7438781171742, 15126.470573529929, 16457.67084658306, 16511.339546418145, 16512.917435412837, 16529.33882644693, 15021.248937553133, 15049.172295523742, 16081.597960051005, 16864.747028794576, 17405.91297043513, 927.3184209605935, 948.7817801905566, 953.3136141977765, 953.3564843730488, 953.5708930981051, 783.713944410289, 908.500324821349, 932.4125800745521, 943.9292053096011, 949.9667511637094, 1000.3197825478671, 1001.6994901529548, 1001.7996400719849, 1002.3534820041069, 1003.4130033930123, 985.5417230987625, 997.760537471009, 999.2755252441995, 999.6701088640731, 1001.1590264178053, 728.5810658871118, 728.5883475836189, 741.903552538172, 742.8811390177545, 743.4498471131324, 15986.76019859703, 16314.83685163157, 16426.42507512243, 16849.241784119746, 16886.408975685914, 14269.357878895475, 14283.0, 14322.64193395163, 14422.567322980327, 14424.71150576993, 10871.945640271748, 11535.25020873649, 11739.23694959825, 11946.761064778655, 12396.194247373893, 3009.653889802657, 3084.0901933929545, 3096.071178646397, 3174.682531746807, 3182.4112539180096, 114263.2860507093, 120228.0, 120803.3959830204, 121549.78450215473, 122295.99999999911, 10419.583216671248, 10571.312864663925, 10652.40213967911, 10878.40168790724, 11211.495482703134, 22089.0, 22352.441188970082, 22568.758718270325, 22613.208537701103, 22665.546689066126, 7689.346405555479, 7841.882371764428, 7979.9227104341335, 8016.398770092266, 8086.1913808618665, 4264.189803937242, 4266.5946735060115, 4326.913461730811, 4328.5946263661, 4424.115176964556, 3424.33225521026, 3443.8794642187404, 3505.0361150683766, 3505.9824700876334, 3524.947125793115, 645.3933302695451, 650.629141389413, 651.667649498759, 652.7323797243107, 661.3254480429935, 658.5423130923962, 665.986680266392, 675.9526833121732, 688.6728803818146, 691.7025678958096, 10199.18406527476, 10252.487375631188, 10265.384076955406, 10576.17518597563, 10595.152387808957, 658.8188248231775, 665.70043480434, 682.5768023825161, 684.4114061906756, 684.4421796236052, 4797.376341075707, 5069.467705890902, 5074.67014644047, 5090.9236361454605, 5104.795808167706, 106150.0, 106393.0, 107791.0, 109855.90144098617, 111406.0, 74900.62549687216, 75999.0, 76199.61900190463, 80325.39349212984, 93758.06241937629, 73785.6310718443, 74280.62859685667, 75075.0, 76206.23793762103, 76367.85448218281, 10217.846732298873, 11025.944870275598, 11029.669109926715, 11146.554137834395, 11300.434978251218, 44369.89075273144, 50247.748761255956, 50878.0, 51640.74179629078, 51807.74096129495, 64050.35949640444, 64221.03668445071, 64262.0, 64567.677161613894, 64655.353446464935, 10711.196660250669, 12424.503019879103, 12490.250584964931, 12679.302638354979, 13117.840580284548, 14082.225477598831, 14260.71478570402, 14296.642583935485, 14620.12279263205, 14772.18752968597, 10842.783144337227, 13415.262160581262, 13849.584512464642, 13881.097728647606, 14276.785848212492, 13288.800667989795, 13298.468061277828, 13724.0, 13768.65578360549, 14247.928760356132, 11180.55277788912, 12796.872031279569, 13460.730785384434, 13659.0, 13937.930310348384, 9171.495567743837, 9468.905310946802, 9539.379940303857, 9693.273004524548, 9733.124018838338, 9913.702588922344, 11325.660230193107, 11327.773444531229, 11339.603113890975, 11347.886521135013], "value": 7633.521558618075, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 120.0, 122.0, 122.0, 120.0, 121.0, 122.0, 123.0, 124.0, 132.0], "value": 121.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 111.0, 112.0, 191.0, 123.0, 114.0, 111.0, 97.0, 129.0, 135.0], "value": 126.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [274.0, 279.0, 197.0, 196.0, 205.0, 201.0, 200.0, 202.0, 197.0, 194.0], "value": 214.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 61.0, 62.0, 93.0, 60.0, 62.0, 62.0, 62.0, 78.0, 65.0], "value": 68.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 82.0, 59.0, 73.0, 87.0, 91.0, 58.0, 58.0, 85.0], "value": 75.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 136.0, 89.0, 137.0, 136.0, 100.0, 89.0, 90.0, 96.0, 110.0], "value": 109.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 98.0, 100.0, 156.0, 138.0, 156.0, 123.0, 97.0, 98.0], "value": 116.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 90.0, 135.0, 92.0, 90.0, 92.0, 92.0, 92.0, 93.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 68.0, 69.0, 69.0, 68.0, 69.0, 70.0, 70.0], "value": 68.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 65.0, 64.0, 62.0, 59.0, 61.0, 60.0, 59.0, 59.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 85.0, 85.0, 99.0, 86.0, 86.0, 89.0, 106.0, 106.0], "value": 90.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 154.0, 139.0, 149.0, 139.0, 138.0, 146.0, 138.0, 182.0, 142.0], "value": 148.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 186.0, 170.0, 169.0, 168.0, 170.0, 170.0, 197.0, 165.0, 223.0], "value": 178.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 86.0, 86.0, 86.0, 83.0, 84.0, 65.0, 65.0, 65.0], "value": 75.7, "unit": "score"}]}]} 09:36:54 INFO - Return code: 0 09:36:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:36:54 ERROR - # TBPL SUCCESS # 09:36:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:36:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:36:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:36:54 INFO - 2017-04-17 09:36:54.998 screenresolution[3963:82798] starting screenresolution argv=screenresolution get 09:36:55 INFO - 2017-04-17 09:36:55.000 screenresolution[3963:82798] Display 0: 1600x1200x32@60 09:36:55 INFO - 2017-04-17 09:36:55.007 screenresolution[3964:82801] starting screenresolution argv=screenresolution list 09:36:55 INFO - Available Modes on Display 0 09:36:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:36:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:36:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:36:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:36:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:36:55 INFO - Intel Iris: 09:36:55 INFO - Chipset Model: Intel Iris 09:36:55 INFO - Type: GPU 09:36:55 INFO - Bus: Built-In 09:36:55 INFO - VRAM (Dynamic, Max): 1536 MB 09:36:55 INFO - Vendor: Intel (0x8086) 09:36:55 INFO - Device ID: 0x0a2e 09:36:55 INFO - Revision ID: 0x0009 09:36:55 INFO - Displays: 09:36:55 INFO - Display: 09:36:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:36:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:36:55 INFO - Display Serial Number: 1600x1200 60 09:36:55 INFO - Main Display: Yes 09:36:55 INFO - Mirror: Off 09:36:55 INFO - Online: Yes 09:36:55 INFO - Rotation: Supported 09:36:55 INFO - Return code: 0 09:36:55 INFO - Running post-action listener: _resource_record_post_action 09:36:55 INFO - [mozharness: 2017-04-17 16:36:55.247666Z] Finished run-tests step (success) 09:36:55 INFO - Running post-run listener: _resource_record_post_run 09:36:55 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 118784; Write bytes: 510471680; Read time: 2; Write time: 1737 09:36:55 INFO - TinderboxPrint: CPU usage
54.5% 09:36:55 INFO - TinderboxPrint: I/O read bytes / time
118,784 / 2 09:36:55 INFO - TinderboxPrint: I/O write bytes / time
510,471,680 / 1,737 09:36:55 INFO - TinderboxPrint: CPU idle
2,183.1 (45.5%) 09:36:55 INFO - TinderboxPrint: CPU system
966.6 (20.1%) 09:36:55 INFO - TinderboxPrint: CPU user
1,648.0 (34.4%) 09:36:55 INFO - TinderboxPrint: Swap in / out
207,798,272 / 0 09:36:55 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205750784; Write bytes: 200889856; Read time: 15775; Write time: 414 09:36:55 INFO - run-tests - Wall time: 1180s; CPU: 55.0%; Read bytes: 118784; Write bytes: 298518528; Read time: 2; Write time: 1286 09:36:55 INFO - Running post-run listener: _upload_blobber_files 09:36:55 INFO - Blob upload gear active. 09:36:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:36:55 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 09:36:55 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:36:55 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:36:56 INFO - (blobuploader) - INFO - Open directory for files ... 09:36:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:36:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:36:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:56 INFO - (blobuploader) - INFO - Done attempting. 09:36:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:36:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:36:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:57 INFO - (blobuploader) - INFO - Done attempting. 09:36:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:36:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:36:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:58 INFO - (blobuploader) - INFO - Done attempting. 09:36:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:36:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:37:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:37:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:37:01 INFO - (blobuploader) - INFO - Done attempting. 09:37:01 INFO - (blobuploader) - INFO - Iteration through files over. 09:37:01 INFO - Return code: 0 09:37:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:37:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:37:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c63662a9ff74e3c6735546beba57676b9ef00e96ed6f794b507582c955b99dbc3196b002bae97c9fd1c42a7d99cef3fe6143d36292c047a09469dc2b424b61bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ff4307a9fa3779cb1eebfb4a2c39899d628837294b160468e34b7966e0f1a599e40e16f50312f21252871c637e44a1792a2f3630b84e13c4295522bbf98c62f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee11bb24d2d90b168e2a52f91f5be0fe4cfac6f04c80c9f09b61c3550fe5dc747d3ce5691e346a049ea902f8d03c4a2f60f6aadde62095dfb821a4e6b033fea6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/acc42fd3fb634efa16b1db55d18f870178ccfbeba11ed39ee4cf6669cae6c074063c7acda73a673a9e2b6369b93a2e50e64f6d434e0ccd5c13c5bf3a84b3ee92"} 09:37:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:37:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:37:01 INFO - Contents: 09:37:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c63662a9ff74e3c6735546beba57676b9ef00e96ed6f794b507582c955b99dbc3196b002bae97c9fd1c42a7d99cef3fe6143d36292c047a09469dc2b424b61bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ff4307a9fa3779cb1eebfb4a2c39899d628837294b160468e34b7966e0f1a599e40e16f50312f21252871c637e44a1792a2f3630b84e13c4295522bbf98c62f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee11bb24d2d90b168e2a52f91f5be0fe4cfac6f04c80c9f09b61c3550fe5dc747d3ce5691e346a049ea902f8d03c4a2f60f6aadde62095dfb821a4e6b033fea6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/acc42fd3fb634efa16b1db55d18f870178ccfbeba11ed39ee4cf6669cae6c074063c7acda73a673a9e2b6369b93a2e50e64f6d434e0ccd5c13c5bf3a84b3ee92"} 09:37:01 INFO - Running post-run listener: copy_logs_to_upload_dir 09:37:01 INFO - Copying logs to upload dir... 09:37:01 INFO - mkdir: /builds/slave/test/build/upload/logs 09:37:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.194476 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-17 09:37:01.179174) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-17 09:37:01.183180) ========= 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.B3gshzoLBo/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.G8p66e2YDu/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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/Mozilla-Aurora/sha512/c63662a9ff74e3c6735546beba57676b9ef00e96ed6f794b507582c955b99dbc3196b002bae97c9fd1c42a7d99cef3fe6143d36292c047a09469dc2b424b61bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ff4307a9fa3779cb1eebfb4a2c39899d628837294b160468e34b7966e0f1a599e40e16f50312f21252871c637e44a1792a2f3630b84e13c4295522bbf98c62f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee11bb24d2d90b168e2a52f91f5be0fe4cfac6f04c80c9f09b61c3550fe5dc747d3ce5691e346a049ea902f8d03c4a2f60f6aadde62095dfb821a4e6b033fea6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/acc42fd3fb634efa16b1db55d18f870178ccfbeba11ed39ee4cf6669cae6c074063c7acda73a673a9e2b6369b93a2e50e64f6d434e0ccd5c13c5bf3a84b3ee92"} build_url:https://queue.taskcluster.net/v1/task/Mtc4L6VNT2KGKvYdfK9MIg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011421 build_url: 'https://queue.taskcluster.net/v1/task/Mtc4L6VNT2KGKvYdfK9MIg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c63662a9ff74e3c6735546beba57676b9ef00e96ed6f794b507582c955b99dbc3196b002bae97c9fd1c42a7d99cef3fe6143d36292c047a09469dc2b424b61bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ff4307a9fa3779cb1eebfb4a2c39899d628837294b160468e34b7966e0f1a599e40e16f50312f21252871c637e44a1792a2f3630b84e13c4295522bbf98c62f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee11bb24d2d90b168e2a52f91f5be0fe4cfac6f04c80c9f09b61c3550fe5dc747d3ce5691e346a049ea902f8d03c4a2f60f6aadde62095dfb821a4e6b033fea6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/acc42fd3fb634efa16b1db55d18f870178ccfbeba11ed39ee4cf6669cae6c074063c7acda73a673a9e2b6369b93a2e50e64f6d434e0ccd5c13c5bf3a84b3ee92"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-17 09:37:01.218864) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 09:37:01.219221) ========= 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.B3gshzoLBo/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.G8p66e2YDu/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/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.005523 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 09:37:01.268124) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-17 09:37:01.268466) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-17 09:37:01.268866) ========= ========= Total master_lag: 0.18 =========