builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0302 starttime: 1490819105.12 results: success (0) buildid: 20170329112223 builduid: 3b4d5bdf840a4f6da909e85072d89675 revision: 4c7c05a49f3ce40aa0969beccb397380a8907f4a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 13:25:05.116825) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 13:25:05.117326) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 13:25:05.117608) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 13:25:05.143235) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 13:25:05.143628) ========= 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.xnir6frvva/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.J046t1PGVe/Listeners TMPDIR=/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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-03-29 13:25:05-- 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% 7.97M=0.001s 2017-03-29 13:25:05 (7.97 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120933 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 13:25:05.288125) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 13:25:05.288445) ========= 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.xnir6frvva/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.J046t1PGVe/Listeners TMPDIR=/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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.020392 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 13:25:05.336993) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-29 13:25:05.337352) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4c7c05a49f3ce40aa0969beccb397380a8907f4a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 4c7c05a49f3ce40aa0969beccb397380a8907f4a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xnir6frvva/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.J046t1PGVe/Listeners TMPDIR=/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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-03-29 13:25:05,430 truncating revision to first 12 chars 2017-03-29 13:25:05,430 Setting DEBUG logging. 2017-03-29 13:25:05,430 attempt 1/10 2017-03-29 13:25:05,430 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4c7c05a49f3c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-29 13:25:06,171 unpacking tar archive at: mozilla-central-4c7c05a49f3c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.008672 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-29 13:25:06.368833) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 13:25:06.369166) ========= script_repo_revision: 4c7c05a49f3ce40aa0969beccb397380a8907f4a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 13:25:06.369546) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 13:25:06.369809) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 13:25:06.387132) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-03-29 13:25:06.387472) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xnir6frvva/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.J046t1PGVe/Listeners TMPDIR=/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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 13:25:06 INFO - MultiFileLogger online at 20170329 13:25:06 in /builds/slave/test 13:25:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:25:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:25:06 INFO - {'append_to_log': False, 13:25:06 INFO - 'base_work_dir': '/builds/slave/test', 13:25:06 INFO - 'blob_upload_branch': 'Firefox', 13:25:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:25:06 INFO - 'branch': 'Firefox', 13:25:06 INFO - 'buildbot_json_path': 'buildprops.json', 13:25:06 INFO - 'config_files': ('talos/mac_config.py',), 13:25:06 INFO - 'default_actions': ('clobber', 13:25:06 INFO - 'read-buildbot-config', 13:25:06 INFO - 'download-and-extract', 13:25:06 INFO - 'populate-webroot', 13:25:06 INFO - 'create-virtualenv', 13:25:06 INFO - 'install', 13:25:06 INFO - 'run-tests'), 13:25:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:25:06 INFO - 'download_minidump_stackwalk': True, 13:25:06 INFO - 'download_symbols': 'ondemand', 13:25:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:25:06 INFO - 'tooltool.py': '/tools/tooltool.py', 13:25:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:25:06 INFO - '/tools/misc-python/virtualenv.py')}, 13:25:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:25:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:25:06 INFO - 'gecko_profile': False, 13:25:06 INFO - 'gecko_profile_interval': 0, 13:25:06 INFO - 'installer_path': 'installer.exe', 13:25:06 INFO - 'log_level': 'info', 13:25:06 INFO - 'log_name': 'talos', 13:25:06 INFO - 'log_to_console': True, 13:25:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:25:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:25:06 INFO - 'opt_config_files': (), 13:25:06 INFO - 'pip_index': False, 13:25:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:25:06 INFO - 'cmd': ('bash', 13:25:06 INFO - '-c', 13:25:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:25:06 INFO - 'enabled': True, 13:25:06 INFO - 'halt_on_failure': False, 13:25:06 INFO - 'name': 'check_screen_resolution'},), 13:25:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:25:06 INFO - 'cmd': ('bash', 13:25:06 INFO - '-c', 13:25:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:25:06 INFO - 'enabled': True, 13:25:06 INFO - 'halt_on_failure': False, 13:25:06 INFO - 'name': 'check_screen_resolution'},), 13:25:06 INFO - 'run_cmd_checks_enabled': True, 13:25:06 INFO - 'suite': 'dromaeojs', 13:25:06 INFO - 'system_bits': '32', 13:25:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:25:06 INFO - 'title': 't-yosemite-r7-0302', 13:25:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:25:06 INFO - 'use_talos_json': True, 13:25:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:25:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:25:06 INFO - 'work_dir': 'build'} 13:25:06 INFO - [mozharness: 2017-03-29 20:25:06.601007Z] Running clobber step. 13:25:06 INFO - Running pre-action listener: _resource_record_pre_action 13:25:06 INFO - Running main action method: clobber 13:25:06 INFO - rmtree: /builds/slave/test/build 13:25:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:25:08 INFO - Running post-action listener: _resource_record_post_action 13:25:08 INFO - [mozharness: 2017-03-29 20:25:08.376393Z] Finished clobber step (success) 13:25:08 INFO - [mozharness: 2017-03-29 20:25:08.376529Z] Running read-buildbot-config step. 13:25:08 INFO - Running pre-action listener: _resource_record_pre_action 13:25:08 INFO - Running main action method: read_buildbot_config 13:25:08 INFO - Using buildbot properties: 13:25:08 INFO - { 13:25:08 INFO - "project": "", 13:25:08 INFO - "product": "firefox", 13:25:08 INFO - "script_repo_revision": "production", 13:25:08 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 13:25:08 INFO - "repository": "", 13:25:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 13:25:08 INFO - "buildid": "20170329112223", 13:25:08 INFO - "pgo_build": "False", 13:25:08 INFO - "basedir": "/builds/slave/test", 13:25:08 INFO - "buildnumber": 11, 13:25:08 INFO - "slavename": "t-yosemite-r7-0302", 13:25:08 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 13:25:08 INFO - "platform": "yosemite_r7", 13:25:08 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 13:25:08 INFO - "branch": "mozilla-central", 13:25:08 INFO - "repo_path": "mozilla-central", 13:25:08 INFO - "revision": "4c7c05a49f3ce40aa0969beccb397380a8907f4a", 13:25:08 INFO - "stage_platform": "macosx64", 13:25:08 INFO - "builduid": "3b4d5bdf840a4f6da909e85072d89675", 13:25:08 INFO - "slavebuilddir": "test" 13:25:08 INFO - } 13:25:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/CKfA2UZ-TqifonDlm3ermQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 13:25:08 INFO - Running post-action listener: _resource_record_post_action 13:25:08 INFO - [mozharness: 2017-03-29 20:25:08.379806Z] Finished read-buildbot-config step (success) 13:25:08 INFO - [mozharness: 2017-03-29 20:25:08.379912Z] Running download-and-extract step. 13:25:08 INFO - Running pre-action listener: _resource_record_pre_action 13:25:08 INFO - Running main action method: download_and_extract 13:25:08 INFO - mkdir: /builds/slave/test/build/tests 13:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:25:08 INFO - trying https://queue.taskcluster.net/v1/task/CKfA2UZ-TqifonDlm3ermQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 13:25:08 INFO - Downloading https://queue.taskcluster.net/v1/task/CKfA2UZ-TqifonDlm3ermQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 13:25:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CKfA2UZ-TqifonDlm3ermQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 13:25:09 INFO - Downloaded 1325 bytes. 13:25:09 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 13:25:09 INFO - Using the following test package requirements: 13:25:09 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:25:09 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 13:25:09 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 13:25:09 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:25:09 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 13:25:09 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:25:09 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 13:25:09 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:25:09 INFO - u'jsshell-mac.zip'], 13:25:09 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:25:09 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 13:25:09 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 13:25:09 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:25:09 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 13:25:09 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:25:09 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 13:25:09 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:25:09 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 13:25:09 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:25:09 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 13:25:09 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:25:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CKfA2UZ-TqifonDlm3ermQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 13:25:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CKfA2UZ-TqifonDlm3ermQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:25:09 INFO - Fetch https://queue.taskcluster.net/v1/task/CKfA2UZ-TqifonDlm3ermQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 13:25:10 INFO - Expected file size: 52508172 13:25:10 INFO - Obtained file size: 52508172 13:25:26 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:25:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CKfA2UZ-TqifonDlm3ermQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 13:25:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CKfA2UZ-TqifonDlm3ermQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:25:26 INFO - Fetch https://queue.taskcluster.net/v1/task/CKfA2UZ-TqifonDlm3ermQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 13:25:28 INFO - Expected file size: 52508172 13:25:28 INFO - Obtained file size: 52508172 13:25:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CKfA2UZ-TqifonDlm3ermQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 13:25:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CKfA2UZ-TqifonDlm3ermQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:25:44 INFO - Fetch https://queue.taskcluster.net/v1/task/CKfA2UZ-TqifonDlm3ermQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 13:25:45 INFO - Expected file size: 14404171 13:25:45 INFO - Obtained file size: 14404171 13:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:25:45 INFO - trying https://queue.taskcluster.net/v1/task/CKfA2UZ-TqifonDlm3ermQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 13:25:45 INFO - Downloading https://queue.taskcluster.net/v1/task/CKfA2UZ-TqifonDlm3ermQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 13:25:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CKfA2UZ-TqifonDlm3ermQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 13:25:47 INFO - Downloaded 75558709 bytes. 13:25:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CKfA2UZ-TqifonDlm3ermQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 13:25:47 INFO - mkdir: /builds/slave/test/properties 13:25:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:25:47 INFO - Writing to file /builds/slave/test/properties/build_url 13:25:47 INFO - Contents: 13:25:47 INFO - build_url:https://queue.taskcluster.net/v1/task/CKfA2UZ-TqifonDlm3ermQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 13:25:48 INFO - Running post-action listener: _resource_record_post_action 13:25:48 INFO - Running post-action listener: set_extra_try_arguments 13:25:48 INFO - [mozharness: 2017-03-29 20:25:48.424614Z] Finished download-and-extract step (success) 13:25:48 INFO - [mozharness: 2017-03-29 20:25:48.424762Z] Running populate-webroot step. 13:25:48 INFO - Running pre-action listener: _resource_record_pre_action 13:25:48 INFO - Running main action method: populate_webroot 13:25:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:25:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:25:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:25:48 INFO - '--tppagecycles', 13:25:48 INFO - '7'], 13:25:48 INFO - 'tests': ['tsvgm']}}, 13:25:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:25:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:25:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:25:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:25:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:25:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:25:48 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:25:48 INFO - 'talos_options': ['--disable-e10s'], 13:25:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:25:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:25:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:25:48 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:25:48 INFO - 'talos_options': ['--disable-e10s'], 13:25:48 INFO - 'tests': ['damp', 'tps']}, 13:25:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:25:48 INFO - 'tests': ['damp', 'tps']}, 13:25:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:25:48 INFO - 'tests': ['dromaeo_dom']}, 13:25:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:25:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:25:48 INFO - 'tests': ['basic_compositor_video']}, 13:25:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:25:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:25:48 INFO - 'tests': ['a11yr', 13:25:48 INFO - 'ts_paint', 13:25:48 INFO - 'tpaint', 13:25:48 INFO - 'sessionrestore', 13:25:48 INFO - 'sessionrestore_no_auto_restore', 13:25:48 INFO - 'tabpaint']}, 13:25:48 INFO - 'other-e10s': {'tests': ['a11yr', 13:25:48 INFO - 'ts_paint', 13:25:48 INFO - 'tpaint', 13:25:48 INFO - 'sessionrestore', 13:25:48 INFO - 'sessionrestore_no_auto_restore', 13:25:48 INFO - 'tabpaint']}, 13:25:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:25:48 INFO - 'ts_paint', 13:25:48 INFO - 'tpaint', 13:25:48 INFO - 'sessionrestore', 13:25:48 INFO - 'sessionrestore_no_auto_restore', 13:25:48 INFO - 'tabpaint']}, 13:25:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:25:48 INFO - 'ts_paint', 13:25:48 INFO - 'tpaint', 13:25:48 INFO - 'sessionrestore', 13:25:48 INFO - 'sessionrestore_no_auto_restore', 13:25:48 INFO - 'tabpaint']}, 13:25:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:25:48 INFO - 'tests': ['a11yr', 13:25:48 INFO - 'ts_paint', 13:25:48 INFO - 'tpaint', 13:25:48 INFO - 'sessionrestore', 13:25:48 INFO - 'sessionrestore_no_auto_restore', 13:25:48 INFO - 'tabpaint']}, 13:25:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:25:48 INFO - 'tests': ['a11yr', 13:25:48 INFO - 'ts_paint', 13:25:48 INFO - 'tpaint', 13:25:48 INFO - 'sessionrestore', 13:25:48 INFO - 'sessionrestore_no_auto_restore', 13:25:48 INFO - 'tabpaint']}, 13:25:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:25:48 INFO - 'tests': ['tsvgx', 13:25:48 INFO - 'tsvgr_opacity', 13:25:48 INFO - 'tart', 13:25:48 INFO - 'tscrollx', 13:25:48 INFO - 'cart', 13:25:48 INFO - 'tsvg_static']}, 13:25:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:25:48 INFO - 'tsvgr_opacity', 13:25:48 INFO - 'tart', 13:25:48 INFO - 'tscrollx', 13:25:48 INFO - 'cart', 13:25:48 INFO - 'tsvg_static']}, 13:25:48 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:25:48 INFO - 'talos_options': ['--disable-e10s'], 13:25:48 INFO - 'tests': ['tp5o']}, 13:25:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:25:48 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:25:48 INFO - 'talos_options': ['--disable-e10s', 13:25:48 INFO - '--xperf_path', 13:25:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:25:48 INFO - 'tests': ['tp5n']}, 13:25:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:25:48 INFO - 'talos_options': ['--xperf_path', 13:25:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:25:48 INFO - 'tests': ['tp5n']}}, 13:25:48 INFO - 'talos.zip': {'path': '', 13:25:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:25:48 INFO - Running post-action listener: _resource_record_post_action 13:25:48 INFO - [mozharness: 2017-03-29 20:25:48.443135Z] Finished populate-webroot step (success) 13:25:48 INFO - [mozharness: 2017-03-29 20:25:48.443266Z] Running create-virtualenv step. 13:25:48 INFO - Running pre-action listener: _resource_record_pre_action 13:25:48 INFO - Running main action method: create_virtualenv 13:25:48 INFO - Creating virtualenv /builds/slave/test/build/venv 13:25:48 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 13:25:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:25:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:25:48 INFO - Using real prefix '/tools/python27' 13:25:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:25:49 INFO - Installing distribute.............................................................................................................................................................................................done. 13:25:52 INFO - Installing pip.................done. 13:25:52 INFO - Return code: 0 13:25:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:25:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:25:52 INFO - Reading from file tmpfile_stdout 13:25:52 INFO - Output received: 13:25:52 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) 13:25:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:25:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1023c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f5359ab70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021a0d30>, '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 0x1020c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102195be8>, '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.xnir6frvva/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.J046t1PGVe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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 13:25:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:25:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:25:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xnir6frvva/Render', 13:25:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:25:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:25:52 INFO - 'HOME': '/Users/cltbld', 13:25:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:25:52 INFO - 'LOGNAME': 'cltbld', 13:25:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:52 INFO - 'MOZ_NO_REMOTE': '1', 13:25:52 INFO - 'NO_EM_RESTART': '1', 13:25:52 INFO - 'PAGER': '/bin/cat', 13:25:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:25:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:52 INFO - 'PWD': '/builds/slave/test', 13:25:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:25:52 INFO - 'SHELL': '/bin/bash', 13:25:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J046t1PGVe/Listeners', 13:25:52 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 13:25:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:25:52 INFO - 'USER': 'cltbld', 13:25:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:25:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:25:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:52 INFO - 'XPC_FLAGS': '0x0', 13:25:52 INFO - 'XPC_SERVICE_NAME': '0', 13:25:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:25:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:52 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 13:25:52 INFO - Cleaning up... 13:25:52 INFO - Return code: 0 13:25:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:25:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1023c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f5359ab70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021a0d30>, '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 0x1020c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102195be8>, '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.xnir6frvva/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.J046t1PGVe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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 13:25:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:25:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:25:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xnir6frvva/Render', 13:25:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:25:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:25:52 INFO - 'HOME': '/Users/cltbld', 13:25:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:25:52 INFO - 'LOGNAME': 'cltbld', 13:25:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:52 INFO - 'MOZ_NO_REMOTE': '1', 13:25:52 INFO - 'NO_EM_RESTART': '1', 13:25:52 INFO - 'PAGER': '/bin/cat', 13:25:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:25:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:52 INFO - 'PWD': '/builds/slave/test', 13:25:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:25:52 INFO - 'SHELL': '/bin/bash', 13:25:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J046t1PGVe/Listeners', 13:25:52 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 13:25:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:25:52 INFO - 'USER': 'cltbld', 13:25:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:25:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:25:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:52 INFO - 'XPC_FLAGS': '0x0', 13:25:52 INFO - 'XPC_SERVICE_NAME': '0', 13:25:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:25:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:52 INFO - Downloading/unpacking psutil>=3.1.1 13:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:25:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:25:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:25:56 INFO - Installing collected packages: psutil 13:25:56 INFO - Running setup.py install for psutil 13:25:56 INFO - building 'psutil._psutil_osx' extension 13:25:56 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 13:25:56 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 13:25:56 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 13:25:56 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 13:25:56 INFO - building 'psutil._psutil_posix' extension 13:25:56 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 13:25:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:25:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:25:57 INFO - ^ 13:25:57 INFO - 1 warning generated. 13:25:57 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 13:25:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:25:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:25:57 INFO - Successfully installed psutil 13:25:57 INFO - Cleaning up... 13:25:57 INFO - Return code: 0 13:25:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:25:57 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')]} 13:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:57 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')]} 13:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:57 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 0x1023c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f5359ab70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021a0d30>, '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 0x1020c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102195be8>, '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.xnir6frvva/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.J046t1PGVe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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 13:25:57 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 13:25:57 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 13:25:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xnir6frvva/Render', 13:25:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:25:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:25:57 INFO - 'HOME': '/Users/cltbld', 13:25:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:25:57 INFO - 'LOGNAME': 'cltbld', 13:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:57 INFO - 'MOZ_NO_REMOTE': '1', 13:25:57 INFO - 'NO_EM_RESTART': '1', 13:25:57 INFO - 'PAGER': '/bin/cat', 13:25:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:57 INFO - 'PWD': '/builds/slave/test', 13:25:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:25:57 INFO - 'SHELL': '/bin/bash', 13:25:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J046t1PGVe/Listeners', 13:25:57 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 13:25:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:25:57 INFO - 'USER': 'cltbld', 13:25:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:25:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:57 INFO - 'XPC_FLAGS': '0x0', 13:25:57 INFO - 'XPC_SERVICE_NAME': '0', 13:25:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:25:57 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 13:25:57 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 13:25:57 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 13:25:57 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 13:25:57 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 13:25:57 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 13:26:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:26:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:26:00 INFO - Installing collected packages: mozsystemmonitor 13:26:00 INFO - Running setup.py install for mozsystemmonitor 13:26:00 INFO - Successfully installed mozsystemmonitor 13:26:00 INFO - Cleaning up... 13:26:00 INFO - Return code: 0 13:26:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:26:00 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')]} 13:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:00 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')]} 13:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:00 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 0x1023c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f5359ab70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021a0d30>, '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 0x1020c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102195be8>, '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.xnir6frvva/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.J046t1PGVe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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 13:26:00 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 13:26:00 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 13:26:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xnir6frvva/Render', 13:26:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:00 INFO - 'HOME': '/Users/cltbld', 13:26:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:00 INFO - 'LOGNAME': 'cltbld', 13:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:00 INFO - 'MOZ_NO_REMOTE': '1', 13:26:00 INFO - 'NO_EM_RESTART': '1', 13:26:00 INFO - 'PAGER': '/bin/cat', 13:26:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:00 INFO - 'PWD': '/builds/slave/test', 13:26:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:00 INFO - 'SHELL': '/bin/bash', 13:26:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J046t1PGVe/Listeners', 13:26:00 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 13:26:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:00 INFO - 'USER': 'cltbld', 13:26:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:00 INFO - 'XPC_FLAGS': '0x0', 13:26:00 INFO - 'XPC_SERVICE_NAME': '0', 13:26:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:00 INFO - Downloading/unpacking jsonschema==2.5.1 13:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:26:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:04 INFO - Downloading functools32-3.2.3-2.tar.gz 13:26:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:26:04 INFO - warning: no files found matching '*.txt' 13:26:04 INFO - no previously-included directories found matching 'build' 13:26:04 INFO - no previously-included directories found matching 'dist' 13:26:04 INFO - no previously-included directories found matching '.git*' 13:26:04 INFO - Installing collected packages: jsonschema, functools32 13:26:04 INFO - Running setup.py install for functools32 13:26:04 INFO - warning: no files found matching '*.txt' 13:26:04 INFO - no previously-included directories found matching 'build' 13:26:04 INFO - no previously-included directories found matching 'dist' 13:26:04 INFO - no previously-included directories found matching '.git*' 13:26:04 INFO - Successfully installed jsonschema functools32 13:26:04 INFO - Cleaning up... 13:26:04 INFO - Return code: 0 13:26:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:26:04 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')]} 13:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1023c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f5359ab70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021a0d30>, '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 0x1020c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102195be8>, '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.xnir6frvva/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.J046t1PGVe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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 13:26:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:26:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xnir6frvva/Render', 13:26:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:05 INFO - 'HOME': '/Users/cltbld', 13:26:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:05 INFO - 'LOGNAME': 'cltbld', 13:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:05 INFO - 'MOZ_NO_REMOTE': '1', 13:26:05 INFO - 'NO_EM_RESTART': '1', 13:26:05 INFO - 'PAGER': '/bin/cat', 13:26:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:05 INFO - 'PWD': '/builds/slave/test', 13:26:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:05 INFO - 'SHELL': '/bin/bash', 13:26:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J046t1PGVe/Listeners', 13:26:05 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 13:26:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:05 INFO - 'USER': 'cltbld', 13:26:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:05 INFO - 'XPC_FLAGS': '0x0', 13:26:05 INFO - 'XPC_SERVICE_NAME': '0', 13:26:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:26:05 INFO - Cleaning up... 13:26:05 INFO - Return code: 0 13:26:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1023c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f5359ab70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021a0d30>, '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 0x1020c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102195be8>, '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.xnir6frvva/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.J046t1PGVe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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 13:26:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:26:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xnir6frvva/Render', 13:26:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:05 INFO - 'HOME': '/Users/cltbld', 13:26:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:05 INFO - 'LOGNAME': 'cltbld', 13:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:05 INFO - 'MOZ_NO_REMOTE': '1', 13:26:05 INFO - 'NO_EM_RESTART': '1', 13:26:05 INFO - 'PAGER': '/bin/cat', 13:26:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:05 INFO - 'PWD': '/builds/slave/test', 13:26:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:05 INFO - 'SHELL': '/bin/bash', 13:26:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J046t1PGVe/Listeners', 13:26:05 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 13:26:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:05 INFO - 'USER': 'cltbld', 13:26:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:05 INFO - 'XPC_FLAGS': '0x0', 13:26:05 INFO - 'XPC_SERVICE_NAME': '0', 13:26:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:05 INFO - Downloading/unpacking blobuploader==1.2.4 13:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:08 INFO - Downloading blobuploader-1.2.4.tar.gz 13:26:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:26:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:26:08 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 13:26:08 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 13:26:08 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 13:26:08 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 13:26:08 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 13:26:08 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 13:26:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:26:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:26:08 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 13:26:08 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 13:26:08 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 13:26:08 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 13:26:08 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 13:26:08 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 13:26:09 INFO - Downloading docopt-0.6.1.tar.gz 13:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:26:09 INFO - Installing collected packages: blobuploader, requests, docopt 13:26:09 INFO - Running setup.py install for blobuploader 13:26:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:26:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:26:09 INFO - Running setup.py install for requests 13:26:10 INFO - Running setup.py install for docopt 13:26:10 INFO - Successfully installed blobuploader requests docopt 13:26:10 INFO - Cleaning up... 13:26:10 INFO - Return code: 0 13:26:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:10 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 0x1023c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f5359ab70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021a0d30>, '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 0x1020c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102195be8>, '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.xnir6frvva/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.J046t1PGVe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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 13:26:10 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 13:26:10 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 13:26:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xnir6frvva/Render', 13:26:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:10 INFO - 'HOME': '/Users/cltbld', 13:26:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:10 INFO - 'LOGNAME': 'cltbld', 13:26:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:10 INFO - 'MOZ_NO_REMOTE': '1', 13:26:10 INFO - 'NO_EM_RESTART': '1', 13:26:10 INFO - 'PAGER': '/bin/cat', 13:26:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:10 INFO - 'PWD': '/builds/slave/test', 13:26:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:10 INFO - 'SHELL': '/bin/bash', 13:26:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J046t1PGVe/Listeners', 13:26:10 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 13:26:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:10 INFO - 'USER': 'cltbld', 13:26:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:10 INFO - 'XPC_FLAGS': '0x0', 13:26:10 INFO - 'XPC_SERVICE_NAME': '0', 13:26:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:26:10 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-TYjdj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:26:10 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-VMhjJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:26:10 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-z9r5YR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:26:10 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-VivDgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:26:11 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-blTOhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:26:11 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-kYVOn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:26:11 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-fhaOtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:26:11 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-YFdUb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:26:11 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-atHU_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:26:11 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-1KF1Cf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:26:11 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-YbZBW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:26:11 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-hxZ8WM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:26:11 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-dTV8hM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:26:12 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-c4JEvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:12 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-TioIXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:26:12 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-6q1IX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:26:12 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-8VWcWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:26:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:26:12 INFO - Running setup.py install for manifestparser 13:26:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:26:12 INFO - Running setup.py install for mozcrash 13:26:12 INFO - Running setup.py install for mozdebug 13:26:12 INFO - Running setup.py install for mozdevice 13:26:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:26:12 INFO - Running setup.py install for mozfile 13:26:13 INFO - Running setup.py install for mozhttpd 13:26:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:26:13 INFO - Running setup.py install for mozinfo 13:26:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:26:13 INFO - Running setup.py install for mozInstall 13:26:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:26:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:26:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:26:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:26:13 INFO - Running setup.py install for mozleak 13:26:13 INFO - Running setup.py install for mozlog 13:26:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:26:13 INFO - Running setup.py install for moznetwork 13:26:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:26:14 INFO - Running setup.py install for mozprocess 13:26:14 INFO - Running setup.py install for mozprofile 13:26:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:26:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:26:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:26:14 INFO - Running setup.py install for mozrunner 13:26:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:26:14 INFO - Running setup.py install for mozscreenshot 13:26:14 INFO - Running setup.py install for moztest 13:26:14 INFO - Running setup.py install for mozversion 13:26:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:26:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:26:14 INFO - Cleaning up... 13:26:14 INFO - Return code: 0 13:26:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:26:14 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')]} 13:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:14 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')]} 13:26:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:14 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 0x1023c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f5359ab70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021a0d30>, '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 0x1020c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102195be8>, '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.xnir6frvva/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.J046t1PGVe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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 13:26:14 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 13:26:14 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 13:26:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xnir6frvva/Render', 13:26:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:14 INFO - 'HOME': '/Users/cltbld', 13:26:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:14 INFO - 'LOGNAME': 'cltbld', 13:26:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:14 INFO - 'MOZ_NO_REMOTE': '1', 13:26:14 INFO - 'NO_EM_RESTART': '1', 13:26:14 INFO - 'PAGER': '/bin/cat', 13:26:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:14 INFO - 'PWD': '/builds/slave/test', 13:26:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:14 INFO - 'SHELL': '/bin/bash', 13:26:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J046t1PGVe/Listeners', 13:26:14 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 13:26:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:14 INFO - 'USER': 'cltbld', 13:26:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:14 INFO - 'XPC_FLAGS': '0x0', 13:26:14 INFO - 'XPC_SERVICE_NAME': '0', 13:26:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:26:15 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-nrLkNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:26:15 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)) 13:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:26:15 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-AymHXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:26:15 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)) 13:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:26:15 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-WDarU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:26:15 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)) 13:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:26:15 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-CkRdac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:26:15 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)) 13:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:26:15 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-bvZi23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:26:15 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)) 13:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:26:15 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-pcfyDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:26:15 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)) 13:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:26:15 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-0_eNov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:26:15 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)) 13:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:26:15 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-5W5W60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:26:16 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)) 13:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:26:16 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-IzQ2u1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:26:16 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)) 13:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:26:16 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-ETuvqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:26:16 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)) 13:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:26:16 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-kWIT0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:26:16 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)) 13:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:26:16 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-eKYpPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:26:16 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)) 13:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:26:16 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-ogFpx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:26:16 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)) 13:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:26:16 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-SMRJjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:26:16 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)) 13:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:16 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-oQP6Ir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:16 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)) 13:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:26:16 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-E6WCxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:26:16 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)) 13:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:26:16 INFO - Running setup.py (path:/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/pip-zyfzt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:26:17 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)) 13:26:17 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)) 13:26:17 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)) 13:26:17 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)) 13:26:17 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)) 13:26:17 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)) 13:26:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:19 INFO - Downloading blessings-1.6.tar.gz 13:26:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:26:19 INFO - Installing collected packages: blessings 13:26:19 INFO - Running setup.py install for blessings 13:26:19 INFO - Successfully installed blessings 13:26:19 INFO - Cleaning up... 13:26:20 INFO - Return code: 0 13:26:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:26:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:26:20 INFO - Reading from file tmpfile_stdout 13:26:20 INFO - Current package versions: 13:26:20 INFO - blessings == 1.6 13:26:20 INFO - blobuploader == 1.2.4 13:26:20 INFO - docopt == 0.6.1 13:26:20 INFO - functools32 == 3.2.3-2 13:26:20 INFO - jsonschema == 2.5.1 13:26:20 INFO - manifestparser == 1.1 13:26:20 INFO - mozInstall == 1.12 13:26:20 INFO - mozcrash == 1.0 13:26:20 INFO - mozdebug == 0.1 13:26:20 INFO - mozdevice == 0.49 13:26:20 INFO - mozfile == 1.2 13:26:20 INFO - mozhttpd == 0.7 13:26:20 INFO - mozinfo == 0.9 13:26:20 INFO - mozleak == 0.1 13:26:20 INFO - mozlog == 3.4 13:26:20 INFO - moznetwork == 0.27 13:26:20 INFO - mozprocess == 0.25 13:26:20 INFO - mozprofile == 0.28 13:26:20 INFO - mozrunner == 6.13 13:26:20 INFO - mozscreenshot == 0.1 13:26:20 INFO - mozsystemmonitor == 0.3 13:26:20 INFO - moztest == 0.8 13:26:20 INFO - mozversion == 1.4 13:26:20 INFO - psutil == 3.1.1 13:26:20 INFO - requests == 1.2.3 13:26:20 INFO - wsgiref == 0.1.2 13:26:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:20 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 0x1023c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f5359ab70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021a0d30>, '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 0x1020c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102195be8>, '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.xnir6frvva/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.J046t1PGVe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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 13:26:20 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 13:26:20 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 13:26:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xnir6frvva/Render', 13:26:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:20 INFO - 'HOME': '/Users/cltbld', 13:26:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:20 INFO - 'LOGNAME': 'cltbld', 13:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:20 INFO - 'MOZ_NO_REMOTE': '1', 13:26:20 INFO - 'NO_EM_RESTART': '1', 13:26:20 INFO - 'PAGER': '/bin/cat', 13:26:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:20 INFO - 'PWD': '/builds/slave/test', 13:26:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:20 INFO - 'SHELL': '/bin/bash', 13:26:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J046t1PGVe/Listeners', 13:26:20 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 13:26:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:20 INFO - 'USER': 'cltbld', 13:26:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:20 INFO - 'XPC_FLAGS': '0x0', 13:26:20 INFO - 'XPC_SERVICE_NAME': '0', 13:26:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:20 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)) 13:26:20 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)) 13:26:20 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)) 13:26:20 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)) 13:26:20 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)) 13:26:20 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)) 13:26:20 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)) 13:26:20 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)) 13:26:20 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)) 13:26:20 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)) 13:26:20 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)) 13:26:20 INFO - Cleaning up... 13:26:20 INFO - Return code: 0 13:26:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1023c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f5359ab70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021a0d30>, '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 0x1020c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102195be8>, '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.xnir6frvva/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.J046t1PGVe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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 13:26:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:26:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xnir6frvva/Render', 13:26:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:20 INFO - 'HOME': '/Users/cltbld', 13:26:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:20 INFO - 'LOGNAME': 'cltbld', 13:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:20 INFO - 'MOZ_NO_REMOTE': '1', 13:26:20 INFO - 'NO_EM_RESTART': '1', 13:26:20 INFO - 'PAGER': '/bin/cat', 13:26:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:20 INFO - 'PWD': '/builds/slave/test', 13:26:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:20 INFO - 'SHELL': '/bin/bash', 13:26:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J046t1PGVe/Listeners', 13:26:20 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 13:26:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:20 INFO - 'USER': 'cltbld', 13:26:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:20 INFO - 'XPC_FLAGS': '0x0', 13:26:20 INFO - 'XPC_SERVICE_NAME': '0', 13:26:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:26:20 INFO - Cleaning up... 13:26:20 INFO - Return code: 0 13:26:20 INFO - Running post-action listener: _resource_record_post_action 13:26:20 INFO - Running post-action listener: _start_resource_monitoring 13:26:20 INFO - Starting resource monitoring. 13:26:20 INFO - [mozharness: 2017-03-29 20:26:20.870625Z] Finished create-virtualenv step (success) 13:26:20 INFO - [mozharness: 2017-03-29 20:26:20.871589Z] Running install step. 13:26:20 INFO - Running pre-action listener: _resource_record_pre_action 13:26:20 INFO - Running main action method: install 13:26:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:26:21 INFO - Reading from file tmpfile_stdout 13:26:21 INFO - Detecting whether we're running mozinstall >=1.0... 13:26:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:26:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:26:21 INFO - Reading from file tmpfile_stdout 13:26:21 INFO - Output received: 13:26:21 INFO - Usage: mozinstall [options] installer 13:26:21 INFO - Options: 13:26:21 INFO - -h, --help show this help message and exit 13:26:21 INFO - -d DEST, --destination=DEST 13:26:21 INFO - Directory to install application into. [default: 13:26:21 INFO - "/builds/slave/test"] 13:26:21 INFO - --app=APP Application being installed. [default: firefox] 13:26:21 INFO - mkdir: /builds/slave/test/build/application 13:26:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:26:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:26:41 INFO - Reading from file tmpfile_stdout 13:26:41 INFO - Output received: 13:26:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:26:41 INFO - Running post-action listener: _resource_record_post_action 13:26:41 INFO - [mozharness: 2017-03-29 20:26:41.764971Z] Finished install step (success) 13:26:41 INFO - [mozharness: 2017-03-29 20:26:41.765104Z] Running run-tests step. 13:26:41 INFO - Running pre-action listener: _resource_record_pre_action 13:26:41 INFO - Running main action method: run_tests 13:26:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:26:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:26:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:26:41 INFO - 2017-03-29 13:26:41.779 screenresolution[2077:16465] starting screenresolution argv=screenresolution get 13:26:41 INFO - 2017-03-29 13:26:41.782 screenresolution[2077:16465] Display 0: 1600x1200x32@60 13:26:41 INFO - 2017-03-29 13:26:41.788 screenresolution[2078:16467] starting screenresolution argv=screenresolution list 13:26:41 INFO - Available Modes on Display 0 13:26:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:26:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:26:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:26:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:26:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:26:42 INFO - Intel Iris: 13:26:42 INFO - Chipset Model: Intel Iris 13:26:42 INFO - Type: GPU 13:26:42 INFO - Bus: Built-In 13:26:42 INFO - VRAM (Dynamic, Max): 1536 MB 13:26:42 INFO - Vendor: Intel (0x8086) 13:26:42 INFO - Device ID: 0x0a2e 13:26:42 INFO - Revision ID: 0x0009 13:26:42 INFO - Displays: 13:26:42 INFO - Display: 13:26:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:26:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:26:42 INFO - Display Serial Number: 1600x1200 60 13:26:42 INFO - Main Display: Yes 13:26:42 INFO - Mirror: Off 13:26:42 INFO - Online: Yes 13:26:42 INFO - Rotation: Supported 13:26:42 INFO - Return code: 0 13:26:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:26:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:26:42 INFO - Python 2.7.3 13:26:42 INFO - Return code: 0 13:26:42 INFO - grabbing minidump binary from tooltool 13:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:42 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 0x1021a0d30>, '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 0x1020c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102195be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:26:42 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 13:26:42 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 13:26:42 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 13:26:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:26:42 INFO - Return code: 0 13:26:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:26:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:26:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:26:42 INFO - ENV: RUST_BACKTRACE is now 1 13:26:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:26:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:26:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CKfA2UZ-TqifonDlm3ermQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0302', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:26:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CKfA2UZ-TqifonDlm3ermQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0302 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:26:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xnir6frvva/Render', 13:26:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:42 INFO - 'HOME': '/Users/cltbld', 13:26:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:42 INFO - 'LOGNAME': 'cltbld', 13:26:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:26:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:42 INFO - 'MOZ_NO_REMOTE': '1', 13:26:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:26:42 INFO - 'NO_EM_RESTART': '1', 13:26:42 INFO - 'PAGER': '/bin/cat', 13:26:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:42 INFO - 'PWD': '/builds/slave/test', 13:26:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:26:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:42 INFO - 'RUST_BACKTRACE': '1', 13:26:42 INFO - 'SHELL': '/bin/bash', 13:26:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J046t1PGVe/Listeners', 13:26:42 INFO - 'TMPDIR': '/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/', 13:26:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:42 INFO - 'USER': 'cltbld', 13:26:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:42 INFO - 'XPC_FLAGS': '0x0', 13:26:42 INFO - 'XPC_SERVICE_NAME': '0', 13:26:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CKfA2UZ-TqifonDlm3ermQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0302', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:26:42 INFO - mozversion application_buildid: 20170329112223 13:26:42 INFO - mozversion application_changeset: 4c7c05a49f3ce40aa0969beccb397380a8907f4a 13:26:42 INFO - mozversion application_display_name: Nightly 13:26:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:26:42 INFO - mozversion application_name: Firefox 13:26:42 INFO - mozversion application_remotingname: firefox 13:26:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:26:42 INFO - mozversion application_vendor: Mozilla 13:26:42 INFO - mozversion application_version: 55.0a1 13:26:42 INFO - mozversion platform_buildid: 20170329112223 13:26:42 INFO - mozversion platform_changeset: 4c7c05a49f3ce40aa0969beccb397380a8907f4a 13:26:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:26:42 INFO - mozversion platform_version: 55.0a1 13:26:42 INFO - using testdate: 1490819202 13:26:42 INFO - actual date: 1490819202 13:26:42 INFO - starting webserver on 'localhost:53448' 13:26:42 INFO - SUITE-START | Running 2 tests 13:26:42 INFO - TEST-START | dromaeo_css 13:26:42 INFO - operating with platform_type : mac_ 13:26:42 INFO - Initialising browser for dromaeo_css test... 13:26:42 INFO - TEST-INFO | started process 2088 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/tmpMoYAO9/profile http://localhost:53448/getInfo.html) 13:26:45 INFO - PID 2088 | __metrics Screen width/height:1600/1200 13:26:45 INFO - PID 2088 | colorDepth:24 13:26:45 INFO - PID 2088 | Browser inner width/height: 1024/689 13:26:45 INFO - PID 2088 | __metrics 13:26:45 ERROR - PID 2088 | 1490819205065 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 13:26:45 INFO - PID 2088 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:26:45 INFO - PID 2088 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:26:45 INFO - TEST-INFO | 2088: exit 0 13:26:45 INFO - Browser initialized. 13:26:45 INFO - Running cycle 1/1 for dromaeo_css test... 13:26:45 INFO - TEST-INFO | started process 2090 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/tmpMoYAO9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:26:57 INFO - PID 2090 | RSS: Main: 234471424 13:26:57 INFO - PID 2090 | 13:30:03 INFO - PID 2090 | Cycle 1(1): loaded http://localhost:53448/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53448/tests/dromaeo/cssquery-ext.html) 13:30:05 INFO - PID 2090 | RSS: Main: 432340992 13:30:05 INFO - PID 2090 | 13:31:48 INFO - PID 2090 | ************************* 13:31:48 INFO - PID 2090 | A coding exception was thrown and uncaught in a Task. 13:31:48 INFO - PID 2090 | 13:31:48 ERROR - PID 2090 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:31:48 INFO - PID 2090 | Full stack: 13:31:48 INFO - PID 2090 | ************************* 13:31:48 INFO - PID 2090 | ************************* 13:31:48 INFO - PID 2090 | A coding exception was thrown and uncaught in a Task. 13:31:48 INFO - PID 2090 | 13:31:48 ERROR - PID 2090 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:31:48 INFO - PID 2090 | Full stack: 13:31:48 INFO - PID 2090 | ************************* 13:31:48 INFO - PID 2090 | ************************* 13:31:48 INFO - PID 2090 | A coding exception was thrown and uncaught in a Task. 13:31:48 INFO - PID 2090 | 13:31:48 ERROR - PID 2090 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:31:48 INFO - PID 2090 | Full stack: 13:31:48 INFO - PID 2090 | ************************* 13:31:48 INFO - PID 2090 | ************************* 13:31:48 INFO - PID 2090 | A coding exception was thrown and uncaught in a Task. 13:31:48 INFO - PID 2090 | 13:31:48 ERROR - PID 2090 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:31:48 INFO - PID 2090 | Full stack: 13:31:48 INFO - PID 2090 | ************************* 13:33:08 INFO - PID 2090 | Cycle 1(1): loaded http://localhost:53448/tests/dromaeo/cssquery-ext.html (next: http://localhost:53448/tests/dromaeo/cssquery-jquery.html) 13:33:09 INFO - PID 2090 | RSS: Main: 370827264 13:33:09 INFO - PID 2090 | 13:36:11 INFO - PID 2090 | Cycle 1(1): loaded http://localhost:53448/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53448/tests/dromaeo/cssquery-mootools.html) 13:36:12 INFO - PID 2090 | RSS: Main: 330051584 13:36:12 INFO - PID 2090 | 13:39:15 INFO - PID 2090 | Cycle 1(1): loaded http://localhost:53448/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53448/tests/dromaeo/cssquery-prototype.html) 13:39:15 INFO - PID 2090 | RSS: Main: 329281536 13:39:15 INFO - PID 2090 | 13:42:19 INFO - PID 2090 | Cycle 1(1): loaded http://localhost:53448/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53448/tests/dromaeo/cssquery-yui.html) 13:42:19 INFO - PID 2090 | RSS: Main: 335822848 13:42:19 INFO - PID 2090 | 13:45:22 INFO - PID 2090 | Cycle 1(1): loaded http://localhost:53448/tests/dromaeo/cssquery-yui.html (next: http://localhost:53448/tests/dromaeo/cssquery-dojo.html) 13:45:23 INFO - PID 2090 | RSS: Main: 545624064 13:45:23 INFO - PID 2090 | 13:45:23 INFO - PID 2090 | __start_tp_report 13:45:23 INFO - PID 2090 | _x_x_mozilla_page_load 13:45:23 INFO - PID 2090 | _x_x_mozilla_page_load_details 13:45:23 INFO - PID 2090 | |i|pagename|runs| 13:45:23 INFO - PID 2090 | |0;dojo.html;3192.6009248843893;3501.6148223695404;3505.7545971781988;3534.3284775892585;3581.3195492856357;5060.41805192403;5984.04255319149;6041.1240370146415;6155.2613686357645;6184.845378865525;6109.526129009815;6148.200733904598;6202.596831205969;6206.472449841769;6239.688015599225;5093;5473.8357849264585;5517.282753242073;5593.608447408683;5599.160125981095;5691.117876729093;5710.714464276791;5713.914291285634;5719.370869204384;5765.971170144165;5453.15476101205;5513.696746678931;5562.137868630329;5681.6022878398735;5685.886282274331;4638.2115040443205;5603.355614104389;5616.157576363578;5680.289963754531;5688.033034384164;5539.695316757577;5542.0855558832745;5545.667259964415;5556.86107847303;5560.110382338847;6041.818745437644;6187.319394866561;6192.225971753531;6194.1018552310115;6253.90556652584;6475.7733479328;6480.773172938924;6595.967020164869;6657.234418041939;6676.699548520328;6643.103181070542;6658.766943156967;6696;6696.196456425211;6733.158355205599;6220.066989951453;6283.560150789446;6284.183056202664;6313.273973493016;6318.462930650854;6640.269570347258;6738.427233685192;6743.190817101881;6792.87917493608;6822.044913712084;6484.351564843572;6488.0916671666;6502.479801615859;6503.8699226015215;6507.186601674791;6514;6643.5017373697165;6654.134962454947;6658.766943156967;6662.533622646368;6358.586691865014;6482.708278127401;6574.046763219307;6579.1447111876105;6579.703913323912;5673.921954828569;5852.824415267549;6004.819855404345;6458.935410645928;6466.094746735461;4966.404031516241;5254.605904557174;5263.0000299942885;5270.393904700932;5271.446498117719;4664.253719404879;4753.405824271966;4762.833300834454;4786.899013226977;4789.784459699322;5124.743762811844;5132.358455193101;6108.584917381041;6125.754381768298;6227.09707092469;6723.966380168165;6727.798166055026;6744.7976560703255;6757.358050985148;6779.220389655253;4661.720296782204;6151.6573060257915;6222.844428889223;6230.221222347207;6240.282367527701;5784.074548072288;5921.437463440966;5932.8813423732145;5938.465538101592;5970.34326224115;5725;6780.423663988616;6786.932130678729;6911.619860907497;6919.273476285119;6260.373962603703;6326.746930122744;6742.393184613408;6777.525573209828;6778.084958530535;6733.595984240961;6798.490113241428;6860.622665753432;6864.279250678607;6870.072540207008;6498.577592456664;6608.43828274602;6650.700718467584;6653.367930046637;6659.134312539339;6090;6492.902606461002;6580.539362244597;6595.538312318284;6642.368974947372;5300.7879684813715;6539.738410463528;6553.115329430466;6553.475721942138;6569.770058047945;6511.9348806511325;6522.934770652422;6523.510736694672;6528.21661400635;6531.183602049744;6186.845328866814;6364.140840986593;6381.298057213796;6425.261094974137;6444.613323200623;6274.121622972696;6347.111404403295;6363.6818159090935;6372.904406434;6386.425221730066;5277.419483856849;6252.187215662117;6255.874882502233;6266.342034086538;6269.404406581368 13:45:23 INFO - PID 2090 | |1;ext.html;797.489606651743;816.1675091406765;1132.6828488023357;1155.2086820527938;1158.1892675127413;36146.819265903665;36938.81530592347;36981;37086;37166.070848228774;38370;38716.41925371122;38812.61187388125;38863.80568097163;39003.804980975125;6035.486983606399;6220.657863817488;8465.957670211641;8602.139786021378;8602.18279263469;7193.712251509959;8307.875381869277;8491.915080849174;8534.78663033426;8548.87176692347;8588.785280367978;8639.870401943976;8642.222200002;8642.65429382824;8645.610947507346;8542.78643033926;8576.828463430758;8607.010193827728;8608.569571521399;8614.267787238092;8425.915740842574;8481.194286542768;8490.78773030673;8491.150884911522;8500.064992850781;36682;36809.263814723825;36855.81572092122;36864.078398039994;36874.262514749826;2949.8349638704826;2987.536931775578;2994.8802047918057;3016.0844583175867;3026.500627396477;26692.8665356672;26766;26786.598201027;27041.594376084373;27688.892444302204;2751.931201719953;2781.4576157649267;2791.288221503504;2810.2552823501787;2818.6335776349147;281918;285132;285168;285722;286692;38426.61573384231;39085;46107.538924611;47718.28422573664;47878.28182577264;50088.99822003539;50097.747556311384;50133.74933125311;50258.49741502611;50268.49731502638;10969.23215374916;11156.442177891073;12900.677483062811;12964.546240881524;13029.348532573333;8806.515641639771;8809.03100658927;8853.911460885438;8943.284537237005;9996.800063998679;12466;12501;12548.247105173536;12616.684582885502;12633;5214.869628259248;5222.451642577551;5236.790528378899;5250.553702935294;5251.553617942442;872.7425409504211;884.8628462588309;912.9497877616794;979.8628192052976;999.4453078541479;20659.17363305451;21821.890890545445;22733.658995115085;24084.87957560236;24150;1056.7780766039064;1059.2373491086405;1109.378747901162;1109.6615532262738;1111.8165502691966;10522.842157367646;11284.435778211056;12188.390580470941;12191.695207619881;12228.633141005606;408199;408875;409596;409972;410044;51982.960340792975;52055.47944520506;52150.956980860174;52152.21771673428;52248.738756305975;1450.311102226434;1468.5374107156213;1511.9697606048037;1512.296781996377;1522.3301747231183;23234.651480227472;23241.65137522905;23297.417564560343;23349.766502334758;23430.76569234354;37844.62155378521;37921;37958.24083518259;37962.62037379591;37974;392309;392876;393524;394014.0299298485;394441;32246.83876580602;32473.675263247063;33149.502757458176;33251;33294.16764580905;41587.75236742781;42026.78986605047;42266;42382.15235695207;42523.1495370097;23800.880995595602;27217.72782272231;29309;29726.30486624584;29918.803247870714;29750.10749677513;30021.849890750407;30029.3994120112;30162.944296949503;30207.546886797154;26772.866135669978;34610;34938.82530587331;35729.92810215698;35763.284734304645;28255.576166357932;29138.56292155577;30038.24904377408;30190.2452438682;30382.328971906758;21588.89205553962;22097;23664.408389789704;23795.371790197063;24001 13:45:23 INFO - PID 2090 | |2;jquery.html;386.89167033230706;399.7501561524047;414.264680192658;431.49299573001724;443.3682003145517;13606.659833504167;15537.84462155378;21774.564508709816;21816.781832181674;21877.343679689595;19515.5121121972;22345.44136396591;22412.551748965012;23528.529429411403;23824;5303.390110137345;5313.362396512424;6189.50483961282;6246.562740608159;6255.59338642989;3625.6011838697855;5180.481951804808;6195.783147589836;6196.752129914798;6209.16176316196;3856.8842934712;3898.5906479819637;6152.261728592575;6173.135760993465;6209.689515524228;5917.289925209003;6008.429199226067;6190.50475961922;6197.287311959138;6210.72051757672;4735.668503204777;5248;5449.863753406157;5529.640573362719;5532.917006244909;27522;28082.43835123286;28185.29536761577;28208.435831283463;28255.869765209365;1996.2152796848316;2005.2680771518437;2029.1883246701439;2048.057893369052;2073.0013886133615;15744.842551574568;16540.503784886474;16851.91574042122;17122.229499672543;17538;1659.4772646616277;1667.1080971680215;1668.7663727078218;1675.1707904587308;1706.0957692423035;135665.64334356628;144057;147084.40818285343;148230;149559;10024.849627255597;11977.58078467267;12051.216670916363;12118.03160704107;12141;16100.67798644044;16118.919405402898;16151.838481615034;16152.838471615369;16156.353745850269;8231.670733170726;8452.028016778026;8525.488470691778;8531.616077276538;8653.653853845775;6451.258160296694;7558.677231484578;7854.528728276322;8040.557769322743;8060.193980601893;6601.174853143357;7482.326590606763;7539.170691223961;7715.498492597963;7764;1836.4857839804877;2077.48316393729;2078.1998930411596;2090.581883623251;2233.6314508106307;879.9352783132354;893.1693525021662;908.7455512456522;930.6044930904474;939.154760715348;20420.693689594667;20438.28466003683;20474;20543.58912821735;20609.690854637192;861.8965724113147;862.8921384826897;878.5782824244399;976.6337623391229;987.4914419074182;9570.712878613653;9916.057974492413;10638.73403164927;10644.201684873666;10677.46612669379;703208;706117;710821;728804.3559782167;731651;154512;157121;157764;160362.1981890083;160696.19651901667;1154.2728081308721;1173.556525473672;1198.2091819399154;1202.032363947031;1205.6383085074442;15160.393584256506;16937.15314234308;17683.557911052325;18069.728954065962;18425.447236582924;59095.40904590899;59609;60114.49713757191;60290.69854650699;60310.095348570685;82175.17824821915;83501.58249208715;83568;85251;86232.56883715541;6277.905831412441;8350.08149103586;8485.151484851465;8604.48373097616;8862.512561809162;13308.800367994294;13461.528846490326;13509.392077356739;13893.30533473302;13962.860371396562;11569.479373428385;11597.88402115968;11760.823587646364;11917.821232681343;11990.640280791591;9191;9598.42409455435;10093.848592270975;10699.94650026745;11089.05743011853;11441.942790285995;11696.941515292368;11990.280583165038;12002.279863208236;12030.75938481208;8576.742697719079;8582.055973842747;8587.87118193215;8623.698170564001;8685.565721713763;11198.552057917592;11429.257098288585;12165.20926139798;12173.878261217274;12198.573049943565 13:45:23 INFO - PID 2090 | |3;mootools.html;1399.5941177058653;1466.691994681117;1467.809184805975;1488.8511148885107;1490.5230326295587;10569.78860422792;11040.834387484185;11051.17116216283;11063.612773552928;11065.336079835206;10721.410322432283;10818.404987725671;11128.61049863253;11142.888571114287;11162.832557511643;2472.9629055564137;2510.811689123314;2515.132279363617;2515.987420062897;2517.848929064253;2440.1337525178574;2462.347477918353;2472.9752702473015;2477.7274499805008;2478.0707234786955;2447.412620970963;2459.409741662006;2471.7404672509397;2492.513959777844;2497.1634502441702;2428.3564855313357;2443.7434069422634;2463.8275320727557;2464.137551856854;2488.377905523619;2029.725986991752;2430.2952143878256;2461.5323088613104;2463.064035666453;2467.4078221226955;10840.566377344896;11072.501737421835;11082.390468524229;11087.72280692981;11098.611548595842;6227.3772622737815;6477.676116194219;6483.22201335838;6485.962246040658;6490.675466226669;3993.860214892494;4060.4924384451942;4140.627343539096;4143;4194.790260486963;1170.6839153428612;1181.3384504677408;1199.9160058795887;1220.0239808153442;1244.4897591987333;14164.92917535416;14555.345009474599;14585.124892506483;15233.314500847488;15386.384544618202;5262.7631756571045;5405.8107966221;5456.154296084113;5467.72661366938;5484.506394424521;10255.230857685554;11499.425028748528;11528.36593987322;11550.653480395602;11555.711107222387;5337.066013447631;6123;6292.402221788922;6326.746930122836;6329.113924050636;5856.1508581255475;5898.439648233411;5915.438033386821;5948.762049518057;6010.068439391901;4143.124318402774;4189.601987811153;4233.370152491251;4262.190183865056;4265.168292183057;1239.9788344997596;1263.6082814327588;1275.8660340664283;1279.635303938373;1280.1487011137676;630.5806638585381;747.1855677311647;759.8024513626497;761.7828918758128;777.2771322669859;5655.688937108416;5755.8561035974435;5958.136070269787;5994.036875641923;6020.187274717857;568.0882184094469;579.9507041901401;582.4641329976432;583.1777194156305;598.796409220867;3957.56466788653;4010.47863777707;4030.1939612077704;4140.109876376593;4147.232761939051;11564.248323858923;13114.213147211198;14010.229437381042;14020.228887411085;14037.929810350883;13524.32378381077;13948.651283717785;14125.505607303696;14138;14167.858321416654;10112.443815590066;10389.324693894721;10399.376037437778;10412.271141020055;10445.895541044645;6321.652309123042;6581.440577550962;6784.491163162881;6798.694058767268;6818.556793808387;11734.354610496162;11832.230904991147;12966.935165324114;12974.416151273026;12991.960643148714;11433.1996760226;12388.380580970736;12427.813582796085;12710.68223294388;12858.807117893426;9049.32130090259;9072.818543629222;9279.62881484733;9296.860547091665;9299.02360252191;10185.287029907835;10192.541335639766;10302.536385862504;10302.742431439274;10332.483375831329;8520.74437766868;8689.435186712843;8733.126687331216;8743.956280218812;8795.296376289754;8381.832363352822;8454.196851299117;8497.57512124379;8571.142885711379;8610.225079742853;7617.847643047219;7821.217878212134;7821.960890195513;7834.099078606033;7834.76709137893;5243.842684719464;5723.341815691082;5891.410858914074;5918.704064796829;5932.190681841907;4707.905841883212;5480.972595136999;5493.533049690821;5522.944770552243;5555.583331250254 13:45:23 INFO - PID 2090 | |4;prototype.html;390.05800990607685;391.6494737210197;400.1836254041753;400.71749416661254;403.49764543143783;4806.399200099988;4951.3810773653295;5930.377310382407;5948.7620495180145;5951.256092988377;5553.305836770403;5716.28546431696;5767.452092051259;5873.207117039209;5884.2056322396575;4603.723776573416;4610.864612063795;4614.215583350821;4659.650526210539;4666.580007799297;4569.268916973285;4643.907121857561;4648.9767551162195;4661.277501987197;4689.2966055091665;3811.6378944000276;4424.8185016091575;4534.274516077428;4641.210994130989;4642.605378542828;3828.7511311764647;4517.751523666197;4541.613962813165;4542.136993971135;4593.816247350102;3320.335932813447;3638.6907112895437;3961;4094.396930700994;4140.37894315852;5006.07387633289;5298;5603.159526071081;5718.34239062509;5830.30036395631;5319.069162896478;5351.598630102758;5378.193271009341;5385.899499195317;5386.326709161355;4695.389599352096;6180.969095154541;6269.811905642838;6296.379581740517;6319.842003949892;3416.829158542063;3972.3842804365368;4160.895977600554;4165.562615925314;4520.977395113036;5597.608167428281;6339.968300158515;6589.17635295588;6590.637514936677;6600.669966501656;3639.8170594556873;4224.809883555247;4225.176090662353;4233.1956928183545;4236.6187043166265;4035.7780322082567;4282.850100246476;4302.505211900609;4418.823247070145;4421.513633500313;4233.534311225762;4732.485604606492;5158.432572417031;5218.712970786567;5246.501582349671;6422.80645676845;6430;6431.614103153825;6433;6463.1903067141275;1428.8142541469751;1499.3103172540536;1502.4966636176785;1507.186119495482;1520.6730552931174;816.6774124220899;949.8575213717997;967.6226271754022;1000.6347683095618;1001.7746007148479;5030.195168773052;5878.941210587925;5880.853743247342;5917.881642367129;5992.460678538952;5985.910211346833;6516.869662606721;6542.934570654328;6595.175603049619;6601.834954126185;5625.634333768292;5937.614055086492;5953.970230148821;5964.196827491072;5970.223870896755;2886.5381538953666;3128.9843550782102;3262.6737326267184;3418.880339188166;3460.7923524588605;6406.35936406365;6472.3204063573585;6745.06589633511;6754.290799466084;6813.557118787263;6786.846236139868;6791.558548694319;6814.591124532445;6831.487638427137;6833.760818371333;5650.378458369576;6078.6048906820915;6110.930587147232;6843.87839769673;6857.245702972669;5669.86602679474;6358.823617630753;6443.259025212161;6511.7395304189195;6514.771982980573;5402.297701298806;6459.967700161469;6502.219733631994;6529.836754081186;6552.148220731275;5573.804916827891;5796.710164491674;6473.676316184266;6810.182778066664;6882.793516194522;3820.4269359596283;3950.952997455734;4712.458067322302;4731.668783185144;4745.881352966066;6391.77628783009;6479.290529120473;6595.505337099833;6604.933950660624;6647.534672572873;6311.305756366704;6332.240131184103;6387.169667943138;6438.871222575616;6441.484681225397;5610.354809196994;6323.399277068671;6336.936630633819;6346.460550853045;6371.522135839923;5125.820596279113;5514.36584792754;6157.322694503511;6163.3836616338;6219.564630476004;6348.365163483615;6353.714082866374;6371.228515595731;6377.744890204525;6383.042543618494;5698.54411647059;5753.2520772301;5981.880362392815;6144.508439324933;6203.503719702503 13:45:23 INFO - PID 2090 | |5;yui.html;733.7725305155406;747.1855677311729;751.3125490176488;765.8774596064627;769.5651956644497;15324.540263792076;15615.687686246296;15842.84157158428;15877.96793208442;15894.523164305076;14413.279336033209;14579.19814410207;14629.561113166596;14675.192864392455;14690.485832995848;900.2932697832204;980.656770130454;1000.6697789729371;1016.7305663999047;1033.7725700345911;971.0629242780715;1007.3401921741234;1013.0983424751939;1019.6023550815188;1020.8468729690532;1076.3165389977341;1080.9891901081007;1082.182951871336;1087.4019289390842;1089.8310761831929;1070.7323169207698;1072.3940973350032;1073.812082885492;1075.2150929821196;1075.6074032977986;802.4984384759525;802.5224991130268;803.9035315762087;804.7545498622918;806.0045843383417;16070.517884463368;16245.675086498322;16446.75329870053;16648.916755416147;16925.57686057846;14606.561803145923;14680.779788303184;14715.307739609867;14746.70506589873;14833.554993350217;11615.651530454015;11732.17874748768;11886.346250956194;11946.880531194663;12212.32832194229;2988.2379993101836;3019.89430369936;3082.6763189864964;3084.6761090085665;3106.813591184536;110277.44861275642;114741.53733960037;114892;115329;118385.40807295995;10798.298110622783;11511.597094101666;11575.13186511015;11614.709632259091;11930.642080737593;25455.236342909742;25463.87268063648;25463.87268063685;25498.745012550007;25529.106481273066;7944.404169687296;7969.800754981172;8006.479578827474;8102.797430064295;8243.05204901444;3978.562358140602;4046.1705350403095;4049.4128351389472;4073.2668119738137;4090.9386359204636;4133.855315064018;4179.791010449465;4180.372944058355;4211.873643790691;4223.619874211336;820.118372749285;823.2714048067503;828.349745449819;850.7915560687547;852.3394369363668;542.2625229687621;553.808935917108;567.9687617181095;574.9798757043484;603.484021161909;9595.520223988773;10170.491475426199;10230.079292863678;10404.68785936423;10459.947700261602;541.6587549843653;564.5596434780878;588.690937257943;591.2727345365139;596.9612873599991;4080.775767269807;4145.54399016108;4533.569310915458;4696.178168820443;4772.188727916263;102752;103521.96478035123;104517.47741261245;106775.46612267045;109013;86846.13153868381;92996;93339.53330233306;94926;96031.03968960221;80727.19272807197;81363.18636813556;81670.73317067251;81973.59013204896;82937;9344.672936447192;9468.668596599086;9480.431174129575;9508.952455237679;9517.666881659108;35555.288894221456;37185;38719.225615488096;39080.41379379368;41153.971150720274;61274.4681382969;64717.67641161764;64835.67582162059;68663;70843.64578177076;10839.295445795999;11977.281363118242;12579.496820127093;13745.862541374858;13749.862501375259;12371.319577422968;14418.990670653373;14772;14964.700705986037;15635.60910977189;12266.570670026505;13481.460741570227;13742;13781.931090344484;14402;13623.591292261248;13732.65668358299;13863;13903.304834758019;13943.4422623098;13234.27211503338;13455.259960702255;14073;14092.224927629079;14296;9420.95289523548;9864.901350986685;9953.900460995297;9969.152622027208;10352.171826254033;8412.411131221;9097.545122743704;9926.255530835071;11315.660530184108;11425.31448113116 13:45:23 INFO - PID 2090 | __end_tp_report 13:45:23 INFO - PID 2090 | __start_cc_report 13:45:23 INFO - PID 2090 | _x_x_mozilla_cycle_collect,2389 13:45:23 INFO - PID 2090 | __end_cc_report 13:45:23 INFO - PID 2090 | __startTimestamp1490820323140__endTimestamp 13:45:23 INFO - PID 2090 | 13:45:23 INFO - PID 2090 | ------- Summary: start ------- 13:45:23 INFO - PID 2090 | Number of tests: 6 13:45:23 INFO - PID 2090 | 13:45:23 INFO - PID 2090 | [#0] dojo.html Cycles:165 Average:6074.42 Median:6266.34 stddev:722.75 (11.5%) stddev-sans-first:688.70 13:45:23 INFO - PID 2090 | Values: 3192.6 3501.6 3505.8 3534.3 3581.3 5060.4 5984.0 6041.1 6155.3 6184.8 6109.5 6148.2 6202.6 6206.5 6239.7 5093.0 5473.8 5517.3 5593.6 5599.2 5691.1 5710.7 5713.9 5719.4 5766.0 5453.2 5513.7 5562.1 5681.6 5685.9 4638.2 5603.4 5616.2 5680.3 5688.0 5539.7 5542.1 5545.7 5556.9 5560.1 6041.8 6187.3 6192.2 6194.1 6253.9 6475.8 6480.8 6596.0 6657.2 6676.7 6643.1 6658.8 6696.0 6696.2 6733.2 6220.1 6283.6 6284.2 6313.3 6318.5 6640.3 6738.4 6743.2 6792.9 6822.0 6484.4 6488.1 6502.5 6503.9 6507.2 6514.0 6643.5 6654.1 6658.8 6662.5 6358.6 6482.7 6574.0 6579.1 6579.7 5673.9 5852.8 6004.8 6458.9 6466.1 4966.4 5254.6 5263.0 5270.4 5271.4 4664.3 4753.4 4762.8 4786.9 4789.8 5124.7 5132.4 6108.6 6125.8 6227.1 6724.0 6727.8 6744.8 6757.4 6779.2 4661.7 6151.7 6222.8 6230.2 6240.3 5784.1 5921.4 5932.9 5938.5 5970.3 5725.0 6780.4 6786.9 6911.6 6919.3 6260.4 6326.7 6742.4 6777.5 6778.1 6733.6 6798.5 6860.6 6864.3 6870.1 6498.6 6608.4 6650.7 6653.4 6659.1 6090.0 6492.9 6580.5 6595.5 6642.4 5300.8 6539.7 6553.1 6553.5 6569.8 6511.9 6522.9 6523.5 6528.2 6531.2 6186.8 6364.1 6381.3 6425.3 6444.6 6274.1 6347.1 6363.7 6372.9 6386.4 5277.4 6252.2 6255.9 6266.3 6269.4 13:45:23 INFO - PID 2090 | 13:45:23 INFO - PID 2090 | [#1] ext.html Cycles:180 Average:49417.21 Median:36832.54 stddev:97203.35 (263.9%) stddev-sans-first:97407.48 13:45:23 INFO - PID 2090 | Values: 797.5 816.2 1132.7 1155.2 1158.2 36146.8 36938.8 36981.0 37086.0 37166.1 38370.0 38716.4 38812.6 38863.8 39003.8 6035.5 6220.7 8466.0 8602.1 8602.2 7193.7 8307.9 8491.9 8534.8 8548.9 8588.8 8639.9 8642.2 8642.7 8645.6 8542.8 8576.8 8607.0 8608.6 8614.3 8425.9 8481.2 8490.8 8491.2 8500.1 36682.0 36809.3 36855.8 36864.1 36874.3 2949.8 2987.5 2994.9 3016.1 3026.5 26692.9 26766.0 26786.6 27041.6 27688.9 2751.9 2781.5 2791.3 2810.3 2818.6 281918.0 285132.0 285168.0 285722.0 286692.0 38426.6 39085.0 46107.5 47718.3 47878.3 50089.0 50097.7 50133.7 50258.5 50268.5 10969.2 11156.4 12900.7 12964.5 13029.3 8806.5 8809.0 8853.9 8943.3 9996.8 12466.0 12501.0 12548.2 12616.7 12633.0 5214.9 5222.5 5236.8 5250.6 5251.6 872.7 884.9 912.9 979.9 999.4 20659.2 21821.9 22733.7 24084.9 24150.0 1056.8 1059.2 1109.4 1109.7 1111.8 10522.8 11284.4 12188.4 12191.7 12228.6 408199.0 408875.0 409596.0 409972.0 410044.0 51983.0 52055.5 52151.0 52152.2 52248.7 1450.3 1468.5 1512.0 1512.3 1522.3 23234.7 23241.7 23297.4 23349.8 23430.8 37844.6 37921.0 37958.2 37962.6 37974.0 392309.0 392876.0 393524.0 394014.0 394441.0 32246.8 32473.7 33149.5 33251.0 33294.2 41587.8 42026.8 42266.0 42382.2 42523.1 23800.9 27217.7 29309.0 29726.3 29918.8 29750.1 30021.8 30029.4 30162.9 30207.5 26772.9 34610.0 34938.8 35729.9 35763.3 28255.6 29138.6 30038.2 30190.2 30382.3 21588.9 22097.0 23664.4 23795.4 24001.0 13:45:23 INFO - PID 2090 | 13:45:23 INFO - PID 2090 | [#2] jquery.html Cycles:180 Average:40602.03 Median:25673.00 stddev:119902.71 (467.0%) stddev-sans-first:120201.04 13:45:23 INFO - PID 2090 | Values: 386.9 399.8 414.3 431.5 443.4 13606.7 15537.8 21774.6 21816.8 21877.3 19515.5 22345.4 22412.6 23528.5 23824.0 5303.4 5313.4 6189.5 6246.6 6255.6 3625.6 5180.5 6195.8 6196.8 6209.2 3856.9 3898.6 6152.3 6173.1 6209.7 5917.3 6008.4 6190.5 6197.3 6210.7 4735.7 5248.0 5449.9 5529.6 5532.9 27522.0 28082.4 28185.3 28208.4 28255.9 1996.2 2005.3 2029.2 2048.1 2073.0 15744.8 16540.5 16851.9 17122.2 17538.0 1659.5 1667.1 1668.8 1675.2 1706.1 135665.6 144057.0 147084.4 148230.0 149559.0 10024.8 11977.6 12051.2 12118.0 12141.0 16100.7 16118.9 16151.8 16152.8 16156.4 8231.7 8452.0 8525.5 8531.6 8653.7 6451.3 7558.7 7854.5 8040.6 8060.2 6601.2 7482.3 7539.2 7715.5 7764.0 1836.5 2077.5 2078.2 2090.6 2233.6 879.9 893.2 908.7 930.6 939.2 20420.7 20438.3 20474.0 20543.6 20609.7 861.9 862.9 878.6 976.6 987.5 9570.7 9916.1 10638.7 10644.2 10677.5 703208.0 706117.0 710821.0 728804.4 731651.0 154512.0 157121.0 157764.0 160362.2 160696.2 1154.3 1173.6 1198.2 1202.0 1205.6 15160.4 16937.2 17683.6 18069.7 18425.4 59095.4 59609.0 60114.5 60290.7 60310.1 82175.2 83501.6 83568.0 85251.0 86232.6 6277.9 8350.1 8485.2 8604.5 8862.5 13308.8 13461.5 13509.4 13893.3 13962.9 11569.5 11597.9 11760.8 11917.8 11990.6 9191.0 9598.4 10093.8 10699.9 11089.1 11441.9 11696.9 11990.3 12002.3 12030.8 8576.7 8582.1 8587.9 8623.7 8685.6 11198.6 11429.3 12165.2 12173.9 12198.6 13:45:23 INFO - PID 2090 | 13:45:23 INFO - PID 2090 | [#3] mootools.html Cycles:180 Average:6762.29 Median:2503.99 stddev:4175.19 (166.7%) stddev-sans-first:4167.46 13:45:23 INFO - PID 2090 | Values: 1399.6 1466.7 1467.8 1488.9 1490.5 10569.8 11040.8 11051.2 11063.6 11065.3 10721.4 10818.4 11128.6 11142.9 11162.8 2473.0 2510.8 2515.1 2516.0 2517.8 2440.1 2462.3 2473.0 2477.7 2478.1 2447.4 2459.4 2471.7 2492.5 2497.2 2428.4 2443.7 2463.8 2464.1 2488.4 2029.7 2430.3 2461.5 2463.1 2467.4 10840.6 11072.5 11082.4 11087.7 11098.6 6227.4 6477.7 6483.2 6486.0 6490.7 3993.9 4060.5 4140.6 4143.0 4194.8 1170.7 1181.3 1199.9 1220.0 1244.5 14164.9 14555.3 14585.1 15233.3 15386.4 5262.8 5405.8 5456.2 5467.7 5484.5 10255.2 11499.4 11528.4 11550.7 11555.7 5337.1 6123.0 6292.4 6326.7 6329.1 5856.2 5898.4 5915.4 5948.8 6010.1 4143.1 4189.6 4233.4 4262.2 4265.2 1240.0 1263.6 1275.9 1279.6 1280.1 630.6 747.2 759.8 761.8 777.3 5655.7 5755.9 5958.1 5994.0 6020.2 568.1 580.0 582.5 583.2 598.8 3957.6 4010.5 4030.2 4140.1 4147.2 11564.2 13114.2 14010.2 14020.2 14037.9 13524.3 13948.7 14125.5 14138.0 14167.9 10112.4 10389.3 10399.4 10412.3 10445.9 6321.7 6581.4 6784.5 6798.7 6818.6 11734.4 11832.2 12966.9 12974.4 12992.0 11433.2 12388.4 12427.8 12710.7 12858.8 9049.3 9072.8 9279.6 9296.9 9299.0 10185.3 10192.5 10302.5 10302.7 10332.5 8520.7 8689.4 8733.1 8744.0 8795.3 8381.8 8454.2 8497.6 8571.1 8610.2 7617.8 7821.2 7822.0 7834.1 7834.8 5243.8 5723.3 5891.4 5918.7 5932.2 4707.9 5481.0 5493.5 5522.9 5555.6 13:45:23 INFO - PID 2090 | 13:45:23 INFO - PID 2090 | [#4] prototype.html Cycles:180 Average:5128.62 Median:5717.31 stddev:1602.06 (28.0%) stddev-sans-first:1566.58 13:45:23 INFO - PID 2090 | Values: 390.1 391.6 400.2 400.7 403.5 4806.4 4951.4 5930.4 5948.8 5951.3 5553.3 5716.3 5767.5 5873.2 5884.2 4603.7 4610.9 4614.2 4659.7 4666.6 4569.3 4643.9 4649.0 4661.3 4689.3 3811.6 4424.8 4534.3 4641.2 4642.6 3828.8 4517.8 4541.6 4542.1 4593.8 3320.3 3638.7 3961.0 4094.4 4140.4 5006.1 5298.0 5603.2 5718.3 5830.3 5319.1 5351.6 5378.2 5385.9 5386.3 4695.4 6181.0 6269.8 6296.4 6319.8 3416.8 3972.4 4160.9 4165.6 4521.0 5597.6 6340.0 6589.2 6590.6 6600.7 3639.8 4224.8 4225.2 4233.2 4236.6 4035.8 4282.9 4302.5 4418.8 4421.5 4233.5 4732.5 5158.4 5218.7 5246.5 6422.8 6430.0 6431.6 6433.0 6463.2 1428.8 1499.3 1502.5 1507.2 1520.7 816.7 949.9 967.6 1000.6 1001.8 5030.2 5878.9 5880.9 5917.9 5992.5 5985.9 6516.9 6542.9 6595.2 6601.8 5625.6 5937.6 5954.0 5964.2 5970.2 2886.5 3129.0 3262.7 3418.9 3460.8 6406.4 6472.3 6745.1 6754.3 6813.6 6786.8 6791.6 6814.6 6831.5 6833.8 5650.4 6078.6 6110.9 6843.9 6857.2 5669.9 6358.8 6443.3 6511.7 6514.8 5402.3 6460.0 6502.2 6529.8 6552.1 5573.8 5796.7 6473.7 6810.2 6882.8 3820.4 3951.0 4712.5 4731.7 4745.9 6391.8 6479.3 6595.5 6604.9 6647.5 6311.3 6332.2 6387.2 6438.9 6441.5 5610.4 6323.4 6336.9 6346.5 6371.5 5125.8 5514.4 6157.3 6163.4 6219.6 6348.4 6353.7 6371.2 6377.7 6383.0 5698.5 5753.3 5981.9 6144.5 6203.5 13:45:23 INFO - PID 2090 | 13:45:23 INFO - PID 2090 | [#5] yui.html Cycles:180 Average:20794.38 Median:25463.87 stddev:30448.22 (119.6%) stddev-sans-first:30496.37 13:45:23 INFO - PID 2090 | Values: 733.8 747.2 751.3 765.9 769.6 15324.5 15615.7 15842.8 15878.0 15894.5 14413.3 14579.2 14629.6 14675.2 14690.5 900.3 980.7 1000.7 1016.7 1033.8 971.1 1007.3 1013.1 1019.6 1020.8 1076.3 1081.0 1082.2 1087.4 1089.8 1070.7 1072.4 1073.8 1075.2 1075.6 802.5 802.5 803.9 804.8 806.0 16070.5 16245.7 16446.8 16648.9 16925.6 14606.6 14680.8 14715.3 14746.7 14833.6 11615.7 11732.2 11886.3 11946.9 12212.3 2988.2 3019.9 3082.7 3084.7 3106.8 110277.4 114741.5 114892.0 115329.0 118385.4 10798.3 11511.6 11575.1 11614.7 11930.6 25455.2 25463.9 25463.9 25498.7 25529.1 7944.4 7969.8 8006.5 8102.8 8243.1 3978.6 4046.2 4049.4 4073.3 4090.9 4133.9 4179.8 4180.4 4211.9 4223.6 820.1 823.3 828.3 850.8 852.3 542.3 553.8 568.0 575.0 603.5 9595.5 10170.5 10230.1 10404.7 10459.9 541.7 564.6 588.7 591.3 597.0 4080.8 4145.5 4533.6 4696.2 4772.2 102752.0 103522.0 104517.5 106775.5 109013.0 86846.1 92996.0 93339.5 94926.0 96031.0 80727.2 81363.2 81670.7 81973.6 82937.0 9344.7 9468.7 9480.4 9509.0 9517.7 35555.3 37185.0 38719.2 39080.4 41154.0 61274.5 64717.7 64835.7 68663.0 70843.6 10839.3 11977.3 12579.5 13745.9 13749.9 12371.3 14419.0 14772.0 14964.7 15635.6 12266.6 13481.5 13742.0 13781.9 14402.0 13623.6 13732.7 13863.0 13903.3 13943.4 13234.3 13455.3 14073.0 14092.2 14296.0 9421.0 9864.9 9953.9 9969.2 10352.2 8412.4 9097.5 9926.3 11315.7 11425.3 13:45:23 INFO - PID 2090 | -------- Summary: end -------- 13:45:23 INFO - PID 2090 | 13:45:23 INFO - TEST-INFO | 2090: exit 0 13:45:23 INFO - TEST-OK | dromaeo_css | took 1121476ms 13:45:23 INFO - TEST-START | kraken 13:45:23 INFO - operating with platform_type : mac_ 13:45:23 INFO - Initialising browser for kraken test... 13:45:23 INFO - TEST-INFO | started process 2209 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/tmpfE5Arw/profile http://localhost:53448/getInfo.html) 13:45:26 INFO - PID 2209 | __metrics Screen width/height:1600/1200 13:45:26 INFO - PID 2209 | colorDepth:24 13:45:26 INFO - PID 2209 | Browser inner width/height: 1024/689 13:45:26 INFO - PID 2209 | __metrics 13:45:26 ERROR - PID 2209 | 1490820326405 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 13:45:26 INFO - PID 2209 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:45:26 INFO - PID 2209 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:45:27 INFO - TEST-INFO | 2209: exit 0 13:45:27 INFO - Browser initialized. 13:45:27 INFO - Running cycle 1/1 for kraken test... 13:45:27 INFO - TEST-INFO | started process 2210 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/tmpfE5Arw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:45:39 INFO - PID 2210 | RSS: Main: 234176512 13:45:39 INFO - PID 2210 | 13:45:42 INFO - PID 2210 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53448/tests/kraken/driver.html?testName=audio-beat-detection) 13:45:43 INFO - PID 2210 | RSS: Main: 287285248 13:45:43 INFO - PID 2210 | 13:45:46 INFO - PID 2210 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53448/tests/kraken/driver.html?testName=audio-dft) 13:45:46 INFO - PID 2210 | RSS: Main: 289042432 13:45:46 INFO - PID 2210 | 13:45:50 INFO - PID 2210 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53448/tests/kraken/driver.html?testName=audio-fft) 13:45:51 INFO - PID 2210 | RSS: Main: 381751296 13:45:51 INFO - PID 2210 | 13:45:53 INFO - PID 2210 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53448/tests/kraken/driver.html?testName=audio-oscillator) 13:45:53 INFO - PID 2210 | RSS: Main: 283418624 13:45:53 INFO - PID 2210 | 13:45:56 INFO - PID 2210 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53448/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:45:56 INFO - PID 2210 | RSS: Main: 286740480 13:45:56 INFO - PID 2210 | 13:45:59 INFO - PID 2210 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53448/tests/kraken/driver.html?testName=imaging-darkroom) 13:46:00 INFO - PID 2210 | RSS: Main: 325853184 13:46:00 INFO - PID 2210 | 13:46:03 INFO - PID 2210 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53448/tests/kraken/driver.html?testName=imaging-desaturate) 13:46:04 INFO - PID 2210 | RSS: Main: 340873216 13:46:04 INFO - PID 2210 | 13:46:07 INFO - PID 2210 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53448/tests/kraken/driver.html?testName=json-parse-financial) 13:46:07 INFO - PID 2210 | RSS: Main: 345255936 13:46:07 INFO - PID 2210 | 13:46:09 INFO - PID 2210 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53448/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:46:10 INFO - PID 2210 | RSS: Main: 304381952 13:46:10 INFO - PID 2210 | 13:46:12 INFO - PID 2210 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53448/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:46:12 INFO - PID 2210 | RSS: Main: 307048448 13:46:12 INFO - PID 2210 | 13:46:15 INFO - PID 2210 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53448/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:46:15 INFO - PID 2210 | RSS: Main: 308338688 13:46:15 INFO - PID 2210 | 13:46:19 INFO - PID 2210 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53448/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:46:19 INFO - PID 2210 | RSS: Main: 328327168 13:46:19 INFO - PID 2210 | 13:46:23 INFO - PID 2210 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53448/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:46:24 INFO - PID 2210 | RSS: Main: 311308288 13:46:24 INFO - PID 2210 | 13:46:26 INFO - PID 2210 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53448/tests/kraken/driver.html?testName=ai-astar) 13:46:26 INFO - PID 2210 | RSS: Main: 377581568 13:46:26 INFO - PID 2210 | 13:46:26 INFO - PID 2210 | __start_tp_report 13:46:26 INFO - PID 2210 | _x_x_mozilla_page_load 13:46:26 INFO - PID 2210 | _x_x_mozilla_page_load_details 13:46:26 INFO - PID 2210 | |i|pagename|runs| 13:46:26 INFO - PID 2210 | |0;ai-astar;123;121;120;121;133;184;155;130;182;158 13:46:26 INFO - PID 2210 | |1;audio-beat-detection;164;120;122;167;124;121;119;119;150;124 13:46:26 INFO - PID 2210 | |2;audio-dft;209;210;208;215;215;219;208;215;216;215 13:46:26 INFO - PID 2210 | |3;audio-fft;89;66;63;102;68;66;53;57;93;93 13:46:26 INFO - PID 2210 | |4;audio-oscillator;94;75;104;77;74;77;89;75;74;92 13:46:26 INFO - PID 2210 | |5;imaging-gaussian-blur;90;93;90;91;91;92;92;90;90;92 13:46:26 INFO - PID 2210 | |6;imaging-darkroom;99;100;101;99;100;101;101;100;102;100 13:46:26 INFO - PID 2210 | |7;imaging-desaturate;102;99;100;101;100;100;100;97;102;102 13:46:26 INFO - PID 2210 | |8;json-parse-financial;65;63;64;64;65;65;66;65;64;64 13:46:26 INFO - PID 2210 | |9;json-stringify-tinderbox;59;59;69;79;70;72;63;66;65;69 13:46:26 INFO - PID 2210 | |10;stanford-crypto-aes;92;91;93;92;89;92;91;92;90;91 13:46:26 INFO - PID 2210 | |11;stanford-crypto-ccm;153;158;151;150;156;158;172;168;239;213 13:46:26 INFO - PID 2210 | |12;stanford-crypto-pbkdf2;219;256;202;214;206;208;238;195;246;240 13:46:26 INFO - PID 2210 | |13;stanford-crypto-sha256-iterative;83;103;95;65;93;102;107;79;74;76 13:46:26 INFO - PID 2210 | __end_tp_report 13:46:26 INFO - PID 2210 | __start_cc_report 13:46:26 INFO - PID 2210 | _x_x_mozilla_cycle_collect,2194 13:46:26 INFO - PID 2210 | __end_cc_report 13:46:26 INFO - PID 2210 | __startTimestamp1490820386358__endTimestamp 13:46:26 INFO - PID 2210 | 13:46:26 INFO - PID 2210 | ------- Summary: start ------- 13:46:26 INFO - PID 2210 | Number of tests: 14 13:46:26 INFO - PID 2210 | 13:46:26 INFO - PID 2210 | [#0] ai-astar Cycles:10 Average:142.70 Median:144.00 stddev:25.25 (17.5%) stddev-sans-first:25.75 13:46:26 INFO - PID 2210 | Values: 123.0 121.0 120.0 121.0 133.0 184.0 155.0 130.0 182.0 158.0 13:46:26 INFO - PID 2210 | 13:46:26 INFO - PID 2210 | [#1] audio-beat-detection Cycles:10 Average:133.00 Median:124.00 stddev:19.42 (15.7%) stddev-sans-first:17.05 13:46:26 INFO - PID 2210 | Values: 164.0 120.0 122.0 167.0 124.0 121.0 119.0 119.0 150.0 124.0 13:46:26 INFO - PID 2210 | 13:46:26 INFO - PID 2210 | [#2] audio-dft Cycles:10 Average:213.00 Median:215.00 stddev:3.89 (1.8%) stddev-sans-first:3.84 13:46:26 INFO - PID 2210 | Values: 209.0 210.0 208.0 215.0 215.0 219.0 208.0 215.0 216.0 215.0 13:46:26 INFO - PID 2210 | 13:46:26 INFO - PID 2210 | [#3] audio-fft Cycles:10 Average:75.00 Median:67.00 stddev:17.44 (26.0%) stddev-sans-first:17.74 13:46:26 INFO - PID 2210 | Values: 89.0 66.0 63.0 102.0 68.0 66.0 53.0 57.0 93.0 93.0 13:46:26 INFO - PID 2210 | 13:46:26 INFO - PID 2210 | [#4] audio-oscillator Cycles:10 Average:83.10 Median:77.00 stddev:10.75 (14.0%) stddev-sans-first:10.66 13:46:26 INFO - PID 2210 | Values: 94.0 75.0 104.0 77.0 74.0 77.0 89.0 75.0 74.0 92.0 13:46:26 INFO - PID 2210 | 13:46:26 INFO - PID 2210 | [#5] imaging-gaussian-blur Cycles:10 Average:91.10 Median:91.50 stddev:1.10 (1.2%) stddev-sans-first:1.09 13:46:26 INFO - PID 2210 | Values: 90.0 93.0 90.0 91.0 91.0 92.0 92.0 90.0 90.0 92.0 13:46:26 INFO - PID 2210 | 13:46:26 INFO - PID 2210 | [#6] imaging-darkroom Cycles:10 Average:100.30 Median:101.00 stddev:0.95 (0.9%) stddev-sans-first:0.88 13:46:26 INFO - PID 2210 | Values: 99.0 100.0 101.0 99.0 100.0 101.0 101.0 100.0 102.0 100.0 13:46:26 INFO - PID 2210 | 13:46:26 INFO - PID 2210 | [#7] imaging-desaturate Cycles:10 Average:100.30 Median:102.00 stddev:1.57 (1.5%) stddev-sans-first:1.54 13:46:26 INFO - PID 2210 | Values: 102.0 99.0 100.0 101.0 100.0 100.0 100.0 97.0 102.0 102.0 13:46:26 INFO - PID 2210 | 13:46:26 INFO - PID 2210 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:65.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 13:46:26 INFO - PID 2210 | Values: 65.0 63.0 64.0 64.0 65.0 65.0 66.0 65.0 64.0 64.0 13:46:26 INFO - PID 2210 | 13:46:26 INFO - PID 2210 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:69.00 stddev:6.10 (8.8%) stddev-sans-first:5.72 13:46:26 INFO - PID 2210 | Values: 59.0 59.0 69.0 79.0 70.0 72.0 63.0 66.0 65.0 69.0 13:46:26 INFO - PID 2210 | 13:46:26 INFO - PID 2210 | [#10] stanford-crypto-aes Cycles:10 Average:91.30 Median:92.00 stddev:1.16 (1.3%) stddev-sans-first:1.20 13:46:26 INFO - PID 2210 | Values: 92.0 91.0 93.0 92.0 89.0 92.0 91.0 92.0 90.0 91.0 13:46:26 INFO - PID 2210 | 13:46:26 INFO - PID 2210 | [#11] stanford-crypto-ccm Cycles:10 Average:171.80 Median:163.00 stddev:30.04 (18.4%) stddev-sans-first:31.08 13:46:26 INFO - PID 2210 | Values: 153.0 158.0 151.0 150.0 156.0 158.0 172.0 168.0 239.0 213.0 13:46:26 INFO - PID 2210 | 13:46:26 INFO - PID 2210 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:222.40 Median:228.50 stddev:20.99 (9.2%) stddev-sans-first:22.22 13:46:26 INFO - PID 2210 | Values: 219.0 256.0 202.0 214.0 206.0 208.0 238.0 195.0 246.0 240.0 13:46:26 INFO - PID 2210 | 13:46:26 INFO - PID 2210 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:87.70 Median:77.50 stddev:14.26 (18.4%) stddev-sans-first:15.02 13:46:26 INFO - PID 2210 | Values: 83.0 103.0 95.0 65.0 93.0 102.0 107.0 79.0 74.0 76.0 13:46:26 INFO - PID 2210 | -------- Summary: end -------- 13:46:26 INFO - PID 2210 | 13:46:27 INFO - TEST-INFO | 2210: exit 0 13:46:27 INFO - TEST-OK | kraken | took 63451ms 13:46:27 INFO - SUITE-END | took 1184s 13:46:27 INFO - Completed test suite (00:19:45) 13:46:27 INFO - javascript benchmark 13:46:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7561.927216362257, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3192.6009248843893, 3501.6148223695404, 3505.7545971781988, 3534.3284775892585, 3581.3195492856357, 5060.41805192403, 5984.04255319149, 6041.1240370146415, 6155.2613686357645, 6184.845378865525, 6109.526129009815, 6148.200733904598, 6202.596831205969, 6206.472449841769, 6239.688015599225, 5093.0, 5473.8357849264585, 5517.282753242073, 5593.608447408683, 5599.160125981095, 5691.117876729093, 5710.714464276791, 5713.914291285634, 5719.370869204384, 5765.971170144165, 5453.15476101205, 5513.696746678931, 5562.137868630329, 5681.6022878398735, 5685.886282274331, 4638.2115040443205, 5603.355614104389, 5616.157576363578, 5680.289963754531, 5688.033034384164, 5539.695316757577, 5542.0855558832745, 5545.667259964415, 5556.86107847303, 5560.110382338847, 6041.818745437644, 6187.319394866561, 6192.225971753531, 6194.1018552310115, 6253.90556652584, 6475.7733479328, 6480.773172938924, 6595.967020164869, 6657.234418041939, 6676.699548520328, 6643.103181070542, 6658.766943156967, 6696.0, 6696.196456425211, 6733.158355205599, 6220.066989951453, 6283.560150789446, 6284.183056202664, 6313.273973493016, 6318.462930650854, 6640.269570347258, 6738.427233685192, 6743.190817101881, 6792.87917493608, 6822.044913712084, 6484.351564843572, 6488.0916671666, 6502.479801615859, 6503.8699226015215, 6507.186601674791, 6514.0, 6643.5017373697165, 6654.134962454947, 6658.766943156967, 6662.533622646368, 6358.586691865014, 6482.708278127401, 6574.046763219307, 6579.1447111876105, 6579.703913323912, 5673.921954828569, 5852.824415267549, 6004.819855404345, 6458.935410645928, 6466.094746735461, 4966.404031516241, 5254.605904557174, 5263.0000299942885, 5270.393904700932, 5271.446498117719, 4664.253719404879, 4753.405824271966, 4762.833300834454, 4786.899013226977, 4789.784459699322, 5124.743762811844, 5132.358455193101, 6108.584917381041, 6125.754381768298, 6227.09707092469, 6723.966380168165, 6727.798166055026, 6744.7976560703255, 6757.358050985148, 6779.220389655253, 4661.720296782204, 6151.6573060257915, 6222.844428889223, 6230.221222347207, 6240.282367527701, 5784.074548072288, 5921.437463440966, 5932.8813423732145, 5938.465538101592, 5970.34326224115, 5725.0, 6780.423663988616, 6786.932130678729, 6911.619860907497, 6919.273476285119, 6260.373962603703, 6326.746930122744, 6742.393184613408, 6777.525573209828, 6778.084958530535, 6733.595984240961, 6798.490113241428, 6860.622665753432, 6864.279250678607, 6870.072540207008, 6498.577592456664, 6608.43828274602, 6650.700718467584, 6653.367930046637, 6659.134312539339, 6090.0, 6492.902606461002, 6580.539362244597, 6595.538312318284, 6642.368974947372, 5300.7879684813715, 6539.738410463528, 6553.115329430466, 6553.475721942138, 6569.770058047945, 6511.9348806511325, 6522.934770652422, 6523.510736694672, 6528.21661400635, 6531.183602049744, 6186.845328866814, 6364.140840986593, 6381.298057213796, 6425.261094974137, 6444.613323200623, 6274.121622972696, 6347.111404403295, 6363.6818159090935, 6372.904406434, 6386.425221730066, 5277.419483856849, 6252.187215662117, 6255.874882502233, 6266.342034086538, 6269.404406581368], "value": 6028.761430811795, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [797.489606651743, 816.1675091406765, 1132.6828488023357, 1155.2086820527938, 1158.1892675127413, 36146.819265903665, 36938.81530592347, 36981.0, 37086.0, 37166.070848228774, 38370.0, 38716.41925371122, 38812.61187388125, 38863.80568097163, 39003.804980975125, 6035.486983606399, 6220.657863817488, 8465.957670211641, 8602.139786021378, 8602.18279263469, 7193.712251509959, 8307.875381869277, 8491.915080849174, 8534.78663033426, 8548.87176692347, 8588.785280367978, 8639.870401943976, 8642.222200002, 8642.65429382824, 8645.610947507346, 8542.78643033926, 8576.828463430758, 8607.010193827728, 8608.569571521399, 8614.267787238092, 8425.915740842574, 8481.194286542768, 8490.78773030673, 8491.150884911522, 8500.064992850781, 36682.0, 36809.263814723825, 36855.81572092122, 36864.078398039994, 36874.262514749826, 2949.8349638704826, 2987.536931775578, 2994.8802047918057, 3016.0844583175867, 3026.500627396477, 26692.8665356672, 26766.0, 26786.598201027, 27041.594376084373, 27688.892444302204, 2751.931201719953, 2781.4576157649267, 2791.288221503504, 2810.2552823501787, 2818.6335776349147, 281918.0, 285132.0, 285168.0, 285722.0, 286692.0, 38426.61573384231, 39085.0, 46107.538924611, 47718.28422573664, 47878.28182577264, 50088.99822003539, 50097.747556311384, 50133.74933125311, 50258.49741502611, 50268.49731502638, 10969.23215374916, 11156.442177891073, 12900.677483062811, 12964.546240881524, 13029.348532573333, 8806.515641639771, 8809.03100658927, 8853.911460885438, 8943.284537237005, 9996.800063998679, 12466.0, 12501.0, 12548.247105173536, 12616.684582885502, 12633.0, 5214.869628259248, 5222.451642577551, 5236.790528378899, 5250.553702935294, 5251.553617942442, 872.7425409504211, 884.8628462588309, 912.9497877616794, 979.8628192052976, 999.4453078541479, 20659.17363305451, 21821.890890545445, 22733.658995115085, 24084.87957560236, 24150.0, 1056.7780766039064, 1059.2373491086405, 1109.378747901162, 1109.6615532262738, 1111.8165502691966, 10522.842157367646, 11284.435778211056, 12188.390580470941, 12191.695207619881, 12228.633141005606, 408199.0, 408875.0, 409596.0, 409972.0, 410044.0, 51982.960340792975, 52055.47944520506, 52150.956980860174, 52152.21771673428, 52248.738756305975, 1450.311102226434, 1468.5374107156213, 1511.9697606048037, 1512.296781996377, 1522.3301747231183, 23234.651480227472, 23241.65137522905, 23297.417564560343, 23349.766502334758, 23430.76569234354, 37844.62155378521, 37921.0, 37958.24083518259, 37962.62037379591, 37974.0, 392309.0, 392876.0, 393524.0, 394014.0299298485, 394441.0, 32246.83876580602, 32473.675263247063, 33149.502757458176, 33251.0, 33294.16764580905, 41587.75236742781, 42026.78986605047, 42266.0, 42382.15235695207, 42523.1495370097, 23800.880995595602, 27217.72782272231, 29309.0, 29726.30486624584, 29918.803247870714, 29750.10749677513, 30021.849890750407, 30029.3994120112, 30162.944296949503, 30207.546886797154, 26772.866135669978, 34610.0, 34938.82530587331, 35729.92810215698, 35763.284734304645, 28255.576166357932, 29138.56292155577, 30038.24904377408, 30190.2452438682, 30382.328971906758, 21588.89205553962, 22097.0, 23664.408389789704, 23795.371790197063, 24001.0], "value": 16931.71629369035, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.89167033230706, 399.7501561524047, 414.264680192658, 431.49299573001724, 443.3682003145517, 13606.659833504167, 15537.84462155378, 21774.564508709816, 21816.781832181674, 21877.343679689595, 19515.5121121972, 22345.44136396591, 22412.551748965012, 23528.529429411403, 23824.0, 5303.390110137345, 5313.362396512424, 6189.50483961282, 6246.562740608159, 6255.59338642989, 3625.6011838697855, 5180.481951804808, 6195.783147589836, 6196.752129914798, 6209.16176316196, 3856.8842934712, 3898.5906479819637, 6152.261728592575, 6173.135760993465, 6209.689515524228, 5917.289925209003, 6008.429199226067, 6190.50475961922, 6197.287311959138, 6210.72051757672, 4735.668503204777, 5248.0, 5449.863753406157, 5529.640573362719, 5532.917006244909, 27522.0, 28082.43835123286, 28185.29536761577, 28208.435831283463, 28255.869765209365, 1996.2152796848316, 2005.2680771518437, 2029.1883246701439, 2048.057893369052, 2073.0013886133615, 15744.842551574568, 16540.503784886474, 16851.91574042122, 17122.229499672543, 17538.0, 1659.4772646616277, 1667.1080971680215, 1668.7663727078218, 1675.1707904587308, 1706.0957692423035, 135665.64334356628, 144057.0, 147084.40818285343, 148230.0, 149559.0, 10024.849627255597, 11977.58078467267, 12051.216670916363, 12118.03160704107, 12141.0, 16100.67798644044, 16118.919405402898, 16151.838481615034, 16152.838471615369, 16156.353745850269, 8231.670733170726, 8452.028016778026, 8525.488470691778, 8531.616077276538, 8653.653853845775, 6451.258160296694, 7558.677231484578, 7854.528728276322, 8040.557769322743, 8060.193980601893, 6601.174853143357, 7482.326590606763, 7539.170691223961, 7715.498492597963, 7764.0, 1836.4857839804877, 2077.48316393729, 2078.1998930411596, 2090.581883623251, 2233.6314508106307, 879.9352783132354, 893.1693525021662, 908.7455512456522, 930.6044930904474, 939.154760715348, 20420.693689594667, 20438.28466003683, 20474.0, 20543.58912821735, 20609.690854637192, 861.8965724113147, 862.8921384826897, 878.5782824244399, 976.6337623391229, 987.4914419074182, 9570.712878613653, 9916.057974492413, 10638.73403164927, 10644.201684873666, 10677.46612669379, 703208.0, 706117.0, 710821.0, 728804.3559782167, 731651.0, 154512.0, 157121.0, 157764.0, 160362.1981890083, 160696.19651901667, 1154.2728081308721, 1173.556525473672, 1198.2091819399154, 1202.032363947031, 1205.6383085074442, 15160.393584256506, 16937.15314234308, 17683.557911052325, 18069.728954065962, 18425.447236582924, 59095.40904590899, 59609.0, 60114.49713757191, 60290.69854650699, 60310.095348570685, 82175.17824821915, 83501.58249208715, 83568.0, 85251.0, 86232.56883715541, 6277.905831412441, 8350.08149103586, 8485.151484851465, 8604.48373097616, 8862.512561809162, 13308.800367994294, 13461.528846490326, 13509.392077356739, 13893.30533473302, 13962.860371396562, 11569.479373428385, 11597.88402115968, 11760.823587646364, 11917.821232681343, 11990.640280791591, 9191.0, 9598.42409455435, 10093.848592270975, 10699.94650026745, 11089.05743011853, 11441.942790285995, 11696.941515292368, 11990.280583165038, 12002.279863208236, 12030.75938481208, 8576.742697719079, 8582.055973842747, 8587.87118193215, 8623.698170564001, 8685.565721713763, 11198.552057917592, 11429.257098288585, 12165.20926139798, 12173.878261217274, 12198.573049943565], "value": 10083.834701124646, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1399.5941177058653, 1466.691994681117, 1467.809184805975, 1488.8511148885107, 1490.5230326295587, 10569.78860422792, 11040.834387484185, 11051.17116216283, 11063.612773552928, 11065.336079835206, 10721.410322432283, 10818.404987725671, 11128.61049863253, 11142.888571114287, 11162.832557511643, 2472.9629055564137, 2510.811689123314, 2515.132279363617, 2515.987420062897, 2517.848929064253, 2440.1337525178574, 2462.347477918353, 2472.9752702473015, 2477.7274499805008, 2478.0707234786955, 2447.412620970963, 2459.409741662006, 2471.7404672509397, 2492.513959777844, 2497.1634502441702, 2428.3564855313357, 2443.7434069422634, 2463.8275320727557, 2464.137551856854, 2488.377905523619, 2029.725986991752, 2430.2952143878256, 2461.5323088613104, 2463.064035666453, 2467.4078221226955, 10840.566377344896, 11072.501737421835, 11082.390468524229, 11087.72280692981, 11098.611548595842, 6227.3772622737815, 6477.676116194219, 6483.22201335838, 6485.962246040658, 6490.675466226669, 3993.860214892494, 4060.4924384451942, 4140.627343539096, 4143.0, 4194.790260486963, 1170.6839153428612, 1181.3384504677408, 1199.9160058795887, 1220.0239808153442, 1244.4897591987333, 14164.92917535416, 14555.345009474599, 14585.124892506483, 15233.314500847488, 15386.384544618202, 5262.7631756571045, 5405.8107966221, 5456.154296084113, 5467.72661366938, 5484.506394424521, 10255.230857685554, 11499.425028748528, 11528.36593987322, 11550.653480395602, 11555.711107222387, 5337.066013447631, 6123.0, 6292.402221788922, 6326.746930122836, 6329.113924050636, 5856.1508581255475, 5898.439648233411, 5915.438033386821, 5948.762049518057, 6010.068439391901, 4143.124318402774, 4189.601987811153, 4233.370152491251, 4262.190183865056, 4265.168292183057, 1239.9788344997596, 1263.6082814327588, 1275.8660340664283, 1279.635303938373, 1280.1487011137676, 630.5806638585381, 747.1855677311647, 759.8024513626497, 761.7828918758128, 777.2771322669859, 5655.688937108416, 5755.8561035974435, 5958.136070269787, 5994.036875641923, 6020.187274717857, 568.0882184094469, 579.9507041901401, 582.4641329976432, 583.1777194156305, 598.796409220867, 3957.56466788653, 4010.47863777707, 4030.1939612077704, 4140.109876376593, 4147.232761939051, 11564.248323858923, 13114.213147211198, 14010.229437381042, 14020.228887411085, 14037.929810350883, 13524.32378381077, 13948.651283717785, 14125.505607303696, 14138.0, 14167.858321416654, 10112.443815590066, 10389.324693894721, 10399.376037437778, 10412.271141020055, 10445.895541044645, 6321.652309123042, 6581.440577550962, 6784.491163162881, 6798.694058767268, 6818.556793808387, 11734.354610496162, 11832.230904991147, 12966.935165324114, 12974.416151273026, 12991.960643148714, 11433.1996760226, 12388.380580970736, 12427.813582796085, 12710.68223294388, 12858.807117893426, 9049.32130090259, 9072.818543629222, 9279.62881484733, 9296.860547091665, 9299.02360252191, 10185.287029907835, 10192.541335639766, 10302.536385862504, 10302.742431439274, 10332.483375831329, 8520.74437766868, 8689.435186712843, 8733.126687331216, 8743.956280218812, 8795.296376289754, 8381.832363352822, 8454.196851299117, 8497.57512124379, 8571.142885711379, 8610.225079742853, 7617.847643047219, 7821.217878212134, 7821.960890195513, 7834.099078606033, 7834.76709137893, 5243.842684719464, 5723.341815691082, 5891.410858914074, 5918.704064796829, 5932.190681841907, 4707.905841883212, 5480.972595136999, 5493.533049690821, 5522.944770552243, 5555.583331250254], "value": 5113.525193698395, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.05800990607685, 391.6494737210197, 400.1836254041753, 400.71749416661254, 403.49764543143783, 4806.399200099988, 4951.3810773653295, 5930.377310382407, 5948.7620495180145, 5951.256092988377, 5553.305836770403, 5716.28546431696, 5767.452092051259, 5873.207117039209, 5884.2056322396575, 4603.723776573416, 4610.864612063795, 4614.215583350821, 4659.650526210539, 4666.580007799297, 4569.268916973285, 4643.907121857561, 4648.9767551162195, 4661.277501987197, 4689.2966055091665, 3811.6378944000276, 4424.8185016091575, 4534.274516077428, 4641.210994130989, 4642.605378542828, 3828.7511311764647, 4517.751523666197, 4541.613962813165, 4542.136993971135, 4593.816247350102, 3320.335932813447, 3638.6907112895437, 3961.0, 4094.396930700994, 4140.37894315852, 5006.07387633289, 5298.0, 5603.159526071081, 5718.34239062509, 5830.30036395631, 5319.069162896478, 5351.598630102758, 5378.193271009341, 5385.899499195317, 5386.326709161355, 4695.389599352096, 6180.969095154541, 6269.811905642838, 6296.379581740517, 6319.842003949892, 3416.829158542063, 3972.3842804365368, 4160.895977600554, 4165.562615925314, 4520.977395113036, 5597.608167428281, 6339.968300158515, 6589.17635295588, 6590.637514936677, 6600.669966501656, 3639.8170594556873, 4224.809883555247, 4225.176090662353, 4233.1956928183545, 4236.6187043166265, 4035.7780322082567, 4282.850100246476, 4302.505211900609, 4418.823247070145, 4421.513633500313, 4233.534311225762, 4732.485604606492, 5158.432572417031, 5218.712970786567, 5246.501582349671, 6422.80645676845, 6430.0, 6431.614103153825, 6433.0, 6463.1903067141275, 1428.8142541469751, 1499.3103172540536, 1502.4966636176785, 1507.186119495482, 1520.6730552931174, 816.6774124220899, 949.8575213717997, 967.6226271754022, 1000.6347683095618, 1001.7746007148479, 5030.195168773052, 5878.941210587925, 5880.853743247342, 5917.881642367129, 5992.460678538952, 5985.910211346833, 6516.869662606721, 6542.934570654328, 6595.175603049619, 6601.834954126185, 5625.634333768292, 5937.614055086492, 5953.970230148821, 5964.196827491072, 5970.223870896755, 2886.5381538953666, 3128.9843550782102, 3262.6737326267184, 3418.880339188166, 3460.7923524588605, 6406.35936406365, 6472.3204063573585, 6745.06589633511, 6754.290799466084, 6813.557118787263, 6786.846236139868, 6791.558548694319, 6814.591124532445, 6831.487638427137, 6833.760818371333, 5650.378458369576, 6078.6048906820915, 6110.930587147232, 6843.87839769673, 6857.245702972669, 5669.86602679474, 6358.823617630753, 6443.259025212161, 6511.7395304189195, 6514.771982980573, 5402.297701298806, 6459.967700161469, 6502.219733631994, 6529.836754081186, 6552.148220731275, 5573.804916827891, 5796.710164491674, 6473.676316184266, 6810.182778066664, 6882.793516194522, 3820.4269359596283, 3950.952997455734, 4712.458067322302, 4731.668783185144, 4745.881352966066, 6391.77628783009, 6479.290529120473, 6595.505337099833, 6604.933950660624, 6647.534672572873, 6311.305756366704, 6332.240131184103, 6387.169667943138, 6438.871222575616, 6441.484681225397, 5610.354809196994, 6323.399277068671, 6336.936630633819, 6346.460550853045, 6371.522135839923, 5125.820596279113, 5514.36584792754, 6157.322694503511, 6163.3836616338, 6219.564630476004, 6348.365163483615, 6353.714082866374, 6371.228515595731, 6377.744890204525, 6383.042543618494, 5698.54411647059, 5753.2520772301, 5981.880362392815, 6144.508439324933, 6203.503719702503], "value": 4629.386157685355, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.7725305155406, 747.1855677311729, 751.3125490176488, 765.8774596064627, 769.5651956644497, 15324.540263792076, 15615.687686246296, 15842.84157158428, 15877.96793208442, 15894.523164305076, 14413.279336033209, 14579.19814410207, 14629.561113166596, 14675.192864392455, 14690.485832995848, 900.2932697832204, 980.656770130454, 1000.6697789729371, 1016.7305663999047, 1033.7725700345911, 971.0629242780715, 1007.3401921741234, 1013.0983424751939, 1019.6023550815188, 1020.8468729690532, 1076.3165389977341, 1080.9891901081007, 1082.182951871336, 1087.4019289390842, 1089.8310761831929, 1070.7323169207698, 1072.3940973350032, 1073.812082885492, 1075.2150929821196, 1075.6074032977986, 802.4984384759525, 802.5224991130268, 803.9035315762087, 804.7545498622918, 806.0045843383417, 16070.517884463368, 16245.675086498322, 16446.75329870053, 16648.916755416147, 16925.57686057846, 14606.561803145923, 14680.779788303184, 14715.307739609867, 14746.70506589873, 14833.554993350217, 11615.651530454015, 11732.17874748768, 11886.346250956194, 11946.880531194663, 12212.32832194229, 2988.2379993101836, 3019.89430369936, 3082.6763189864964, 3084.6761090085665, 3106.813591184536, 110277.44861275642, 114741.53733960037, 114892.0, 115329.0, 118385.40807295995, 10798.298110622783, 11511.597094101666, 11575.13186511015, 11614.709632259091, 11930.642080737593, 25455.236342909742, 25463.87268063648, 25463.87268063685, 25498.745012550007, 25529.106481273066, 7944.404169687296, 7969.800754981172, 8006.479578827474, 8102.797430064295, 8243.05204901444, 3978.562358140602, 4046.1705350403095, 4049.4128351389472, 4073.2668119738137, 4090.9386359204636, 4133.855315064018, 4179.791010449465, 4180.372944058355, 4211.873643790691, 4223.619874211336, 820.118372749285, 823.2714048067503, 828.349745449819, 850.7915560687547, 852.3394369363668, 542.2625229687621, 553.808935917108, 567.9687617181095, 574.9798757043484, 603.484021161909, 9595.520223988773, 10170.491475426199, 10230.079292863678, 10404.68785936423, 10459.947700261602, 541.6587549843653, 564.5596434780878, 588.690937257943, 591.2727345365139, 596.9612873599991, 4080.775767269807, 4145.54399016108, 4533.569310915458, 4696.178168820443, 4772.188727916263, 102752.0, 103521.96478035123, 104517.47741261245, 106775.46612267045, 109013.0, 86846.13153868381, 92996.0, 93339.53330233306, 94926.0, 96031.03968960221, 80727.19272807197, 81363.18636813556, 81670.73317067251, 81973.59013204896, 82937.0, 9344.672936447192, 9468.668596599086, 9480.431174129575, 9508.952455237679, 9517.666881659108, 35555.288894221456, 37185.0, 38719.225615488096, 39080.41379379368, 41153.971150720274, 61274.4681382969, 64717.67641161764, 64835.67582162059, 68663.0, 70843.64578177076, 10839.295445795999, 11977.281363118242, 12579.496820127093, 13745.862541374858, 13749.862501375259, 12371.319577422968, 14418.990670653373, 14772.0, 14964.700705986037, 15635.60910977189, 12266.570670026505, 13481.460741570227, 13742.0, 13781.931090344484, 14402.0, 13623.591292261248, 13732.65668358299, 13863.0, 13903.304834758019, 13943.4422623098, 13234.27211503338, 13455.259960702255, 14073.0, 14092.224927629079, 14296.0, 9420.95289523548, 9864.901350986685, 9953.900460995297, 9969.152622027208, 10352.171826254033, 8412.411131221, 9097.545122743704, 9926.255530835071, 11315.660530184108, 11425.31448113116], "value": 7672.993842113101, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1643.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 121.0, 120.0, 121.0, 133.0, 184.0, 155.0, 130.0, 182.0, 158.0], "value": 142.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 120.0, 122.0, 167.0, 124.0, 121.0, 119.0, 119.0, 150.0, 124.0], "value": 133.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [209.0, 210.0, 208.0, 215.0, 215.0, 219.0, 208.0, 215.0, 216.0, 215.0], "value": 213.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 66.0, 63.0, 102.0, 68.0, 66.0, 53.0, 57.0, 93.0, 93.0], "value": 75.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 75.0, 104.0, 77.0, 74.0, 77.0, 89.0, 75.0, 74.0, 92.0], "value": 83.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 93.0, 90.0, 91.0, 91.0, 92.0, 92.0, 90.0, 90.0, 92.0], "value": 91.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 100.0, 101.0, 99.0, 100.0, 101.0, 101.0, 100.0, 102.0, 100.0], "value": 100.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 99.0, 100.0, 101.0, 100.0, 100.0, 100.0, 97.0, 102.0, 102.0], "value": 100.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 64.0, 65.0, 65.0, 66.0, 65.0, 64.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 69.0, 79.0, 70.0, 72.0, 63.0, 66.0, 65.0, 69.0], "value": 67.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 93.0, 92.0, 89.0, 92.0, 91.0, 92.0, 90.0, 91.0], "value": 91.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 158.0, 151.0, 150.0, 156.0, 158.0, 172.0, 168.0, 239.0, 213.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [219.0, 256.0, 202.0, 214.0, 206.0, 208.0, 238.0, 195.0, 246.0, 240.0], "value": 222.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 103.0, 95.0, 65.0, 93.0, 102.0, 107.0, 79.0, 74.0, 76.0], "value": 87.7, "unit": "score"}]}]} 13:46:27 INFO - Return code: 0 13:46:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:46:27 ERROR - # TBPL SUCCESS # 13:46:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:46:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:46:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:46:27 INFO - 2017-03-29 13:46:27.667 screenresolution[2220:18769] starting screenresolution argv=screenresolution get 13:46:27 INFO - 2017-03-29 13:46:27.670 screenresolution[2220:18769] Display 0: 1600x1200x32@60 13:46:27 INFO - 2017-03-29 13:46:27.677 screenresolution[2221:18772] starting screenresolution argv=screenresolution list 13:46:27 INFO - Available Modes on Display 0 13:46:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:46:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:46:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:46:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:46:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:46:27 INFO - Intel Iris: 13:46:27 INFO - Chipset Model: Intel Iris 13:46:27 INFO - Type: GPU 13:46:27 INFO - Bus: Built-In 13:46:27 INFO - VRAM (Dynamic, Max): 1536 MB 13:46:27 INFO - Vendor: Intel (0x8086) 13:46:27 INFO - Device ID: 0x0a2e 13:46:27 INFO - Revision ID: 0x0009 13:46:27 INFO - Displays: 13:46:27 INFO - Display: 13:46:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:46:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:46:27 INFO - Display Serial Number: 1600x1200 60 13:46:27 INFO - Main Display: Yes 13:46:27 INFO - Mirror: Off 13:46:27 INFO - Online: Yes 13:46:27 INFO - Rotation: Supported 13:46:27 INFO - Return code: 0 13:46:27 INFO - Running post-action listener: _resource_record_post_action 13:46:27 INFO - [mozharness: 2017-03-29 20:46:27.913108Z] Finished run-tests step (success) 13:46:27 INFO - Running post-run listener: _resource_record_post_run 13:46:27 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 700416; Write bytes: 520333824; Read time: 11; Write time: 1617 13:46:27 INFO - TinderboxPrint: CPU usage
53.4% 13:46:27 INFO - TinderboxPrint: I/O read bytes / time
700,416 / 11 13:46:27 INFO - TinderboxPrint: I/O write bytes / time
520,333,824 / 1,617 13:46:27 INFO - TinderboxPrint: CPU idle
2,247.5 (46.6%) 13:46:27 INFO - TinderboxPrint: CPU system
964.5 (20.0%) 13:46:27 INFO - TinderboxPrint: CPU user
1,613.5 (33.4%) 13:46:27 INFO - TinderboxPrint: Swap in / out
212,766,720 / 0 13:46:27 INFO - install - Wall time: 21s; CPU: 55.0%; Read bytes: 202711552; Write bytes: 198711296; Read time: 15496; Write time: 419 13:46:27 INFO - run-tests - Wall time: 1186s; CPU: 53.0%; Read bytes: 700416; Write bytes: 303890944; Read time: 11; Write time: 1142 13:46:28 INFO - Running post-run listener: _upload_blobber_files 13:46:28 INFO - Blob upload gear active. 13:46:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:46:28 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 13:46:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:46:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:46:28 INFO - (blobuploader) - INFO - Open directory for files ... 13:46:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:46:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:46:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:29 INFO - (blobuploader) - INFO - Done attempting. 13:46:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:46:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:46:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:30 INFO - (blobuploader) - INFO - Done attempting. 13:46:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:46:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:46:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:31 INFO - (blobuploader) - INFO - Done attempting. 13:46:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:46:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:46:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:33 INFO - (blobuploader) - INFO - Done attempting. 13:46:33 INFO - (blobuploader) - INFO - Iteration through files over. 13:46:33 INFO - Return code: 0 13:46:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:46:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:46:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80fb066a230b9ec40b30b8d640afb4c2d18ddfc0a620cc7c43da0fde79803b3c676c053aa3e46630f3c28aba0704fe854a5e35750585f8a91776ec3595d8065c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0e88e58a25fe45d0251d10157b530d2f2f2a10c3557e12dacd5c2cc51defee7193a70d3a448ac189cbfb619e3163139c16c242f7681a20d6656fe3ba446f0ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81908dc2c060f527be123769081991c1267cd56dda71a1375a6f2148385833f3ebf07f42e5723745dd36d7e059013006c37b3d7436c66be89d4de6d8926fee93", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28f855e97202572662afa58befdd53afd1c2b634adf46c1c6160fdd638ca4375167ba724f434b915462bf7cfcbdedc1bd7fd914c280f479c35d6b713691a1b94"} 13:46:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:46:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:46:33 INFO - Contents: 13:46:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80fb066a230b9ec40b30b8d640afb4c2d18ddfc0a620cc7c43da0fde79803b3c676c053aa3e46630f3c28aba0704fe854a5e35750585f8a91776ec3595d8065c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0e88e58a25fe45d0251d10157b530d2f2f2a10c3557e12dacd5c2cc51defee7193a70d3a448ac189cbfb619e3163139c16c242f7681a20d6656fe3ba446f0ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81908dc2c060f527be123769081991c1267cd56dda71a1375a6f2148385833f3ebf07f42e5723745dd36d7e059013006c37b3d7436c66be89d4de6d8926fee93", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28f855e97202572662afa58befdd53afd1c2b634adf46c1c6160fdd638ca4375167ba724f434b915462bf7cfcbdedc1bd7fd914c280f479c35d6b713691a1b94"} 13:46:33 INFO - Running post-run listener: copy_logs_to_upload_dir 13:46:33 INFO - Copying logs to upload dir... 13:46:33 INFO - mkdir: /builds/slave/test/build/upload/logs 13:46:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.181437 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-03-29 13:46:33.606803) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 13:46:33.610401) ========= 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.xnir6frvva/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.J046t1PGVe/Listeners TMPDIR=/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80fb066a230b9ec40b30b8d640afb4c2d18ddfc0a620cc7c43da0fde79803b3c676c053aa3e46630f3c28aba0704fe854a5e35750585f8a91776ec3595d8065c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0e88e58a25fe45d0251d10157b530d2f2f2a10c3557e12dacd5c2cc51defee7193a70d3a448ac189cbfb619e3163139c16c242f7681a20d6656fe3ba446f0ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81908dc2c060f527be123769081991c1267cd56dda71a1375a6f2148385833f3ebf07f42e5723745dd36d7e059013006c37b3d7436c66be89d4de6d8926fee93", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28f855e97202572662afa58befdd53afd1c2b634adf46c1c6160fdd638ca4375167ba724f434b915462bf7cfcbdedc1bd7fd914c280f479c35d6b713691a1b94"} build_url:https://queue.taskcluster.net/v1/task/CKfA2UZ-TqifonDlm3ermQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011035 build_url: 'https://queue.taskcluster.net/v1/task/CKfA2UZ-TqifonDlm3ermQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80fb066a230b9ec40b30b8d640afb4c2d18ddfc0a620cc7c43da0fde79803b3c676c053aa3e46630f3c28aba0704fe854a5e35750585f8a91776ec3595d8065c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0e88e58a25fe45d0251d10157b530d2f2f2a10c3557e12dacd5c2cc51defee7193a70d3a448ac189cbfb619e3163139c16c242f7681a20d6656fe3ba446f0ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81908dc2c060f527be123769081991c1267cd56dda71a1375a6f2148385833f3ebf07f42e5723745dd36d7e059013006c37b3d7436c66be89d4de6d8926fee93", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28f855e97202572662afa58befdd53afd1c2b634adf46c1c6160fdd638ca4375167ba724f434b915462bf7cfcbdedc1bd7fd914c280f479c35d6b713691a1b94"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 13:46:33.644098) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 13:46:33.644416) ========= 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.xnir6frvva/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.J046t1PGVe/Listeners TMPDIR=/var/folders/2g/ml3_1wdx5nq793p95g6sr6tw00000w/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.005124 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 13:46:33.693013) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 13:46:33.693331) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 13:46:33.693653) ========= ========= Total master_lag: 0.18 =========