builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0172 starttime: 1479342505.0 results: success (0) buildid: 20161116105708 builduid: 95ba28a1f38149bd8352cfdd3edb1c19 revision: cc3d0823289f64804fce57ac51a03b0b17d0189e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-16 16:28:25.000212) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-16 16:28:25.000687) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-16 16:28:25.000986) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-16 16:28:25.023677) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 16:28:25.023969) ========= 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.TUg5PfXss6/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.4rC1Y6RXKJ/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-16 16:28:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 157M=0s 2016-11-16 16:28:25 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118153 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 16:28:25.163967) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 16:28:25.164292) ========= 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.TUg5PfXss6/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.4rC1Y6RXKJ/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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.019448 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 16:28:25.212712) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-16 16:28:25.213082) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev cc3d0823289f64804fce57ac51a03b0b17d0189e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev cc3d0823289f64804fce57ac51a03b0b17d0189e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TUg5PfXss6/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.4rC1Y6RXKJ/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-16 16:28:25,415 truncating revision to first 12 chars 2016-11-16 16:28:25,415 Setting DEBUG logging. 2016-11-16 16:28:25,415 attempt 1/10 2016-11-16 16:28:25,415 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/cc3d0823289f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-16 16:28:26,784 unpacking tar archive at: graphics-cc3d0823289f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.624614 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-16 16:28:26.860238) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-16 16:28:26.860619) ========= script_repo_revision: cc3d0823289f64804fce57ac51a03b0b17d0189e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-16 16:28:26.861074) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-16 16:28:26.861362) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-16 16:28:26.880350) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-11-16 16:28:26.880813) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TUg5PfXss6/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.4rC1Y6RXKJ/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 16:28:27 INFO - MultiFileLogger online at 20161116 16:28:27 in /builds/slave/test 16:28:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 16:28:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:28:27 INFO - {'append_to_log': False, 16:28:27 INFO - 'base_work_dir': '/builds/slave/test', 16:28:27 INFO - 'blob_upload_branch': 'Graphics', 16:28:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:28:27 INFO - 'branch': 'Graphics', 16:28:27 INFO - 'buildbot_json_path': 'buildprops.json', 16:28:27 INFO - 'config_files': ('talos/mac_config.py',), 16:28:27 INFO - 'default_actions': ('clobber', 16:28:27 INFO - 'read-buildbot-config', 16:28:27 INFO - 'download-and-extract', 16:28:27 INFO - 'populate-webroot', 16:28:27 INFO - 'create-virtualenv', 16:28:27 INFO - 'install', 16:28:27 INFO - 'run-tests'), 16:28:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:28:27 INFO - 'download_minidump_stackwalk': True, 16:28:27 INFO - 'download_symbols': 'ondemand', 16:28:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:28:27 INFO - 'tooltool.py': '/tools/tooltool.py', 16:28:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:28:27 INFO - '/tools/misc-python/virtualenv.py')}, 16:28:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:28:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:28:27 INFO - 'installer_path': 'installer.exe', 16:28:27 INFO - 'log_level': 'info', 16:28:27 INFO - 'log_name': 'talos', 16:28:27 INFO - 'log_to_console': True, 16:28:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:28:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:28:27 INFO - 'opt_config_files': (), 16:28:27 INFO - 'pip_index': False, 16:28:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:28:27 INFO - 'cmd': ('bash', 16:28:27 INFO - '-c', 16:28:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:28:27 INFO - 'enabled': True, 16:28:27 INFO - 'halt_on_failure': False, 16:28:27 INFO - 'name': 'check_screen_resolution'},), 16:28:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:28:27 INFO - 'cmd': ('bash', 16:28:27 INFO - '-c', 16:28:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:28:27 INFO - 'enabled': True, 16:28:27 INFO - 'halt_on_failure': False, 16:28:27 INFO - 'name': 'check_screen_resolution'},), 16:28:27 INFO - 'run_cmd_checks_enabled': True, 16:28:27 INFO - 'sps_profile': False, 16:28:27 INFO - 'sps_profile_interval': 0, 16:28:27 INFO - 'suite': 'dromaeojs', 16:28:27 INFO - 'system_bits': '32', 16:28:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:28:27 INFO - 'title': 't-yosemite-r7-0172', 16:28:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:28:27 INFO - 'use_talos_json': True, 16:28:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:28:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:28:27 INFO - 'work_dir': 'build'} 16:28:27 INFO - [mozharness: 2016-11-17 00:28:27.210905Z] Running clobber step. 16:28:27 INFO - Running pre-action listener: _resource_record_pre_action 16:28:27 INFO - Running main action method: clobber 16:28:27 INFO - rmtree: /builds/slave/test/build 16:28:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:28:27 INFO - Running post-action listener: _resource_record_post_action 16:28:27 INFO - [mozharness: 2016-11-17 00:28:27.584137Z] Finished clobber step (success) 16:28:27 INFO - [mozharness: 2016-11-17 00:28:27.584363Z] Running read-buildbot-config step. 16:28:27 INFO - Running pre-action listener: _resource_record_pre_action 16:28:27 INFO - Running main action method: read_buildbot_config 16:28:27 INFO - Using buildbot properties: 16:28:27 INFO - { 16:28:27 INFO - "project": "", 16:28:27 INFO - "product": "firefox", 16:28:27 INFO - "script_repo_revision": "default", 16:28:27 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 16:28:27 INFO - "repository": "", 16:28:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 16:28:27 INFO - "buildid": "20161116105708", 16:28:27 INFO - "pgo_build": "False", 16:28:27 INFO - "basedir": "/builds/slave/test", 16:28:27 INFO - "buildnumber": 2, 16:28:27 INFO - "slavename": "t-yosemite-r7-0172", 16:28:27 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 16:28:27 INFO - "platform": "yosemite_r7", 16:28:27 INFO - "scheduler": "tests-graphics-macosx64-talos", 16:28:27 INFO - "branch": "graphics", 16:28:27 INFO - "repo_path": "projects/graphics", 16:28:27 INFO - "revision": "cc3d0823289f64804fce57ac51a03b0b17d0189e", 16:28:27 INFO - "stage_platform": "macosx64", 16:28:27 INFO - "builduid": "95ba28a1f38149bd8352cfdd3edb1c19", 16:28:27 INFO - "slavebuilddir": "test" 16:28:27 INFO - } 16:28:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/DUesqtwSSKipEzq01bzPEw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 16:28:27 INFO - Running post-action listener: _resource_record_post_action 16:28:27 INFO - [mozharness: 2016-11-17 00:28:27.590032Z] Finished read-buildbot-config step (success) 16:28:27 INFO - [mozharness: 2016-11-17 00:28:27.590207Z] Running download-and-extract step. 16:28:27 INFO - Running pre-action listener: _resource_record_pre_action 16:28:27 INFO - Running main action method: download_and_extract 16:28:27 INFO - mkdir: /builds/slave/test/build/tests 16:28:27 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')]} 16:28:27 INFO - trying https://queue.taskcluster.net/v1/task/DUesqtwSSKipEzq01bzPEw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 16:28:27 INFO - Downloading https://queue.taskcluster.net/v1/task/DUesqtwSSKipEzq01bzPEw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 16:28:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DUesqtwSSKipEzq01bzPEw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 16:28:29 INFO - Downloaded 1199 bytes. 16:28:29 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 16:28:29 INFO - Using the following test package requirements: 16:28:29 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 16:28:29 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:28:29 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 16:28:29 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:28:29 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 16:28:29 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:28:29 INFO - u'jsshell-mac.zip'], 16:28:29 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:28:29 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 16:28:29 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 16:28:29 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:28:29 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 16:28:29 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:28:29 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 16:28:29 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:28:29 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 16:28:29 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:28:29 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 16:28:29 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:28:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DUesqtwSSKipEzq01bzPEw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 16:28:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DUesqtwSSKipEzq01bzPEw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:28:29 INFO - Fetch https://queue.taskcluster.net/v1/task/DUesqtwSSKipEzq01bzPEw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 16:28:29 INFO - Http code: 200 16:28:29 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 16:28:29 INFO - x-amz-cf-id: xVWkiGCVZoqPbKrHBxw4GdDYAAfdCr4CXRVdPCnEWbcCeRONDktbuQ== 16:28:29 INFO - x-amz-version-id: A7HaDupdhWzAUX_9OeHB11okJbbqKRsW 16:28:30 INFO - Expected file size: 16268141 16:28:30 INFO - Obtained file size: 16268141 16:28:36 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:28:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DUesqtwSSKipEzq01bzPEw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 16:28:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DUesqtwSSKipEzq01bzPEw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:28:36 INFO - Fetch https://queue.taskcluster.net/v1/task/DUesqtwSSKipEzq01bzPEw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 16:28:37 INFO - Http code: 200 16:28:37 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 16:28:37 INFO - x-amz-cf-id: rjjakEjg_ivhksIV02xkDRUA7PMM-zHmYomffnDUdW5TU4dUcCTn9A== 16:28:37 INFO - x-amz-version-id: A7HaDupdhWzAUX_9OeHB11okJbbqKRsW 16:28:37 INFO - Expected file size: 16268141 16:28:37 INFO - Obtained file size: 16268141 16:28:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DUesqtwSSKipEzq01bzPEw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 16:28:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DUesqtwSSKipEzq01bzPEw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:28:43 INFO - Fetch https://queue.taskcluster.net/v1/task/DUesqtwSSKipEzq01bzPEw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 16:28:45 INFO - Http code: 200 16:28:45 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 16:28:45 INFO - x-amz-cf-id: CM7Je3KQjlWTZxgts-0h1ZhB6mmr4X0PpttUbCEYU6wY8TObjTCM1A== 16:28:45 INFO - x-amz-version-id: 9dBlYqAlyX4FEvwxPsHiopA5ZHk9HMfX 16:28:45 INFO - Expected file size: 14409366 16:28:45 INFO - Obtained file size: 14409366 16:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:46 INFO - trying https://queue.taskcluster.net/v1/task/DUesqtwSSKipEzq01bzPEw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 16:28:46 INFO - Downloading https://queue.taskcluster.net/v1/task/DUesqtwSSKipEzq01bzPEw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 16:28:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DUesqtwSSKipEzq01bzPEw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 16:28:48 INFO - Downloaded 111135044 bytes. 16:28:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DUesqtwSSKipEzq01bzPEw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 16:28:48 INFO - mkdir: /builds/slave/test/properties 16:28:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:28:48 INFO - Writing to file /builds/slave/test/properties/build_url 16:28:48 INFO - Contents: 16:28:48 INFO - build_url:https://queue.taskcluster.net/v1/task/DUesqtwSSKipEzq01bzPEw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 16:28:49 INFO - Running post-action listener: _resource_record_post_action 16:28:49 INFO - Running post-action listener: set_extra_try_arguments 16:28:49 INFO - [mozharness: 2016-11-17 00:28:49.457838Z] Finished download-and-extract step (success) 16:28:49 INFO - [mozharness: 2016-11-17 00:28:49.457986Z] Running populate-webroot step. 16:28:49 INFO - Running pre-action listener: _resource_record_pre_action 16:28:49 INFO - Running main action method: populate_webroot 16:28:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:28:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:28:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:28:49 INFO - '--tppagecycles', 16:28:49 INFO - '7'], 16:28:49 INFO - 'tests': ['tsvgm']}}, 16:28:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:28:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:28:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:28:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:28:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:28:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:28:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:28:49 INFO - 'talos_options': ['--disable-e10s'], 16:28:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:28:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:28:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:28:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:28:49 INFO - 'talos_options': ['--disable-e10s'], 16:28:49 INFO - 'tests': ['damp', 'tps']}, 16:28:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:28:49 INFO - 'tests': ['damp', 'tps']}, 16:28:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:28:49 INFO - 'tests': ['dromaeo_dom']}, 16:28:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:28:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:28:49 INFO - 'tests': ['basic_compositor_video']}, 16:28:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:28:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:28:49 INFO - 'tests': ['a11yr', 16:28:49 INFO - 'ts_paint', 16:28:49 INFO - 'tpaint', 16:28:49 INFO - 'sessionrestore', 16:28:49 INFO - 'sessionrestore_no_auto_restore', 16:28:49 INFO - 'tabpaint']}, 16:28:49 INFO - 'other-e10s': {'tests': ['a11yr', 16:28:49 INFO - 'ts_paint', 16:28:49 INFO - 'tpaint', 16:28:49 INFO - 'sessionrestore', 16:28:49 INFO - 'sessionrestore_no_auto_restore', 16:28:49 INFO - 'tabpaint']}, 16:28:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:28:49 INFO - 'ts_paint', 16:28:49 INFO - 'tpaint', 16:28:49 INFO - 'sessionrestore', 16:28:49 INFO - 'sessionrestore_no_auto_restore', 16:28:49 INFO - 'tabpaint']}, 16:28:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:28:49 INFO - 'ts_paint', 16:28:49 INFO - 'tpaint', 16:28:49 INFO - 'sessionrestore', 16:28:49 INFO - 'sessionrestore_no_auto_restore', 16:28:49 INFO - 'tabpaint']}, 16:28:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:28:49 INFO - 'tests': ['a11yr', 16:28:49 INFO - 'ts_paint', 16:28:49 INFO - 'tpaint', 16:28:49 INFO - 'sessionrestore', 16:28:49 INFO - 'sessionrestore_no_auto_restore', 16:28:49 INFO - 'tabpaint']}, 16:28:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:28:49 INFO - 'tests': ['a11yr', 16:28:49 INFO - 'ts_paint', 16:28:49 INFO - 'tpaint', 16:28:49 INFO - 'sessionrestore', 16:28:49 INFO - 'sessionrestore_no_auto_restore', 16:28:49 INFO - 'tabpaint']}, 16:28:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:28:49 INFO - 'tests': ['tsvgx', 16:28:49 INFO - 'tsvgr_opacity', 16:28:49 INFO - 'tart', 16:28:49 INFO - 'tscrollx', 16:28:49 INFO - 'cart']}, 16:28:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:28:49 INFO - 'tsvgr_opacity', 16:28:49 INFO - 'tart', 16:28:49 INFO - 'tscrollx', 16:28:49 INFO - 'cart']}, 16:28:49 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:28:49 INFO - 'talos_options': ['--disable-e10s'], 16:28:49 INFO - 'tests': ['tp5o']}, 16:28:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:28:49 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:28:49 INFO - 'talos_options': ['--disable-e10s', 16:28:49 INFO - '--xperf_path', 16:28:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:28:49 INFO - 'tests': ['tp5n']}, 16:28:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:28:49 INFO - 'talos_options': ['--xperf_path', 16:28:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:28:49 INFO - 'tests': ['tp5n']}}, 16:28:49 INFO - 'talos.zip': {'path': '', 16:28:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:28:49 INFO - Running post-action listener: _resource_record_post_action 16:28:49 INFO - [mozharness: 2016-11-17 00:28:49.476628Z] Finished populate-webroot step (success) 16:28:49 INFO - [mozharness: 2016-11-17 00:28:49.476766Z] Running create-virtualenv step. 16:28:49 INFO - Running pre-action listener: _resource_record_pre_action 16:28:49 INFO - Running main action method: create_virtualenv 16:28:49 INFO - Creating virtualenv /builds/slave/test/build/venv 16:28:49 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 16:28:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:28:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:28:49 INFO - Using real prefix '/tools/python27' 16:28:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:28:50 INFO - Installing distribute.............................................................................................................................................................................................done. 16:28:53 INFO - Installing pip.................done. 16:28:53 INFO - Return code: 0 16:28:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:28:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:28:53 INFO - Reading from file tmpfile_stdout 16:28:53 INFO - Output received: 16:28:53 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) 16:28:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:28:53 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')]} 16:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:53 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')]} 16:28:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:53 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 0x10e0043f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df7a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5e2481b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de1ad30>, '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 0x10dc81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de12b20>, '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.TUg5PfXss6/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.4rC1Y6RXKJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 16:28:53 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 16:28:53 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 16:28:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUg5PfXss6/Render', 16:28:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:53 INFO - 'HOME': '/Users/cltbld', 16:28:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:53 INFO - 'LOGNAME': 'cltbld', 16:28:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:53 INFO - 'MOZ_NO_REMOTE': '1', 16:28:53 INFO - 'NO_EM_RESTART': '1', 16:28:53 INFO - 'PAGER': '/bin/cat', 16:28:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:53 INFO - 'PWD': '/builds/slave/test', 16:28:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:53 INFO - 'SHELL': '/bin/bash', 16:28:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4rC1Y6RXKJ/Listeners', 16:28:53 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 16:28:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:53 INFO - 'USER': 'cltbld', 16:28:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:53 INFO - 'XPC_FLAGS': '0x0', 16:28:53 INFO - 'XPC_SERVICE_NAME': '0', 16:28:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:53 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 16:28:53 INFO - Cleaning up... 16:28:53 INFO - Return code: 0 16:28:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:28:53 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')]} 16:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:53 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')]} 16:28:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:53 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 0x10e0043f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df7a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5e2481b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de1ad30>, '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 0x10dc81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de12b20>, '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.TUg5PfXss6/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.4rC1Y6RXKJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 16:28:53 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 16:28:53 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 16:28:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUg5PfXss6/Render', 16:28:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:53 INFO - 'HOME': '/Users/cltbld', 16:28:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:53 INFO - 'LOGNAME': 'cltbld', 16:28:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:53 INFO - 'MOZ_NO_REMOTE': '1', 16:28:53 INFO - 'NO_EM_RESTART': '1', 16:28:53 INFO - 'PAGER': '/bin/cat', 16:28:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:53 INFO - 'PWD': '/builds/slave/test', 16:28:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:53 INFO - 'SHELL': '/bin/bash', 16:28:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4rC1Y6RXKJ/Listeners', 16:28:53 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 16:28:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:53 INFO - 'USER': 'cltbld', 16:28:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:53 INFO - 'XPC_FLAGS': '0x0', 16:28:53 INFO - 'XPC_SERVICE_NAME': '0', 16:28:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:53 INFO - Downloading/unpacking psutil>=3.1.1 16:28:53 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 16:28:53 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 16:28:53 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 16:28:53 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 16:28:53 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 16:28:53 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 16:28:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:28:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:28:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:28:57 INFO - Installing collected packages: psutil 16:28:57 INFO - Running setup.py install for psutil 16:28:57 INFO - building 'psutil._psutil_osx' extension 16:28:57 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 16:28:57 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 16:28:57 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 16:28:57 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 16:28:57 INFO - building 'psutil._psutil_posix' extension 16:28:57 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 16:28:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:28:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:28:57 INFO - ^ 16:28:57 INFO - 1 warning generated. 16:28: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 16:28:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:28:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:28:58 INFO - Successfully installed psutil 16:28:58 INFO - Cleaning up... 16:28:58 INFO - Return code: 0 16:28:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0043f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df7a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5e2481b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de1ad30>, '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 0x10dc81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de12b20>, '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.TUg5PfXss6/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.4rC1Y6RXKJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 16:28:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:28:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUg5PfXss6/Render', 16:28:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:58 INFO - 'HOME': '/Users/cltbld', 16:28:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:58 INFO - 'LOGNAME': 'cltbld', 16:28:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:58 INFO - 'MOZ_NO_REMOTE': '1', 16:28:58 INFO - 'NO_EM_RESTART': '1', 16:28:58 INFO - 'PAGER': '/bin/cat', 16:28:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:58 INFO - 'PWD': '/builds/slave/test', 16:28:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:58 INFO - 'SHELL': '/bin/bash', 16:28:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4rC1Y6RXKJ/Listeners', 16:28:58 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 16:28:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:58 INFO - 'USER': 'cltbld', 16:28:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:58 INFO - 'XPC_FLAGS': '0x0', 16:28:58 INFO - 'XPC_SERVICE_NAME': '0', 16:28:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:29:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:29:01 INFO - Installing collected packages: mozsystemmonitor 16:29:01 INFO - Running setup.py install for mozsystemmonitor 16:29:01 INFO - Successfully installed mozsystemmonitor 16:29:01 INFO - Cleaning up... 16:29:01 INFO - Return code: 0 16:29:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:29:01 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')]} 16:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:01 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')]} 16:29:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:01 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 0x10e0043f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df7a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5e2481b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de1ad30>, '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 0x10dc81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de12b20>, '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.TUg5PfXss6/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.4rC1Y6RXKJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 16:29:01 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 16:29:01 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 16:29:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUg5PfXss6/Render', 16:29:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:29:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:29:01 INFO - 'HOME': '/Users/cltbld', 16:29:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:29:01 INFO - 'LOGNAME': 'cltbld', 16:29:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:01 INFO - 'MOZ_NO_REMOTE': '1', 16:29:01 INFO - 'NO_EM_RESTART': '1', 16:29:01 INFO - 'PAGER': '/bin/cat', 16:29:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:29:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:01 INFO - 'PWD': '/builds/slave/test', 16:29:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:29:01 INFO - 'SHELL': '/bin/bash', 16:29:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4rC1Y6RXKJ/Listeners', 16:29:01 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 16:29:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:29:01 INFO - 'USER': 'cltbld', 16:29:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:29:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:29:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:01 INFO - 'XPC_FLAGS': '0x0', 16:29:01 INFO - 'XPC_SERVICE_NAME': '0', 16:29:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:29:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:01 INFO - Downloading/unpacking jsonschema==2.5.1 16:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:29:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:29:04 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 16:29:04 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 16:29:04 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 16:29:04 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 16:29:04 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 16:29:04 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 16:29:04 INFO - Downloading functools32-3.2.3-2.tar.gz 16:29:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:29:04 INFO - warning: no files found matching '*.txt' 16:29:04 INFO - no previously-included directories found matching 'build' 16:29:04 INFO - no previously-included directories found matching 'dist' 16:29:04 INFO - no previously-included directories found matching '.git*' 16:29:04 INFO - Installing collected packages: jsonschema, functools32 16:29:04 INFO - Running setup.py install for functools32 16:29:04 INFO - warning: no files found matching '*.txt' 16:29:04 INFO - no previously-included directories found matching 'build' 16:29:04 INFO - no previously-included directories found matching 'dist' 16:29:04 INFO - no previously-included directories found matching '.git*' 16:29:04 INFO - Successfully installed jsonschema functools32 16:29:04 INFO - Cleaning up... 16:29:04 INFO - Return code: 0 16:29:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:29: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')]} 16:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29: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')]} 16:29:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:04 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 0x10e0043f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df7a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5e2481b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de1ad30>, '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 0x10dc81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de12b20>, '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.TUg5PfXss6/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.4rC1Y6RXKJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 16:29:04 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 16:29:04 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 16:29:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUg5PfXss6/Render', 16:29:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:29:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:29:04 INFO - 'HOME': '/Users/cltbld', 16:29:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:29:04 INFO - 'LOGNAME': 'cltbld', 16:29:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:04 INFO - 'MOZ_NO_REMOTE': '1', 16:29:04 INFO - 'NO_EM_RESTART': '1', 16:29:04 INFO - 'PAGER': '/bin/cat', 16:29:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:29:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:04 INFO - 'PWD': '/builds/slave/test', 16:29:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:29:04 INFO - 'SHELL': '/bin/bash', 16:29:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4rC1Y6RXKJ/Listeners', 16:29:04 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 16:29:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:29:04 INFO - 'USER': 'cltbld', 16:29:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:29:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:29:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:04 INFO - 'XPC_FLAGS': '0x0', 16:29:04 INFO - 'XPC_SERVICE_NAME': '0', 16:29:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:29:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:29:05 INFO - Cleaning up... 16:29:05 INFO - Return code: 0 16:29:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:29: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')]} 16:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29: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')]} 16:29:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29: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 0x10e0043f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df7a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5e2481b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de1ad30>, '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 0x10dc81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de12b20>, '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.TUg5PfXss6/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.4rC1Y6RXKJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 16:29: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 16:29: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 16:29:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUg5PfXss6/Render', 16:29:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:29:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:29:05 INFO - 'HOME': '/Users/cltbld', 16:29:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:29:05 INFO - 'LOGNAME': 'cltbld', 16:29:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:05 INFO - 'MOZ_NO_REMOTE': '1', 16:29:05 INFO - 'NO_EM_RESTART': '1', 16:29:05 INFO - 'PAGER': '/bin/cat', 16:29:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:29:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:05 INFO - 'PWD': '/builds/slave/test', 16:29:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:29:05 INFO - 'SHELL': '/bin/bash', 16:29:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4rC1Y6RXKJ/Listeners', 16:29:05 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 16:29:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:29:05 INFO - 'USER': 'cltbld', 16:29:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:29:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:29:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:05 INFO - 'XPC_FLAGS': '0x0', 16:29:05 INFO - 'XPC_SERVICE_NAME': '0', 16:29:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:29:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:05 INFO - Downloading/unpacking blobuploader==1.2.4 16:29: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 16:29: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 16:29: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 16:29: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 16:29: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 16:29: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 16:29:07 INFO - Downloading blobuploader-1.2.4.tar.gz 16:29:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:29:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:29: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 16:29: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 16:29: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 16:29: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 16:29: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 16:29: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 16:29:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:29:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:29: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 16:29: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 16:29: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 16:29: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 16:29: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 16:29: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 16:29:09 INFO - Downloading docopt-0.6.1.tar.gz 16:29:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:29:09 INFO - Installing collected packages: blobuploader, requests, docopt 16:29:09 INFO - Running setup.py install for blobuploader 16:29:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:29:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:29:09 INFO - Running setup.py install for requests 16:29:09 INFO - Running setup.py install for docopt 16:29:10 INFO - Successfully installed blobuploader requests docopt 16:29:10 INFO - Cleaning up... 16:29:10 INFO - Return code: 0 16:29:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:29: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')]} 16:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29: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')]} 16:29:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29: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 0x10e0043f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df7a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5e2481b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de1ad30>, '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 0x10dc81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de12b20>, '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.TUg5PfXss6/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.4rC1Y6RXKJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 16:29: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 16:29: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 16:29:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUg5PfXss6/Render', 16:29:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:29:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:29:10 INFO - 'HOME': '/Users/cltbld', 16:29:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:29:10 INFO - 'LOGNAME': 'cltbld', 16:29:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:10 INFO - 'MOZ_NO_REMOTE': '1', 16:29:10 INFO - 'NO_EM_RESTART': '1', 16:29:10 INFO - 'PAGER': '/bin/cat', 16:29:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:29:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:10 INFO - 'PWD': '/builds/slave/test', 16:29:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:29:10 INFO - 'SHELL': '/bin/bash', 16:29:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4rC1Y6RXKJ/Listeners', 16:29:10 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 16:29:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:29:10 INFO - 'USER': 'cltbld', 16:29:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:29:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:29:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:10 INFO - 'XPC_FLAGS': '0x0', 16:29:10 INFO - 'XPC_SERVICE_NAME': '0', 16:29:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:29:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:29:10 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-2KawnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:29:10 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-ibrdMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:29:10 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-dj5Mv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:29:10 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-EO02_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:29:10 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-jupq9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:29:10 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-LUiiRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:29:11 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-2vO22m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:29:11 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-EbHXoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:29:11 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-HeoZPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:29:11 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-C5mvL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:29:11 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-26wJtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:29:11 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-wyFphJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:29:11 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-RrVH3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:29:11 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-L0MHfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:11 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-KorRin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:29:11 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-CjnoXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:29:12 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-edr3Sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:29:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:29:12 INFO - Running setup.py install for manifestparser 16:29:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:29:12 INFO - Running setup.py install for mozcrash 16:29:12 INFO - Running setup.py install for mozdebug 16:29:12 INFO - Running setup.py install for mozdevice 16:29:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:29:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:29:12 INFO - Running setup.py install for mozfile 16:29:12 INFO - Running setup.py install for mozhttpd 16:29:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:29:13 INFO - Running setup.py install for mozinfo 16:29:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:29:13 INFO - Running setup.py install for mozInstall 16:29:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:29:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:29:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:29:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:29:13 INFO - Running setup.py install for mozleak 16:29:13 INFO - Running setup.py install for mozlog 16:29:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:29:13 INFO - Running setup.py install for moznetwork 16:29:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:29:13 INFO - Running setup.py install for mozprocess 16:29:13 INFO - Running setup.py install for mozprofile 16:29:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:29:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:29:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:29:14 INFO - Running setup.py install for mozrunner 16:29:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:29:14 INFO - Running setup.py install for mozscreenshot 16:29:14 INFO - Running setup.py install for moztest 16:29:14 INFO - Running setup.py install for mozversion 16:29:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:29:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:29:14 INFO - Cleaning up... 16:29:14 INFO - Return code: 0 16:29:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:29: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')]} 16:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29: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')]} 16:29:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29: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 0x10e0043f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df7a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5e2481b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de1ad30>, '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 0x10dc81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de12b20>, '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.TUg5PfXss6/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.4rC1Y6RXKJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 16:29: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 16:29: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 16:29:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUg5PfXss6/Render', 16:29:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:29:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:29:14 INFO - 'HOME': '/Users/cltbld', 16:29:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:29:14 INFO - 'LOGNAME': 'cltbld', 16:29:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:14 INFO - 'MOZ_NO_REMOTE': '1', 16:29:14 INFO - 'NO_EM_RESTART': '1', 16:29:14 INFO - 'PAGER': '/bin/cat', 16:29:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:29:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:14 INFO - 'PWD': '/builds/slave/test', 16:29:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:29:14 INFO - 'SHELL': '/bin/bash', 16:29:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4rC1Y6RXKJ/Listeners', 16:29:14 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 16:29:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:29:14 INFO - 'USER': 'cltbld', 16:29:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:29:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:29:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:14 INFO - 'XPC_FLAGS': '0x0', 16:29:14 INFO - 'XPC_SERVICE_NAME': '0', 16:29:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:29:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:29:15 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-9aQOta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:29: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)) 16:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:29:15 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-rJVOkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:29: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)) 16:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:29:15 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-81ZrPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:29: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)) 16:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:29:15 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-ZFyMep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:29:15 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-arZKZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:29: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)) 16:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:29:15 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-Y8e1wa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:29: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)) 16:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:29:15 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-xbV5_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:29: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)) 16:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:29:15 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-Ms80kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:29:15 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)) 16:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:29:15 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-6QDPPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:29:15 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)) 16:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:29:16 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-NC4m1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:29: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)) 16:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:29:16 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-_31wPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:29: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)) 16:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:29:16 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-T2RmrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:29:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 16:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:29:16 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-e590Wk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:29: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)) 16:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:29:16 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-PMx6jv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:29: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)) 16:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:16 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-BmSfMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:29: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)) 16:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:29:16 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-5PTqUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:29:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:29:16 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-DW_HNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:29:16 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)) 16:29:16 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)) 16:29:16 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)) 16:29:16 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)) 16:29:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:29:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:29:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:19 INFO - Downloading blessings-1.6.tar.gz 16:29:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:29:19 INFO - Installing collected packages: blessings 16:29:19 INFO - Running setup.py install for blessings 16:29:19 INFO - Successfully installed blessings 16:29:19 INFO - Cleaning up... 16:29:19 INFO - Return code: 0 16:29:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:29:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:29:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:29:19 INFO - Reading from file tmpfile_stdout 16:29:19 INFO - Current package versions: 16:29:19 INFO - blessings == 1.6 16:29:19 INFO - blobuploader == 1.2.4 16:29:19 INFO - docopt == 0.6.1 16:29:19 INFO - functools32 == 3.2.3-2 16:29:19 INFO - jsonschema == 2.5.1 16:29:19 INFO - manifestparser == 1.1 16:29:19 INFO - mozInstall == 1.12 16:29:19 INFO - mozcrash == 1.0 16:29:19 INFO - mozdebug == 0.1 16:29:19 INFO - mozdevice == 0.48 16:29:19 INFO - mozfile == 1.2 16:29:19 INFO - mozhttpd == 0.7 16:29:19 INFO - mozinfo == 0.9 16:29:19 INFO - mozleak == 0.1 16:29:19 INFO - mozlog == 3.4 16:29:19 INFO - moznetwork == 0.27 16:29:19 INFO - mozprocess == 0.23 16:29:19 INFO - mozprofile == 0.28 16:29:19 INFO - mozrunner == 6.13 16:29:19 INFO - mozscreenshot == 0.1 16:29:19 INFO - mozsystemmonitor == 0.3 16:29:19 INFO - moztest == 0.7 16:29:19 INFO - mozversion == 1.4 16:29:19 INFO - psutil == 3.1.1 16:29:19 INFO - requests == 1.2.3 16:29:19 INFO - wsgiref == 0.1.2 16:29:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:19 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 0x10e0043f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df7a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5e2481b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de1ad30>, '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 0x10dc81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de12b20>, '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.TUg5PfXss6/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.4rC1Y6RXKJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 16:29:19 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 16:29: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 16:29:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUg5PfXss6/Render', 16:29:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:29:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:29:20 INFO - 'HOME': '/Users/cltbld', 16:29:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:29:20 INFO - 'LOGNAME': 'cltbld', 16:29:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:20 INFO - 'MOZ_NO_REMOTE': '1', 16:29:20 INFO - 'NO_EM_RESTART': '1', 16:29:20 INFO - 'PAGER': '/bin/cat', 16:29:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:29:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:20 INFO - 'PWD': '/builds/slave/test', 16:29:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:29:20 INFO - 'SHELL': '/bin/bash', 16:29:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4rC1Y6RXKJ/Listeners', 16:29:20 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 16:29:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:29:20 INFO - 'USER': 'cltbld', 16:29:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:29:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:29:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:20 INFO - 'XPC_FLAGS': '0x0', 16:29:20 INFO - 'XPC_SERVICE_NAME': '0', 16:29:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:29:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29: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)) 16:29: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)) 16:29: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)) 16:29: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)) 16:29: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)) 16:29: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)) 16:29: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)) 16:29: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)) 16:29: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)) 16:29: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)) 16:29: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)) 16:29:20 INFO - Cleaning up... 16:29:20 INFO - Return code: 0 16:29:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:29: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')]} 16:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29: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')]} 16:29:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29: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 0x10e0043f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df7a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5e2481b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de1ad30>, '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 0x10dc81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de12b20>, '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.TUg5PfXss6/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.4rC1Y6RXKJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 16:29: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 16:29: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 16:29:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUg5PfXss6/Render', 16:29:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:29:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:29:20 INFO - 'HOME': '/Users/cltbld', 16:29:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:29:20 INFO - 'LOGNAME': 'cltbld', 16:29:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:20 INFO - 'MOZ_NO_REMOTE': '1', 16:29:20 INFO - 'NO_EM_RESTART': '1', 16:29:20 INFO - 'PAGER': '/bin/cat', 16:29:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:29:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:20 INFO - 'PWD': '/builds/slave/test', 16:29:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:29:20 INFO - 'SHELL': '/bin/bash', 16:29:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4rC1Y6RXKJ/Listeners', 16:29:20 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 16:29:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:29:20 INFO - 'USER': 'cltbld', 16:29:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:29:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:29:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:20 INFO - 'XPC_FLAGS': '0x0', 16:29:20 INFO - 'XPC_SERVICE_NAME': '0', 16:29:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:29:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:29:20 INFO - Cleaning up... 16:29:20 INFO - Return code: 0 16:29:20 INFO - Running post-action listener: _resource_record_post_action 16:29:20 INFO - Running post-action listener: _start_resource_monitoring 16:29:20 INFO - Starting resource monitoring. 16:29:20 INFO - [mozharness: 2016-11-17 00:29:20.558227Z] Finished create-virtualenv step (success) 16:29:20 INFO - [mozharness: 2016-11-17 00:29:20.559217Z] Running install step. 16:29:20 INFO - Running pre-action listener: _resource_record_pre_action 16:29:20 INFO - Running main action method: install 16:29:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:29:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:29:20 INFO - Reading from file tmpfile_stdout 16:29:20 INFO - Detecting whether we're running mozinstall >=1.0... 16:29:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:29:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:29:20 INFO - Reading from file tmpfile_stdout 16:29:20 INFO - Output received: 16:29:20 INFO - Usage: mozinstall [options] installer 16:29:20 INFO - Options: 16:29:20 INFO - -h, --help show this help message and exit 16:29:20 INFO - -d DEST, --destination=DEST 16:29:20 INFO - Directory to install application into. [default: 16:29:20 INFO - "/builds/slave/test"] 16:29:20 INFO - --app=APP Application being installed. [default: firefox] 16:29:20 INFO - mkdir: /builds/slave/test/build/application 16:29:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:29:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:29:54 INFO - Reading from file tmpfile_stdout 16:29:54 INFO - Output received: 16:29:54 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:29:54 INFO - Running post-action listener: _resource_record_post_action 16:29:54 INFO - [mozharness: 2016-11-17 00:29:54.519234Z] Finished install step (success) 16:29:54 INFO - [mozharness: 2016-11-17 00:29:54.519374Z] Running run-tests step. 16:29:54 INFO - Running pre-action listener: _resource_record_pre_action 16:29:54 INFO - Running main action method: run_tests 16:29:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:29:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:29:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:29:54 INFO - 2016-11-16 16:29:54.533 screenresolution[2223:278731] starting screenresolution argv=screenresolution get 16:29:54 INFO - 2016-11-16 16:29:54.536 screenresolution[2223:278731] Display 0: 1600x1200x32@60 16:29:54 INFO - 2016-11-16 16:29:54.542 screenresolution[2224:278733] starting screenresolution argv=screenresolution list 16:29:54 INFO - Available Modes on Display 0 16:29:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:29:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:29:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:29:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:29:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:29:54 INFO - Intel Iris: 16:29:54 INFO - Chipset Model: Intel Iris 16:29:54 INFO - Type: GPU 16:29:54 INFO - Bus: Built-In 16:29:54 INFO - VRAM (Dynamic, Max): 1536 MB 16:29:54 INFO - Vendor: Intel (0x8086) 16:29:54 INFO - Device ID: 0x0a2e 16:29:54 INFO - Revision ID: 0x0009 16:29:54 INFO - Displays: 16:29:54 INFO - Display: 16:29:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:29:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:29:54 INFO - Display Serial Number: 1600x1200 60 16:29:54 INFO - Main Display: Yes 16:29:54 INFO - Mirror: Off 16:29:54 INFO - Online: Yes 16:29:54 INFO - Rotation: Supported 16:29:54 INFO - Return code: 0 16:29:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:29:54 INFO - Python 2.7.3 16:29:54 INFO - Return code: 0 16:29:54 INFO - grabbing minidump binary from tooltool 16:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:54 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 0x10de1ad30>, '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 0x10dc81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de12b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:29:54 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 16:29:54 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 16:29:54 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 16:29:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:29:54 INFO - Return code: 0 16:29:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:29:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:29:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:29:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:29:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:29:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DUesqtwSSKipEzq01bzPEw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0172', '--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 16:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DUesqtwSSKipEzq01bzPEw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0172 --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 16:29:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUg5PfXss6/Render', 16:29:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:29:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:29:54 INFO - 'HOME': '/Users/cltbld', 16:29:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:29:54 INFO - 'LOGNAME': 'cltbld', 16:29:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:29:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:54 INFO - 'MOZ_NO_REMOTE': '1', 16:29:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:29:54 INFO - 'NO_EM_RESTART': '1', 16:29:54 INFO - 'PAGER': '/bin/cat', 16:29:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:54 INFO - 'PWD': '/builds/slave/test', 16:29:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:29:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:29:54 INFO - 'SHELL': '/bin/bash', 16:29:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4rC1Y6RXKJ/Listeners', 16:29:54 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 16:29:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:29:54 INFO - 'USER': 'cltbld', 16:29:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:29:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:54 INFO - 'XPC_FLAGS': '0x0', 16:29:54 INFO - 'XPC_SERVICE_NAME': '0', 16:29:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:29:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DUesqtwSSKipEzq01bzPEw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0172', '--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 16:29:55 INFO - mozversion application_buildid: 20161116105708 16:29:55 INFO - mozversion application_changeset: cc3d0823289f64804fce57ac51a03b0b17d0189e 16:29:55 INFO - mozversion application_display_name: Nightly 16:29:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:29:55 INFO - mozversion application_name: Firefox 16:29:55 INFO - mozversion application_remotingname: firefox 16:29:55 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 16:29:55 INFO - mozversion application_vendor: Mozilla 16:29:55 INFO - mozversion application_version: 53.0a1 16:29:55 INFO - mozversion platform_buildid: 20161116105708 16:29:55 INFO - mozversion platform_changeset: cc3d0823289f64804fce57ac51a03b0b17d0189e 16:29:55 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 16:29:55 INFO - mozversion platform_version: 53.0a1 16:29:55 INFO - using testdate: 1479342595 16:29:55 INFO - actual date: 1479342595 16:29:55 INFO - starting webserver on 'localhost:49445' 16:29:55 INFO - SUITE-START | Running 2 tests 16:29:55 INFO - TEST-START | dromaeo_css 16:29:55 INFO - operating with platform_type : mac_ 16:29:55 INFO - Initialising browser for dromaeo_css test... 16:29:55 INFO - TEST-INFO | started process 2234 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmps0vdiL/profile http://localhost:49445/getInfo.html) 16:29:57 INFO - PROCESS | 2234 | __metrics Screen width/height:1600/1200 16:29:57 INFO - PROCESS | 2234 | colorDepth:24 16:29:57 INFO - PROCESS | 2234 | Browser inner width/height: 1024/689 16:29:57 INFO - PROCESS | 2234 | __metrics 16:29:57 INFO - PROCESS | 2234 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:29:57 INFO - PROCESS | 2234 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:29:58 INFO - TEST-INFO | 2234: exit 0 16:29:58 INFO - Browser initialized. 16:29:58 INFO - Running cycle 1/1 for dromaeo_css test... 16:29:58 INFO - TEST-INFO | started process 2237 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmps0vdiL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:30:10 INFO - PROCESS | 2237 | RSS: Main: 237821952 16:30:10 INFO - PROCESS | 2237 | 16:31:02 INFO - PROCESS | 2237 | 1479342662190 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:33:14 INFO - PROCESS | 2237 | Cycle 1(1): loaded http://localhost:49445/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49445/tests/dromaeo/cssquery-ext.html) 16:33:16 INFO - PROCESS | 2237 | RSS: Main: 409903104 16:33:16 INFO - PROCESS | 2237 | 16:36:19 INFO - PROCESS | 2237 | Cycle 1(1): loaded http://localhost:49445/tests/dromaeo/cssquery-ext.html (next: http://localhost:49445/tests/dromaeo/cssquery-jquery.html) 16:36:20 INFO - PROCESS | 2237 | RSS: Main: 373125120 16:36:20 INFO - PROCESS | 2237 | 16:39:22 INFO - PROCESS | 2237 | Cycle 1(1): loaded http://localhost:49445/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49445/tests/dromaeo/cssquery-mootools.html) 16:39:23 INFO - PROCESS | 2237 | RSS: Main: 359587840 16:39:23 INFO - PROCESS | 2237 | 16:42:25 INFO - PROCESS | 2237 | Cycle 1(1): loaded http://localhost:49445/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49445/tests/dromaeo/cssquery-prototype.html) 16:42:26 INFO - PROCESS | 2237 | RSS: Main: 339374080 16:42:26 INFO - PROCESS | 2237 | 16:45:29 INFO - PROCESS | 2237 | Cycle 1(1): loaded http://localhost:49445/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49445/tests/dromaeo/cssquery-yui.html) 16:45:30 INFO - PROCESS | 2237 | RSS: Main: 334692352 16:45:30 INFO - PROCESS | 2237 | 16:48:33 INFO - PROCESS | 2237 | Cycle 1(1): loaded http://localhost:49445/tests/dromaeo/cssquery-yui.html (next: http://localhost:49445/tests/dromaeo/cssquery-dojo.html) 16:48:33 INFO - PROCESS | 2237 | RSS: Main: 563736576 16:48:33 INFO - PROCESS | 2237 | 16:48:33 INFO - PROCESS | 2237 | __start_tp_report 16:48:33 INFO - PROCESS | 2237 | _x_x_mozilla_page_load 16:48:33 INFO - PROCESS | 2237 | _x_x_mozilla_page_load_details 16:48:33 INFO - PROCESS | 2237 | |i|pagename|runs| 16:48:33 INFO - PROCESS | 2237 | |0;dojo.html;3305.7355411567073;3326.7504937129706;3339.1652086978247;3348.9665103348957;3374.713149382302;5596.972015139929;5601.887962240753;5687.886242275163;5727.742251598673;5737.282839645044;5675.971620141893;5694.2312787773635;5719.513841323493;5719.6854173020465;5732.828015159542;5141.177411614142;5180.171172612383;5182.274481572583;5199.428062913076;5213.165893457048;5258.106121959257;5270.262163297141;5288.233206185101;5288.444713305105;5292.841214763564;5141.0489059523925;5155.432902380754;5187.3775146982225;5200.375954885419;5273.419923808378;5205.063088644061;5224.033553792523;5245.396779370383;5263.578913686896;5295.708736019517;5022.77397517109;5058.645894787366;5077.974610126963;5178.093833579109;5201.141811601081;5591.384947655754;5637.408072152447;5662.405447428043;5667.546596272288;5669.886602267931;6221.160143380631;6230.937690623126;6234.376562343775;6251.374862513758;6254.562180647356;5306.787728490855;5451.563874889999;6133.254817025391;6193.380661933816;6308.053791931201;5745.396733343023;5779.479846813807;5796.275465566804;5825.941740582624;5843.444872737083;6217.036359364306;6247.344028876993;6276.905846412307;6278.0269058296035;6324.3991820776955;6011.669358185254;6090.873188460149;6162.476189523851;6162.691865406712;6163.075538669235;6139.447449729546;6144.109104179869;6161.784337548164;6193.81418557444;6197.225346831646;5111.718855462911;5178.766955487012;6198.411150940653;6199.3490683478485;6204.348543402878;5682.664573825148;6150.661713605795;6209.441150296495;6216.471599913967;6232.376762323822;4784.760761961888;4875.24433712775;4879.926801097987;4880.438749543777;4918.1884988977135;4380.123975204971;4381.5618438155925;4382.715123516961;4438.489573699001;4468.128714900563;5650.576206784508;5716.771329146787;5744.109663002241;5759.992001399822;5772.624779389326;6087.269527656709;6097.725602347905;6136.21274067861;6201.596896201822;6231.844203894939;5676.176954341598;5718.628289161191;5730.398308177665;5755.165501002331;5801.448862358069;5383.138697808332;5384.003959267548;5389.595780316492;5392.056390131711;5392.352917649829;6159.353267906805;6297.842553936188;6298.08677741734;6298.559100862895;6316.842078948063;6122.387761223842;6135.202044401795;6150.323464418821;6196.721147548281;6200.534959877937;5327.360716714019;6300.936990630035;6303.621782693053;6312.084747711648;6321.747130114744;6119.265688117454;6171.105189747372;6178.876422471615;6182.536309776875;6187.474064704551;6101.816945491642;6108.281362586102;6122.642120310999;6131.601445906002;6168.365721567314;5863.736131874161;6035.577509574287;6103.640733310809;6126.203593532812;6142.477889379453;5966.373530779206;5979.760809567742;5999.52003839683;6002.549808764273;6006.639601623917;5754.223179870663;5815.06958886593;5824.3593204748295;5883;5886.38192989747;5960.5827592068135;5984.970075149597;6011.7595296187665;6048.818535443944;6051.364606716232;5729.885402292014;5921.7631294747725;5928.3775203603;5959.22530071088;5978.940210597838 16:48:33 INFO - PROCESS | 2237 | |1;ext.html;453.2566590791103;465.52051387071305;477.5534874891975;478.05583971656006;505.2547492448638;29933.850330748344;31242.68757312429;31278;35061.12347191315;38931.41602875959;39695.60304396955;40061.39907901384;40102.598974010325;40123;40206.39690404639;7781.8832717509285;9305.674301399453;9323.487208203545;9323.95338023309;9349.485778282191;9196.908030919672;9281.489518076503;9283.11810378013;9288.21050210733;9321.766955826091;9282.071792820732;9349.111834375723;9352.625894964192;9355.158035776778;9372.250219982385;7962.960185199095;9264.907350926473;9311.394759340621;9336.579853906522;9379.812403751956;9122.680706175319;9203.631854725803;9204.677836275765;9205.53972301389;9210.769730756718;37810.62189378126;38132;38217;38243.8087809562;38267.61732382696;3251.7723759336855;3283.9343213135844;3284.9340483265364;3526.717862571014;3898.9805050974564;28675.283117922012;29099;29338.853305733333;30049.549256761165;30135;3180.4275230458506;3238.5789847319934;3284.2282063715006;3310.6027276726704;3319.4356959316974;466872;469259;471543;471798;472196;53839.923201536534;54262;54299;54313;54349.45650543444;33299.167520812174;34314.31371372558;56640.716796415756;56678.7166064167;56884;15392.61518462025;15395.461158859385;15597.220138993005;15606.453774117852;15633.062016278833;11945.88054119465;12056.457459414347;12064.879351206551;12068.758624827455;12081.758364832654;17989.010604416882;18060.9096954517;18147.54631134206;18165.273389064554;18248.178831952595;7423.962880185564;7593.886091708629;7668.846623067619;7695.037765369795;7714.53712777224;860.7374750701097;961.1925982174866;969.6266937229077;999.7000899730052;1022.6420752736632;21871.234506792185;25294.11470598557;28648.427031459254;28654.411398395605;28814.42371152565;943.7027336389016;984.7538115471132;1021.2340744441668;1023.4166525080633;1082.610260306289;14512.927435362966;14546.854531454761;14736.82105431563;14807.555773326818;15184.392624294904;626857;629915;631030;631367;632100;54112.96531450886;54662.52730826728;54856.451435485935;54940.45059549353;54992.45007549953;1187.7743228786676;1260.9684757881125;1326.316946772413;1364.6315494816345;1389.2081513537187;28552.428951421272;29511.704882950897;29717.85141074281;30158;30415.695843041285;45201;45648.08703825971;45701.77149114233;45705;45757.31364029609;480179;481743;482909;483144;483488.58255708497;21115.366539003855;22159.335219942783;22792.544149116595;24459.75540244575;25219.621705674064;43595.78202109096;43674.36580057637;43833.56166438422;44541.10917781561;44630.55369446264;36169.0957726059;36215.818920906284;36305.092372690895;37224.69713560012;37328.066798330256;35737.28525429425;35944.93041451872;36595.45106823453;37139.88580342594;37405.06487337838;35428.114297142776;36107;36383.45424818683;36448.27103457969;36832.26335473329;25931.74068259369;28724.712752872205;31243.750249989745;31436.685633143377;32091.839540802146;24174.62673884482;24359.391015224763;24546.87726561356;24965.750342496343;24981.000759970124 16:48:33 INFO - PROCESS | 2237 | |2;jquery.html;349.067988470783;365.8829174664107;368.73451115197065;381.4792807817328;396.9662578680812;14539.345729442173;15020.173890436035;15387.230638468074;19613.019349032562;20069.996500175006;18573.90713046433;18913.814639020733;19513.12190951407;19735.013249337513;19935.900320498415;5572.972135139318;5910.67491287979;5915.763369465216;5917.497012753921;5922.496587790021;5388.353397592275;5803.854903627422;5857.8828423431505;5863;5864.970675146618;5656.91514627281;5822.796202132926;5838.41615838417;6001.069834175688;6019.879602407949;5982.102684597302;6025.789097381615;6026.126211699301;6029.909551356734;6032.758689652409;4989.101961646902;5258.6581872178185;5331.733413329357;5373.731313434313;5373.811916582901;11900.880991190064;12211.023118150526;12721.236725796482;17051;23583.76416235833;2118.3447260280814;2139.3474990128007;2227.5099478114953;2334.054707843326;2697.1638791974356;9541.742626676281;9584.760380990461;9625.133737963617;10102.444365559892;10136.493175341204;1762.594603241249;1820.3537744100918;1846.5106598079149;1848.3161230344724;1860.2930886263134;77804.61097694532;100388;102199.48900255526;102253;102471.48764256206;9815.852762208573;10910.727231819268;11046.061084807721;11062.723431914266;11313;14012;14027.228502432261;14040.648983775283;14060.578182654537;14067.71864562703;7926.365890728728;8105.432619716681;8107.108218096005;8203;8203.876941845758;7919.722809701633;7948.920510794934;7958.0848202457455;8091.029076510738;8113.797155071171;3637;3714.5728241252064;4333.5883091106925;4346.087321662423;4399.802008909607;1805.7110862261975;1869.6634605770819;1894.9905250473935;1908.9809101908804;1910.1881700277604;781.8944442500303;829.0672992883007;845.2899564365962;957.5595226195888;968.1431932739436;19335.613287734446;19727.112279947436;20629.277975270794;20725.481862953548;21097.894510527654;844.7465760271893;861.160368640583;889.888763904512;897.2463130969886;968.8982656821073;10408;10818;10858.239923205458;10899.455027248607;10951.288166269327;513377;516118;517843;531900;533874.2657167854;110470;116092.41953790178;118967.40516297364;119803;122227.38886305512;869.5174178331087;963.797602503468;976.9902300977042;1011.8583398324093;1012.1245122968579;13014.349282536024;16744.41394551185;17225.483235502954;18411;19340;49541.752291238314;50379.74810125926;51647.22529161991;52244.21633675574;52836.20745688741;71613;72174.63912680403;72503;73477;75175;5869.618474799125;7471.850562988601;7637.236276372319;7815.101263354787;7888.329491993015;8621.353398495012;10724.249302548747;11925.821112683143;12194.695132621755;12305.815412768994;9774.951125244328;10233.13018393415;10432;10481.842772358268;10658.573657053632;8755;9252.629894804133;9615.423074615546;10322.948385258025;10323.432211228455;8651.6106775194;10520.789584208425;10659.46702664848;10707.3575585462;10802.189835762192;5896.6756828374855;7330.230325815925;7471.925280747123;7553.206913274027;7997.960010200144;7823.647935842787;9082.727518174466;9631.614735410505;10068.546915388972;10307.484625768831 16:48:33 INFO - PROCESS | 2237 | |3;mootools.html;1180.4156942313557;1282.198625858838;1425.073702093639;1546.3350759173559;1817.7182536706814;5745.770169193238;7327.12074551054;7841.607919604018;8314.958425207866;8412.873806892887;8123.95938020309;8358.791030224247;8369.455985360948;8373.41386102973;8379.539125348103;1884.7466434820828;2194.1552502286654;2213.9335819925345;2225.221172589597;2231.944201394962;2297.8391512594126;2350.882455877208;2353;2357;2361.6929799126087;2280.623697089978;2297.9770202298014;2321.779430954065;2331.207389487574;2333.3349995251356;2281.543691261738;2295.885205739715;2313.6760853480528;2314.502381987864;2324.7907688308132;2304.4354133237466;2325.5581439526436;2326.627739561679;2329.918452854159;2331.6152834782242;8300.750977470685;8311.750647480585;8391.035030971456;8422.831543369099;8427.32581393487;5011.84964451067;5065.46812584677;5209.062368773619;5218.982298451803;5220.582353411718;3570.125319296763;3661.048127486846;3668.358037343481;3671.7796932184156;3673.651003154696;927.7402327348353;947.6683160893701;965.6958058211641;966.24632786426;971.9028097190295;10568;10808.02727754498;10811.783764324748;10825.945870270676;10829.945850270777;4321.58944900234;4582.95417045832;4622.359062532752;4686.250199967989;4703.17694403478;9479.24166066713;9480.431174129575;9487.857682134774;9498.477583732962;9499.38254013487;5116.079105760924;5201.427842937273;5218.347706536683;5219.3736751589295;5220.190870415092;3975.602439756059;4190.7723279466045;4758.2386818108935;4767.237242041257;4768.165571025057;3731.3470142724914;3761.097336639242;3804.524434445694;3846.7307288489537;3853.845846166178;1249.2005116725304;1270.4410059573759;1271.4596296574105;1283.153118941494;1292.179466039072;786.2373497707215;845.4039901869168;879.3448880584006;912.4342907397456;919.5080631861922;5395.568354531628;5499.403103859944;5536.501714845684;5702.087665973508;5772.5670574707065;410.5073911306444;426.46052743279773;426.6586730615495;435.6754218107467;441.9845305414295;3703.518542589446;3791.5071040764524;3864.497615310048;3873.3538246245234;3945.8027098644952;9665;10182.083612474913;10182.745431364126;10186.796264074677;10188.847167292497;9719;9901.950490247647;10090.495475226357;10099.94950025245;10104.141148002354;7685.346745526581;7707.884381734279;7806.921930780733;7844.411669124838;7946.523208607502;5405.297311349499;5505.614606977473;5521.668699878021;5596.104623260258;5638.830835074954;9282.58228379711;9283.48940808262;9283.582238799405;9285;9379.812403752023;7925.167857374892;9232.95383523078;9385.15533601979;9481.762955926157;9582.329236953625;7015.579065256101;7065.187503437171;7099.325564071405;7196.316349946746;7202.747903823341;7777.300042996158;7868.803279918048;7882.172371900868;7884.763457096296;7886.526808391515;5813.302403711582;6860.897086543606;7047.083879095685;7114.57312561248;7188.928110718826;6691.698873550799;6927.099477067949;6966.930330696831;7042.295770422917;7110.30719724979;6400.839979000562;6574.178227721535;6643;6658.1344425224415;6720;3936;4545.2954792007295;4806.735629540409;4879.268109783561;4936.284238785284;4531.3429552714015;4834.444038935568;4843.515648435128;4864.343313652753;5024.874378140576 16:48:33 INFO - PROCESS | 2237 | |4;prototype.html;292.866745630738;300.316779327031;304.8064479055799;310.9284864481169;311.13814733189054;4265.786710664462;5089.236614507821;5111.798727299091;5140.5373516383515;5151.150060240056;4175.248455278049;4639.976800116003;5054.721990290533;5070.898582028357;5097.419799862036;3689.3728066228673;3808.428735689641;3829.5787463379006;3833.9616603833883;3881.6506514413695;3737.9813100934457;3836.558795738484;3852.4413959975786;3944.7830369329677;3983.546005707925;2887.4802535543595;3297.571315728952;3433.639467855877;3903.8048097595006;3916.7649941003488;3609.187932715144;3683.2633473305314;3696.131409118855;3867.5939026402384;3902.3951287550335;2816.2959260184953;3279.6392396836327;3374.240795820945;3392.643772403887;3398.694117529434;4134.979325103385;4853.757312134415;4897.530740777753;4934.777934992934;4935.580475659537;3898.9610103899167;4195.895102622429;4289.227938971015;4390.209762242795;4432.578905004019;5300.549453296474;5316;5347.46525347466;5355.678659280456;5376.274202982587;3756.793376364299;3763.247350529905;3764.209516001643;3764.6800021998165;3781.9243615127543;4640.79116439761;4948.802047918043;5544.97608372945;5580.525655319303;5604.691741954191;3848.461215429842;3862.497875276252;3879.3017256893468;3884.1649045455365;3898.7075969302414;3878.96121038786;3930.4890364253038;3933.350997085506;3935.58676338986;3942.8817135485983;4068.8372465101656;4182.498100227992;4217.493900731932;4483.529229430928;4497.650704788551;5015.623828212899;5365.570754339644;5382.973085134628;5385.8114965976;5392.838214853561;1109.3454861631515;1200.7452212438022;1263.6651287408845;1277.2847205564913;1279.6289076167993;852.9019162796234;884.9955750221208;892.5269607108113;900.4147304252158;901.9954900225588;4317.762523061199;4421.911561768811;4594.97702511492;4773.880652983703;4869.513048695173;4842.612590992712;5448.809291674773;5464.93433780409;5472.015037293326;5491.368492623399;4242.6817988650355;4389.385486031958;4593.954060459419;4758.643101767381;4995.450500444948;2580.6645136132556;2598.597217431301;2708.6478757761365;2721.2108488538497;2763.765079968225;4516.232240519054;4811.903761924742;4867.70793752376;5150.471926730202;5429.321334833146;4066.9389959150635;4727.479977202505;4877.975610121926;5088.313077734532;5369.19462080691;5145.76844042019;5183.740812959337;5204.375474943031;5678.574106941914;5740.225069615632;5207.531322181022;5512.889742205213;5523.861903452445;5532.640378375393;5561.63849349791;4814.7833347498745;5094.388673359221;5446.782128714807;5492.780288788404;5500.50495455411;5013.899722005613;5640.23856779346;5707.429257074259;5719.8856022880145;5797.797077102281;3002.609660744089;3730.47773311742;3751.9062023449633;3758.4174452959833;3764.1342491226624;5266.499682530153;5491.615586908878;5518.944810552004;5543.584231182596;5562.193481945176;5361.356637203405;5395;5395.784168633368;5410.296661433988;5441.211024401518;4928.353018766015;5256.9737151314;5394.757235924314;5419.853811834029;5425.755840987086;4639.605633521053;4913.459519452929;5085.898282034413;5119.692818430906;5301.284326615858;4710.905781884411;4827.744786355643;4842.51574842527;5075.416327122428;5364.9731751341;5211;5326.786928522815;5350.876315973689;5359.678419294854;5385.542228910586 16:48:33 INFO - PROCESS | 2237 | |5;yui.html;602.0642201834862;720.502853031408;757.0877093102812;775.9767206983789;780.3055280800087;11592;14927.104373737584;14957.551273461786;14976.400943962242;15006.474773382934;13312.733745325088;13490.392932318045;13490.865091349084;13500.054996150273;13505.257210853399;656.5437021270219;681.9761308354208;683.2484267305948;828.9253967142971;850.4727069217095;815.282551354807;841.5203334099566;846.3525403066628;858.8883445152121;861.3970220845401;900.3742399032642;902.1069141549851;903.9096090390941;905.6105874473974;906.6600024990629;685.338648204485;895.6775560798108;897.8294124116462;898.8606765951288;899.5052721003487;532.1113740054119;650.9772157974448;672.6905623413236;678.6538865178745;679.789265327745;13850.93074534631;13876.722465550733;13896.305184740722;13896.58310250684;13923;12568.120231583793;12646.367681615882;13028.41372138256;13054.15148015376;13064.673383165402;11817.527298908119;11885.22746021506;11959.40202989847;12055.457504412323;12397.318147501885;4308.892277693051;4337.284348082562;4339.696221264513;4515.390422293014;4536.34223037661;94451;96445;98273;98539;98879.50560247224;10182.287239893285;10280.07479326864;10332.121769649513;10333.121684656888;10638.042576168182;18142.365017224332;19014.61970760605;19382.4185274442;19424.320148794723;19448.222071116998;7431.591262480507;7549.849003020019;7591;7613;7710.113336966208;4233.449651545279;4257.254980378421;4307.655387568987;4314.56854314566;4417.249067658506;3413.2149605590357;3519.7712148710766;3526.18897653536;3526.9118272042892;3532.1346270163976;542.5632365945373;656.3797211634959;656.5305806348483;677.9186497620317;678.4979115454528;526.6208330002393;579.6174524813603;649.1301655781276;669.825845280221;678.6504949950779;7701.845963080707;9441.15029647335;9674.516274186262;9804.656087827268;10032.347897386646;565.8868226354746;596.6628854697083;614.261639560044;637.1363760999059;639.398964972924;4151.535530150167;4458.197524445566;4485.775711214426;4491.573300536444;4644.16405047088;51161.48838511642;67214.3278567208;77483;98435.50782246042;101253;48881.75559122253;61765.42635891444;75183.62408187924;89201;95356.52321738347;45767.084658306645;75230;76923.23076769161;78704;83242.16757832465;8460.576971151295;8603.784905377415;8666.869996950178;8724.607392667473;8795.780105497413;49213.03147874045;50730.74634626803;52655.73672131615;53037.40887773373;55551.44448555625;68950.96573551501;71149.28850711427;75461.24538754542;78113;79035.41929161499;12105.81841272364;12400.31798251105;12455.501779928702;12529.561465348668;12968.157069790434;13904.72190556163;14025.929870350583;14084.577462676136;14352.852150189861;14466.238777918028;13187.340632968122;13250.734985300047;13440.193588384729;13585.116967397087;14010.719785604027;10747.785044299226;13244.933775331061;13327.466901323838;13378.531751388655;13676.863231367559;12018.519259229533;12347.75304493923;12535.24788512692;12783.296918669563;12786.168899021533;10907.618233361794;11102.61140860066;11228.55085796559;11378;11457.255278406878;8704.434211776468;9598.85601715961;11150.330980141218;11368.431578421212;11413.714657133638 16:48:33 INFO - PROCESS | 2237 | __end_tp_report 16:48:33 INFO - PROCESS | 2237 | __start_cc_report 16:48:33 INFO - PROCESS | 2237 | _x_x_mozilla_cycle_collect,1978 16:48:33 INFO - PROCESS | 2237 | __end_cc_report 16:48:33 INFO - PROCESS | 2237 | __startTimestamp1479343713843__endTimestamp 16:48:33 INFO - PROCESS | 2237 | 16:48:33 INFO - PROCESS | 2237 | ------- Summary: start ------- 16:48:33 INFO - PROCESS | 2237 | Number of tests: 6 16:48:33 INFO - PROCESS | 2237 | 16:48:33 INFO - PROCESS | 2237 | [#0] dojo.html Cycles:165 Average:5685.96 Median:5824.36 stddev:626.61 (10.8%) stddev-sans-first:600.07 16:48:33 INFO - PROCESS | 2237 | Values: 3305.7 3326.8 3339.2 3349.0 3374.7 5597.0 5601.9 5687.9 5727.7 5737.3 5676.0 5694.2 5719.5 5719.7 5732.8 5141.2 5180.2 5182.3 5199.4 5213.2 5258.1 5270.3 5288.2 5288.4 5292.8 5141.0 5155.4 5187.4 5200.4 5273.4 5205.1 5224.0 5245.4 5263.6 5295.7 5022.8 5058.6 5078.0 5178.1 5201.1 5591.4 5637.4 5662.4 5667.5 5669.9 6221.2 6230.9 6234.4 6251.4 6254.6 5306.8 5451.6 6133.3 6193.4 6308.1 5745.4 5779.5 5796.3 5825.9 5843.4 6217.0 6247.3 6276.9 6278.0 6324.4 6011.7 6090.9 6162.5 6162.7 6163.1 6139.4 6144.1 6161.8 6193.8 6197.2 5111.7 5178.8 6198.4 6199.3 6204.3 5682.7 6150.7 6209.4 6216.5 6232.4 4784.8 4875.2 4879.9 4880.4 4918.2 4380.1 4381.6 4382.7 4438.5 4468.1 5650.6 5716.8 5744.1 5760.0 5772.6 6087.3 6097.7 6136.2 6201.6 6231.8 5676.2 5718.6 5730.4 5755.2 5801.4 5383.1 5384.0 5389.6 5392.1 5392.4 6159.4 6297.8 6298.1 6298.6 6316.8 6122.4 6135.2 6150.3 6196.7 6200.5 5327.4 6300.9 6303.6 6312.1 6321.7 6119.3 6171.1 6178.9 6182.5 6187.5 6101.8 6108.3 6122.6 6131.6 6168.4 5863.7 6035.6 6103.6 6126.2 6142.5 5966.4 5979.8 5999.5 6002.5 6006.6 5754.2 5815.1 5824.4 5883.0 5886.4 5960.6 5985.0 6011.8 6048.8 6051.4 5729.9 5921.8 5928.4 5959.2 5978.9 16:48:33 INFO - PROCESS | 2237 | 16:48:33 INFO - PROCESS | 2237 | [#1] ext.html Cycles:180 Average:64938.39 Median:38174.50 stddev:142375.80 (373.0%) stddev-sans-first:142692.88 16:48:33 INFO - PROCESS | 2237 | Values: 453.3 465.5 477.6 478.1 505.3 29933.9 31242.7 31278.0 35061.1 38931.4 39695.6 40061.4 40102.6 40123.0 40206.4 7781.9 9305.7 9323.5 9324.0 9349.5 9196.9 9281.5 9283.1 9288.2 9321.8 9282.1 9349.1 9352.6 9355.2 9372.3 7963.0 9264.9 9311.4 9336.6 9379.8 9122.7 9203.6 9204.7 9205.5 9210.8 37810.6 38132.0 38217.0 38243.8 38267.6 3251.8 3283.9 3284.9 3526.7 3899.0 28675.3 29099.0 29338.9 30049.5 30135.0 3180.4 3238.6 3284.2 3310.6 3319.4 466872.0 469259.0 471543.0 471798.0 472196.0 53839.9 54262.0 54299.0 54313.0 54349.5 33299.2 34314.3 56640.7 56678.7 56884.0 15392.6 15395.5 15597.2 15606.5 15633.1 11945.9 12056.5 12064.9 12068.8 12081.8 17989.0 18060.9 18147.5 18165.3 18248.2 7424.0 7593.9 7668.8 7695.0 7714.5 860.7 961.2 969.6 999.7 1022.6 21871.2 25294.1 28648.4 28654.4 28814.4 943.7 984.8 1021.2 1023.4 1082.6 14512.9 14546.9 14736.8 14807.6 15184.4 626857.0 629915.0 631030.0 631367.0 632100.0 54113.0 54662.5 54856.5 54940.5 54992.5 1187.8 1261.0 1326.3 1364.6 1389.2 28552.4 29511.7 29717.9 30158.0 30415.7 45201.0 45648.1 45701.8 45705.0 45757.3 480179.0 481743.0 482909.0 483144.0 483488.6 21115.4 22159.3 22792.5 24459.8 25219.6 43595.8 43674.4 43833.6 44541.1 44630.6 36169.1 36215.8 36305.1 37224.7 37328.1 35737.3 35944.9 36595.5 37139.9 37405.1 35428.1 36107.0 36383.5 36448.3 36832.3 25931.7 28724.7 31243.8 31436.7 32091.8 24174.6 24359.4 24546.9 24965.8 24981.0 16:48:33 INFO - PROCESS | 2237 | 16:48:33 INFO - PROCESS | 2237 | [#2] jquery.html Cycles:180 Average:31093.70 Median:4339.84 stddev:87295.24 (2011.5%) stddev-sans-first:87509.60 16:48:33 INFO - PROCESS | 2237 | Values: 349.1 365.9 368.7 381.5 397.0 14539.3 15020.2 15387.2 19613.0 20070.0 18573.9 18913.8 19513.1 19735.0 19935.9 5573.0 5910.7 5915.8 5917.5 5922.5 5388.4 5803.9 5857.9 5863.0 5865.0 5656.9 5822.8 5838.4 6001.1 6019.9 5982.1 6025.8 6026.1 6029.9 6032.8 4989.1 5258.7 5331.7 5373.7 5373.8 11900.9 12211.0 12721.2 17051.0 23583.8 2118.3 2139.3 2227.5 2334.1 2697.2 9541.7 9584.8 9625.1 10102.4 10136.5 1762.6 1820.4 1846.5 1848.3 1860.3 77804.6 100388.0 102199.5 102253.0 102471.5 9815.9 10910.7 11046.1 11062.7 11313.0 14012.0 14027.2 14040.6 14060.6 14067.7 7926.4 8105.4 8107.1 8203.0 8203.9 7919.7 7948.9 7958.1 8091.0 8113.8 3637.0 3714.6 4333.6 4346.1 4399.8 1805.7 1869.7 1895.0 1909.0 1910.2 781.9 829.1 845.3 957.6 968.1 19335.6 19727.1 20629.3 20725.5 21097.9 844.7 861.2 889.9 897.2 968.9 10408.0 10818.0 10858.2 10899.5 10951.3 513377.0 516118.0 517843.0 531900.0 533874.3 110470.0 116092.4 118967.4 119803.0 122227.4 869.5 963.8 977.0 1011.9 1012.1 13014.3 16744.4 17225.5 18411.0 19340.0 49541.8 50379.7 51647.2 52244.2 52836.2 71613.0 72174.6 72503.0 73477.0 75175.0 5869.6 7471.9 7637.2 7815.1 7888.3 8621.4 10724.2 11925.8 12194.7 12305.8 9775.0 10233.1 10432.0 10481.8 10658.6 8755.0 9252.6 9615.4 10322.9 10323.4 8651.6 10520.8 10659.5 10707.4 10802.2 5896.7 7330.2 7471.9 7553.2 7998.0 7823.6 9082.7 9631.6 10068.5 10307.5 16:48:33 INFO - PROCESS | 2237 | 16:48:33 INFO - PROCESS | 2237 | [#3] mootools.html Cycles:180 Average:5382.24 Median:5205.25 stddev:2984.43 (57.3%) stddev-sans-first:2976.09 16:48:33 INFO - PROCESS | 2237 | Values: 1180.4 1282.2 1425.1 1546.3 1817.7 5745.8 7327.1 7841.6 8315.0 8412.9 8124.0 8358.8 8369.5 8373.4 8379.5 1884.7 2194.2 2213.9 2225.2 2231.9 2297.8 2350.9 2353.0 2357.0 2361.7 2280.6 2298.0 2321.8 2331.2 2333.3 2281.5 2295.9 2313.7 2314.5 2324.8 2304.4 2325.6 2326.6 2329.9 2331.6 8300.8 8311.8 8391.0 8422.8 8427.3 5011.8 5065.5 5209.1 5219.0 5220.6 3570.1 3661.0 3668.4 3671.8 3673.7 927.7 947.7 965.7 966.2 971.9 10568.0 10808.0 10811.8 10825.9 10829.9 4321.6 4583.0 4622.4 4686.3 4703.2 9479.2 9480.4 9487.9 9498.5 9499.4 5116.1 5201.4 5218.3 5219.4 5220.2 3975.6 4190.8 4758.2 4767.2 4768.2 3731.3 3761.1 3804.5 3846.7 3853.8 1249.2 1270.4 1271.5 1283.2 1292.2 786.2 845.4 879.3 912.4 919.5 5395.6 5499.4 5536.5 5702.1 5772.6 410.5 426.5 426.7 435.7 442.0 3703.5 3791.5 3864.5 3873.4 3945.8 9665.0 10182.1 10182.7 10186.8 10188.8 9719.0 9902.0 10090.5 10099.9 10104.1 7685.3 7707.9 7806.9 7844.4 7946.5 5405.3 5505.6 5521.7 5596.1 5638.8 9282.6 9283.5 9283.6 9285.0 9379.8 7925.2 9233.0 9385.2 9481.8 9582.3 7015.6 7065.2 7099.3 7196.3 7202.7 7777.3 7868.8 7882.2 7884.8 7886.5 5813.3 6860.9 7047.1 7114.6 7188.9 6691.7 6927.1 6966.9 7042.3 7110.3 6400.8 6574.2 6643.0 6658.1 6720.0 3936.0 4545.3 4806.7 4879.3 4936.3 4531.3 4834.4 4843.5 4864.3 5024.9 16:48:33 INFO - PROCESS | 2237 | 16:48:33 INFO - PROCESS | 2237 | [#4] prototype.html Cycles:180 Average:4301.92 Median:4835.13 stddev:1312.15 (27.1%) stddev-sans-first:1280.86 16:48:33 INFO - PROCESS | 2237 | Values: 292.9 300.3 304.8 310.9 311.1 4265.8 5089.2 5111.8 5140.5 5151.2 4175.2 4640.0 5054.7 5070.9 5097.4 3689.4 3808.4 3829.6 3834.0 3881.7 3738.0 3836.6 3852.4 3944.8 3983.5 2887.5 3297.6 3433.6 3903.8 3916.8 3609.2 3683.3 3696.1 3867.6 3902.4 2816.3 3279.6 3374.2 3392.6 3398.7 4135.0 4853.8 4897.5 4934.8 4935.6 3899.0 4195.9 4289.2 4390.2 4432.6 5300.5 5316.0 5347.5 5355.7 5376.3 3756.8 3763.2 3764.2 3764.7 3781.9 4640.8 4948.8 5545.0 5580.5 5604.7 3848.5 3862.5 3879.3 3884.2 3898.7 3879.0 3930.5 3933.4 3935.6 3942.9 4068.8 4182.5 4217.5 4483.5 4497.7 5015.6 5365.6 5383.0 5385.8 5392.8 1109.3 1200.7 1263.7 1277.3 1279.6 852.9 885.0 892.5 900.4 902.0 4317.8 4421.9 4595.0 4773.9 4869.5 4842.6 5448.8 5464.9 5472.0 5491.4 4242.7 4389.4 4594.0 4758.6 4995.5 2580.7 2598.6 2708.6 2721.2 2763.8 4516.2 4811.9 4867.7 5150.5 5429.3 4066.9 4727.5 4878.0 5088.3 5369.2 5145.8 5183.7 5204.4 5678.6 5740.2 5207.5 5512.9 5523.9 5532.6 5561.6 4814.8 5094.4 5446.8 5492.8 5500.5 5013.9 5640.2 5707.4 5719.9 5797.8 3002.6 3730.5 3751.9 3758.4 3764.1 5266.5 5491.6 5518.9 5543.6 5562.2 5361.4 5395.0 5395.8 5410.3 5441.2 4928.4 5257.0 5394.8 5419.9 5425.8 4639.6 4913.5 5085.9 5119.7 5301.3 4710.9 4827.7 4842.5 5075.4 5365.0 5211.0 5326.8 5350.9 5359.7 5385.5 16:48:33 INFO - PROCESS | 2237 | 16:48:33 INFO - PROCESS | 2237 | [#5] yui.html Cycles:180 Average:18922.93 Median:26762.96 stddev:26636.30 (99.5%) stddev-sans-first:26675.50 16:48:33 INFO - PROCESS | 2237 | Values: 602.1 720.5 757.1 776.0 780.3 11592.0 14927.1 14957.6 14976.4 15006.5 13312.7 13490.4 13490.9 13500.1 13505.3 656.5 682.0 683.2 828.9 850.5 815.3 841.5 846.4 858.9 861.4 900.4 902.1 903.9 905.6 906.7 685.3 895.7 897.8 898.9 899.5 532.1 651.0 672.7 678.7 679.8 13850.9 13876.7 13896.3 13896.6 13923.0 12568.1 12646.4 13028.4 13054.2 13064.7 11817.5 11885.2 11959.4 12055.5 12397.3 4308.9 4337.3 4339.7 4515.4 4536.3 94451.0 96445.0 98273.0 98539.0 98879.5 10182.3 10280.1 10332.1 10333.1 10638.0 18142.4 19014.6 19382.4 19424.3 19448.2 7431.6 7549.8 7591.0 7613.0 7710.1 4233.4 4257.3 4307.7 4314.6 4417.2 3413.2 3519.8 3526.2 3526.9 3532.1 542.6 656.4 656.5 677.9 678.5 526.6 579.6 649.1 669.8 678.7 7701.8 9441.2 9674.5 9804.7 10032.3 565.9 596.7 614.3 637.1 639.4 4151.5 4458.2 4485.8 4491.6 4644.2 51161.5 67214.3 77483.0 98435.5 101253.0 48881.8 61765.4 75183.6 89201.0 95356.5 45767.1 75230.0 76923.2 78704.0 83242.2 8460.6 8603.8 8666.9 8724.6 8795.8 49213.0 50730.7 52655.7 53037.4 55551.4 68951.0 71149.3 75461.2 78113.0 79035.4 12105.8 12400.3 12455.5 12529.6 12968.2 13904.7 14025.9 14084.6 14352.9 14466.2 13187.3 13250.7 13440.2 13585.1 14010.7 10747.8 13244.9 13327.5 13378.5 13676.9 12018.5 12347.8 12535.2 12783.3 12786.2 10907.6 11102.6 11228.6 11378.0 11457.3 8704.4 9598.9 11150.3 11368.4 11413.7 16:48:33 INFO - PROCESS | 2237 | -------- Summary: end -------- 16:48:33 INFO - PROCESS | 2237 | 16:48:34 INFO - TEST-INFO | 2237: exit 0 16:48:34 INFO - TEST-OK | dromaeo_css | took 1119383ms 16:48:34 INFO - TEST-START | kraken 16:48:34 INFO - operating with platform_type : mac_ 16:48:34 INFO - Initialising browser for kraken test... 16:48:34 INFO - TEST-INFO | started process 2242 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmp3QMMVr/profile http://localhost:49445/getInfo.html) 16:48:36 INFO - PROCESS | 2242 | __metrics Screen width/height:1600/1200 16:48:36 INFO - PROCESS | 2242 | colorDepth:24 16:48:36 INFO - PROCESS | 2242 | Browser inner width/height: 1024/689 16:48:36 INFO - PROCESS | 2242 | __metrics 16:48:37 INFO - PROCESS | 2242 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:48:37 INFO - PROCESS | 2242 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:48:37 INFO - TEST-INFO | 2242: exit 0 16:48:37 INFO - Browser initialized. 16:48:37 INFO - Running cycle 1/1 for kraken test... 16:48:37 INFO - TEST-INFO | started process 2243 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmp3QMMVr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:48:49 INFO - PROCESS | 2243 | RSS: Main: 230977536 16:48:49 INFO - PROCESS | 2243 | 16:48:52 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:49445/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49445/tests/kraken/driver.html?testName=audio-beat-detection) 16:48:53 INFO - PROCESS | 2243 | RSS: Main: 289570816 16:48:53 INFO - PROCESS | 2243 | 16:48:56 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:49445/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49445/tests/kraken/driver.html?testName=audio-dft) 16:48:56 INFO - PROCESS | 2243 | RSS: Main: 290816000 16:48:56 INFO - PROCESS | 2243 | 16:49:00 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:49445/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49445/tests/kraken/driver.html?testName=audio-fft) 16:49:00 INFO - PROCESS | 2243 | RSS: Main: 382971904 16:49:00 INFO - PROCESS | 2243 | 16:49:02 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:49445/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49445/tests/kraken/driver.html?testName=audio-oscillator) 16:49:03 INFO - PROCESS | 2243 | RSS: Main: 283312128 16:49:03 INFO - PROCESS | 2243 | 16:49:05 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:49445/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49445/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:49:06 INFO - PROCESS | 2243 | RSS: Main: 288448512 16:49:06 INFO - PROCESS | 2243 | 16:49:08 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:49445/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49445/tests/kraken/driver.html?testName=imaging-darkroom) 16:49:09 INFO - PROCESS | 2243 | RSS: Main: 329134080 16:49:09 INFO - PROCESS | 2243 | 16:49:12 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:49445/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49445/tests/kraken/driver.html?testName=imaging-desaturate) 16:49:12 INFO - PROCESS | 2243 | RSS: Main: 330682368 16:49:12 INFO - PROCESS | 2243 | 16:49:15 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:49445/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49445/tests/kraken/driver.html?testName=json-parse-financial) 16:49:16 INFO - PROCESS | 2243 | RSS: Main: 327798784 16:49:16 INFO - PROCESS | 2243 | 16:49:17 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:49445/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49445/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:49:18 INFO - PROCESS | 2243 | RSS: Main: 303321088 16:49:18 INFO - PROCESS | 2243 | 16:49:20 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:49445/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49445/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:49:21 INFO - PROCESS | 2243 | RSS: Main: 305831936 16:49:21 INFO - PROCESS | 2243 | 16:49:23 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:49445/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49445/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:49:23 INFO - PROCESS | 2243 | RSS: Main: 309518336 16:49:23 INFO - PROCESS | 2243 | 16:49:26 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:49445/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49445/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:49:27 INFO - PROCESS | 2243 | RSS: Main: 325742592 16:49:27 INFO - PROCESS | 2243 | 16:49:30 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:49445/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49445/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:49:31 INFO - PROCESS | 2243 | RSS: Main: 319848448 16:49:31 INFO - PROCESS | 2243 | 16:49:32 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:49445/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49445/tests/kraken/driver.html?testName=ai-astar) 16:49:33 INFO - PROCESS | 2243 | RSS: Main: 363483136 16:49:33 INFO - PROCESS | 2243 | 16:49:33 INFO - PROCESS | 2243 | __start_tp_report 16:49:33 INFO - PROCESS | 2243 | _x_x_mozilla_page_load 16:49:33 INFO - PROCESS | 2243 | _x_x_mozilla_page_load_details 16:49:33 INFO - PROCESS | 2243 | |i|pagename|runs| 16:49:33 INFO - PROCESS | 2243 | |0;ai-astar;104;112;112;112;111;112;111;111;118;164 16:49:33 INFO - PROCESS | 2243 | |1;audio-beat-detection;148;113;108;160;140;139;112;110;141;111 16:49:33 INFO - PROCESS | 2243 | |2;audio-dft;186;182;181;184;183;181;183;179;179;181 16:49:33 INFO - PROCESS | 2243 | |3;audio-fft;80;58;58;87;60;59;58;57;81;58 16:49:33 INFO - PROCESS | 2243 | |4;audio-oscillator;83;70;92;70;68;68;90;68;69;96 16:49:33 INFO - PROCESS | 2243 | |5;imaging-gaussian-blur;89;84;87;85;86;84;88;84;88;84 16:49:33 INFO - PROCESS | 2243 | |6;imaging-darkroom;96;94;96;95;96;95;94;95;97;95 16:49:33 INFO - PROCESS | 2243 | |7;imaging-desaturate;86;84;84;85;85;84;85;84;87;85 16:49:33 INFO - PROCESS | 2243 | |8;json-parse-financial;55;55;53;53;55;56;54;55;54;54 16:49:33 INFO - PROCESS | 2243 | |9;json-stringify-tinderbox;64;72;69;77;74;71;70;73;72;72 16:49:33 INFO - PROCESS | 2243 | |10;stanford-crypto-aes;88;87;86;90;86;86;85;89;87;91 16:49:33 INFO - PROCESS | 2243 | |11;stanford-crypto-ccm;149;148;148;148;146;146;134;144;188;155 16:49:33 INFO - PROCESS | 2243 | |12;stanford-crypto-pbkdf2;177;234;235;173;174;173;173;173;174;172 16:49:33 INFO - PROCESS | 2243 | |13;stanford-crypto-sha256-iterative;59;84;89;68;68;68;67;66;67;67 16:49:33 INFO - PROCESS | 2243 | __end_tp_report 16:49:33 INFO - PROCESS | 2243 | __start_cc_report 16:49:33 INFO - PROCESS | 2243 | _x_x_mozilla_cycle_collect,1940 16:49:33 INFO - PROCESS | 2243 | __end_cc_report 16:49:33 INFO - PROCESS | 2243 | __startTimestamp1479343773231__endTimestamp 16:49:33 INFO - PROCESS | 2243 | 16:49:33 INFO - PROCESS | 2243 | ------- Summary: start ------- 16:49:33 INFO - PROCESS | 2243 | Number of tests: 14 16:49:33 INFO - PROCESS | 2243 | 16:49:33 INFO - PROCESS | 2243 | [#0] ai-astar Cycles:10 Average:116.70 Median:112.00 stddev:16.95 (15.1%) stddev-sans-first:17.35 16:49:33 INFO - PROCESS | 2243 | Values: 104.0 112.0 112.0 112.0 111.0 112.0 111.0 111.0 118.0 164.0 16:49:33 INFO - PROCESS | 2243 | 16:49:33 INFO - PROCESS | 2243 | [#1] audio-beat-detection Cycles:10 Average:128.20 Median:139.50 stddev:19.30 (13.8%) stddev-sans-first:19.09 16:49:33 INFO - PROCESS | 2243 | Values: 148.0 113.0 108.0 160.0 140.0 139.0 112.0 110.0 141.0 111.0 16:49:33 INFO - PROCESS | 2243 | 16:49:33 INFO - PROCESS | 2243 | [#2] audio-dft Cycles:10 Average:181.90 Median:182.50 stddev:2.18 (1.2%) stddev-sans-first:1.74 16:49:33 INFO - PROCESS | 2243 | Values: 186.0 182.0 181.0 184.0 183.0 181.0 183.0 179.0 179.0 181.0 16:49:33 INFO - PROCESS | 2243 | 16:49:33 INFO - PROCESS | 2243 | [#3] audio-fft Cycles:10 Average:65.60 Median:59.50 stddev:11.94 (20.1%) stddev-sans-first:11.47 16:49:33 INFO - PROCESS | 2243 | Values: 80.0 58.0 58.0 87.0 60.0 59.0 58.0 57.0 81.0 58.0 16:49:33 INFO - PROCESS | 2243 | 16:49:33 INFO - PROCESS | 2243 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:76.50 stddev:11.52 (15.1%) stddev-sans-first:12.04 16:49:33 INFO - PROCESS | 2243 | Values: 83.0 70.0 92.0 70.0 68.0 68.0 90.0 68.0 69.0 96.0 16:49:33 INFO - PROCESS | 2243 | 16:49:33 INFO - PROCESS | 2243 | [#5] imaging-gaussian-blur Cycles:10 Average:85.90 Median:86.50 stddev:1.97 (2.3%) stddev-sans-first:1.74 16:49:33 INFO - PROCESS | 2243 | Values: 89.0 84.0 87.0 85.0 86.0 84.0 88.0 84.0 88.0 84.0 16:49:33 INFO - PROCESS | 2243 | 16:49:33 INFO - PROCESS | 2243 | [#6] imaging-darkroom Cycles:10 Average:95.30 Median:95.50 stddev:0.95 (1.0%) stddev-sans-first:0.97 16:49:33 INFO - PROCESS | 2243 | Values: 96.0 94.0 96.0 95.0 96.0 95.0 94.0 95.0 97.0 95.0 16:49:33 INFO - PROCESS | 2243 | 16:49:33 INFO - PROCESS | 2243 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:0.99 (1.2%) stddev-sans-first:0.97 16:49:33 INFO - PROCESS | 2243 | Values: 86.0 84.0 84.0 85.0 85.0 84.0 85.0 84.0 87.0 85.0 16:49:33 INFO - PROCESS | 2243 | 16:49:33 INFO - PROCESS | 2243 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:55.00 stddev:0.97 (1.8%) stddev-sans-first:1.00 16:49:33 INFO - PROCESS | 2243 | Values: 55.0 55.0 53.0 53.0 55.0 56.0 54.0 55.0 54.0 54.0 16:49:33 INFO - PROCESS | 2243 | 16:49:33 INFO - PROCESS | 2243 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:72.00 stddev:3.41 (4.7%) stddev-sans-first:2.33 16:49:33 INFO - PROCESS | 2243 | Values: 64.0 72.0 69.0 77.0 74.0 71.0 70.0 73.0 72.0 72.0 16:49:33 INFO - PROCESS | 2243 | 16:49:33 INFO - PROCESS | 2243 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:87.50 stddev:1.96 (2.2%) stddev-sans-first:2.07 16:49:33 INFO - PROCESS | 2243 | Values: 88.0 87.0 86.0 90.0 86.0 86.0 85.0 89.0 87.0 91.0 16:49:33 INFO - PROCESS | 2243 | 16:49:33 INFO - PROCESS | 2243 | [#11] stanford-crypto-ccm Cycles:10 Average:150.60 Median:148.00 stddev:14.15 (9.6%) stddev-sans-first:15.00 16:49:33 INFO - PROCESS | 2243 | Values: 149.0 148.0 148.0 148.0 146.0 146.0 134.0 144.0 188.0 155.0 16:49:33 INFO - PROCESS | 2243 | 16:49:33 INFO - PROCESS | 2243 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.80 Median:174.00 stddev:25.70 (14.8%) stddev-sans-first:27.06 16:49:33 INFO - PROCESS | 2243 | Values: 177.0 234.0 235.0 173.0 174.0 173.0 173.0 173.0 174.0 172.0 16:49:33 INFO - PROCESS | 2243 | 16:49:33 INFO - PROCESS | 2243 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:68.00 stddev:9.02 (13.3%) stddev-sans-first:8.59 16:49:33 INFO - PROCESS | 2243 | Values: 59.0 84.0 89.0 68.0 68.0 68.0 67.0 66.0 67.0 67.0 16:49:33 INFO - PROCESS | 2243 | -------- Summary: end -------- 16:49:33 INFO - PROCESS | 2243 | 16:49:34 INFO - TEST-INFO | 2243: exit 0 16:49:34 INFO - TEST-OK | kraken | took 59596ms 16:49:34 INFO - SUITE-END | took 1178s 16:49:34 INFO - Completed test suite (00:19:39) 16:49:34 INFO - javascript benchmark 16:49:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3305.7355411567073, 3326.7504937129706, 3339.1652086978247, 3348.9665103348957, 3374.713149382302, 5596.972015139929, 5601.887962240753, 5687.886242275163, 5727.742251598673, 5737.282839645044, 5675.971620141893, 5694.2312787773635, 5719.513841323493, 5719.6854173020465, 5732.828015159542, 5141.177411614142, 5180.171172612383, 5182.274481572583, 5199.428062913076, 5213.165893457048, 5258.106121959257, 5270.262163297141, 5288.233206185101, 5288.444713305105, 5292.841214763564, 5141.0489059523925, 5155.432902380754, 5187.3775146982225, 5200.375954885419, 5273.419923808378, 5205.063088644061, 5224.033553792523, 5245.396779370383, 5263.578913686896, 5295.708736019517, 5022.77397517109, 5058.645894787366, 5077.974610126963, 5178.093833579109, 5201.141811601081, 5591.384947655754, 5637.408072152447, 5662.405447428043, 5667.546596272288, 5669.886602267931, 6221.160143380631, 6230.937690623126, 6234.376562343775, 6251.374862513758, 6254.562180647356, 5306.787728490855, 5451.563874889999, 6133.254817025391, 6193.380661933816, 6308.053791931201, 5745.396733343023, 5779.479846813807, 5796.275465566804, 5825.941740582624, 5843.444872737083, 6217.036359364306, 6247.344028876993, 6276.905846412307, 6278.0269058296035, 6324.3991820776955, 6011.669358185254, 6090.873188460149, 6162.476189523851, 6162.691865406712, 6163.075538669235, 6139.447449729546, 6144.109104179869, 6161.784337548164, 6193.81418557444, 6197.225346831646, 5111.718855462911, 5178.766955487012, 6198.411150940653, 6199.3490683478485, 6204.348543402878, 5682.664573825148, 6150.661713605795, 6209.441150296495, 6216.471599913967, 6232.376762323822, 4784.760761961888, 4875.24433712775, 4879.926801097987, 4880.438749543777, 4918.1884988977135, 4380.123975204971, 4381.5618438155925, 4382.715123516961, 4438.489573699001, 4468.128714900563, 5650.576206784508, 5716.771329146787, 5744.109663002241, 5759.992001399822, 5772.624779389326, 6087.269527656709, 6097.725602347905, 6136.21274067861, 6201.596896201822, 6231.844203894939, 5676.176954341598, 5718.628289161191, 5730.398308177665, 5755.165501002331, 5801.448862358069, 5383.138697808332, 5384.003959267548, 5389.595780316492, 5392.056390131711, 5392.352917649829, 6159.353267906805, 6297.842553936188, 6298.08677741734, 6298.559100862895, 6316.842078948063, 6122.387761223842, 6135.202044401795, 6150.323464418821, 6196.721147548281, 6200.534959877937, 5327.360716714019, 6300.936990630035, 6303.621782693053, 6312.084747711648, 6321.747130114744, 6119.265688117454, 6171.105189747372, 6178.876422471615, 6182.536309776875, 6187.474064704551, 6101.816945491642, 6108.281362586102, 6122.642120310999, 6131.601445906002, 6168.365721567314, 5863.736131874161, 6035.577509574287, 6103.640733310809, 6126.203593532812, 6142.477889379453, 5966.373530779206, 5979.760809567742, 5999.52003839683, 6002.549808764273, 6006.639601623917, 5754.223179870663, 5815.06958886593, 5824.3593204748295, 5883.0, 5886.38192989747, 5960.5827592068135, 5984.970075149597, 6011.7595296187665, 6048.818535443944, 6051.364606716232, 5729.885402292014, 5921.7631294747725, 5928.3775203603, 5959.22530071088, 5978.940210597838], "value": 5646.962719117883, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [453.2566590791103, 465.52051387071305, 477.5534874891975, 478.05583971656006, 505.2547492448638, 29933.850330748344, 31242.68757312429, 31278.0, 35061.12347191315, 38931.41602875959, 39695.60304396955, 40061.39907901384, 40102.598974010325, 40123.0, 40206.39690404639, 7781.8832717509285, 9305.674301399453, 9323.487208203545, 9323.95338023309, 9349.485778282191, 9196.908030919672, 9281.489518076503, 9283.11810378013, 9288.21050210733, 9321.766955826091, 9282.071792820732, 9349.111834375723, 9352.625894964192, 9355.158035776778, 9372.250219982385, 7962.960185199095, 9264.907350926473, 9311.394759340621, 9336.579853906522, 9379.812403751956, 9122.680706175319, 9203.631854725803, 9204.677836275765, 9205.53972301389, 9210.769730756718, 37810.62189378126, 38132.0, 38217.0, 38243.8087809562, 38267.61732382696, 3251.7723759336855, 3283.9343213135844, 3284.9340483265364, 3526.717862571014, 3898.9805050974564, 28675.283117922012, 29099.0, 29338.853305733333, 30049.549256761165, 30135.0, 3180.4275230458506, 3238.5789847319934, 3284.2282063715006, 3310.6027276726704, 3319.4356959316974, 466872.0, 469259.0, 471543.0, 471798.0, 472196.0, 53839.923201536534, 54262.0, 54299.0, 54313.0, 54349.45650543444, 33299.167520812174, 34314.31371372558, 56640.716796415756, 56678.7166064167, 56884.0, 15392.61518462025, 15395.461158859385, 15597.220138993005, 15606.453774117852, 15633.062016278833, 11945.88054119465, 12056.457459414347, 12064.879351206551, 12068.758624827455, 12081.758364832654, 17989.010604416882, 18060.9096954517, 18147.54631134206, 18165.273389064554, 18248.178831952595, 7423.962880185564, 7593.886091708629, 7668.846623067619, 7695.037765369795, 7714.53712777224, 860.7374750701097, 961.1925982174866, 969.6266937229077, 999.7000899730052, 1022.6420752736632, 21871.234506792185, 25294.11470598557, 28648.427031459254, 28654.411398395605, 28814.42371152565, 943.7027336389016, 984.7538115471132, 1021.2340744441668, 1023.4166525080633, 1082.610260306289, 14512.927435362966, 14546.854531454761, 14736.82105431563, 14807.555773326818, 15184.392624294904, 626857.0, 629915.0, 631030.0, 631367.0, 632100.0, 54112.96531450886, 54662.52730826728, 54856.451435485935, 54940.45059549353, 54992.45007549953, 1187.7743228786676, 1260.9684757881125, 1326.316946772413, 1364.6315494816345, 1389.2081513537187, 28552.428951421272, 29511.704882950897, 29717.85141074281, 30158.0, 30415.695843041285, 45201.0, 45648.08703825971, 45701.77149114233, 45705.0, 45757.31364029609, 480179.0, 481743.0, 482909.0, 483144.0, 483488.58255708497, 21115.366539003855, 22159.335219942783, 22792.544149116595, 24459.75540244575, 25219.621705674064, 43595.78202109096, 43674.36580057637, 43833.56166438422, 44541.10917781561, 44630.55369446264, 36169.0957726059, 36215.818920906284, 36305.092372690895, 37224.69713560012, 37328.066798330256, 35737.28525429425, 35944.93041451872, 36595.45106823453, 37139.88580342594, 37405.06487337838, 35428.114297142776, 36107.0, 36383.45424818683, 36448.27103457969, 36832.26335473329, 25931.74068259369, 28724.712752872205, 31243.750249989745, 31436.685633143377, 32091.839540802146, 24174.62673884482, 24359.391015224763, 24546.87726561356, 24965.750342496343, 24981.000759970124], "value": 18749.873025194294, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.067988470783, 365.8829174664107, 368.73451115197065, 381.4792807817328, 396.9662578680812, 14539.345729442173, 15020.173890436035, 15387.230638468074, 19613.019349032562, 20069.996500175006, 18573.90713046433, 18913.814639020733, 19513.12190951407, 19735.013249337513, 19935.900320498415, 5572.972135139318, 5910.67491287979, 5915.763369465216, 5917.497012753921, 5922.496587790021, 5388.353397592275, 5803.854903627422, 5857.8828423431505, 5863.0, 5864.970675146618, 5656.91514627281, 5822.796202132926, 5838.41615838417, 6001.069834175688, 6019.879602407949, 5982.102684597302, 6025.789097381615, 6026.126211699301, 6029.909551356734, 6032.758689652409, 4989.101961646902, 5258.6581872178185, 5331.733413329357, 5373.731313434313, 5373.811916582901, 11900.880991190064, 12211.023118150526, 12721.236725796482, 17051.0, 23583.76416235833, 2118.3447260280814, 2139.3474990128007, 2227.5099478114953, 2334.054707843326, 2697.1638791974356, 9541.742626676281, 9584.760380990461, 9625.133737963617, 10102.444365559892, 10136.493175341204, 1762.594603241249, 1820.3537744100918, 1846.5106598079149, 1848.3161230344724, 1860.2930886263134, 77804.61097694532, 100388.0, 102199.48900255526, 102253.0, 102471.48764256206, 9815.852762208573, 10910.727231819268, 11046.061084807721, 11062.723431914266, 11313.0, 14012.0, 14027.228502432261, 14040.648983775283, 14060.578182654537, 14067.71864562703, 7926.365890728728, 8105.432619716681, 8107.108218096005, 8203.0, 8203.876941845758, 7919.722809701633, 7948.920510794934, 7958.0848202457455, 8091.029076510738, 8113.797155071171, 3637.0, 3714.5728241252064, 4333.5883091106925, 4346.087321662423, 4399.802008909607, 1805.7110862261975, 1869.6634605770819, 1894.9905250473935, 1908.9809101908804, 1910.1881700277604, 781.8944442500303, 829.0672992883007, 845.2899564365962, 957.5595226195888, 968.1431932739436, 19335.613287734446, 19727.112279947436, 20629.277975270794, 20725.481862953548, 21097.894510527654, 844.7465760271893, 861.160368640583, 889.888763904512, 897.2463130969886, 968.8982656821073, 10408.0, 10818.0, 10858.239923205458, 10899.455027248607, 10951.288166269327, 513377.0, 516118.0, 517843.0, 531900.0, 533874.2657167854, 110470.0, 116092.41953790178, 118967.40516297364, 119803.0, 122227.38886305512, 869.5174178331087, 963.797602503468, 976.9902300977042, 1011.8583398324093, 1012.1245122968579, 13014.349282536024, 16744.41394551185, 17225.483235502954, 18411.0, 19340.0, 49541.752291238314, 50379.74810125926, 51647.22529161991, 52244.21633675574, 52836.20745688741, 71613.0, 72174.63912680403, 72503.0, 73477.0, 75175.0, 5869.618474799125, 7471.850562988601, 7637.236276372319, 7815.101263354787, 7888.329491993015, 8621.353398495012, 10724.249302548747, 11925.821112683143, 12194.695132621755, 12305.815412768994, 9774.951125244328, 10233.13018393415, 10432.0, 10481.842772358268, 10658.573657053632, 8755.0, 9252.629894804133, 9615.423074615546, 10322.948385258025, 10323.432211228455, 8651.6106775194, 10520.789584208425, 10659.46702664848, 10707.3575585462, 10802.189835762192, 5896.6756828374855, 7330.230325815925, 7471.925280747123, 7553.206913274027, 7997.960010200144, 7823.647935842787, 9082.727518174466, 9631.614735410505, 10068.546915388972, 10307.484625768831], "value": 8868.387724895074, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1180.4156942313557, 1282.198625858838, 1425.073702093639, 1546.3350759173559, 1817.7182536706814, 5745.770169193238, 7327.12074551054, 7841.607919604018, 8314.958425207866, 8412.873806892887, 8123.95938020309, 8358.791030224247, 8369.455985360948, 8373.41386102973, 8379.539125348103, 1884.7466434820828, 2194.1552502286654, 2213.9335819925345, 2225.221172589597, 2231.944201394962, 2297.8391512594126, 2350.882455877208, 2353.0, 2357.0, 2361.6929799126087, 2280.623697089978, 2297.9770202298014, 2321.779430954065, 2331.207389487574, 2333.3349995251356, 2281.543691261738, 2295.885205739715, 2313.6760853480528, 2314.502381987864, 2324.7907688308132, 2304.4354133237466, 2325.5581439526436, 2326.627739561679, 2329.918452854159, 2331.6152834782242, 8300.750977470685, 8311.750647480585, 8391.035030971456, 8422.831543369099, 8427.32581393487, 5011.84964451067, 5065.46812584677, 5209.062368773619, 5218.982298451803, 5220.582353411718, 3570.125319296763, 3661.048127486846, 3668.358037343481, 3671.7796932184156, 3673.651003154696, 927.7402327348353, 947.6683160893701, 965.6958058211641, 966.24632786426, 971.9028097190295, 10568.0, 10808.02727754498, 10811.783764324748, 10825.945870270676, 10829.945850270777, 4321.58944900234, 4582.95417045832, 4622.359062532752, 4686.250199967989, 4703.17694403478, 9479.24166066713, 9480.431174129575, 9487.857682134774, 9498.477583732962, 9499.38254013487, 5116.079105760924, 5201.427842937273, 5218.347706536683, 5219.3736751589295, 5220.190870415092, 3975.602439756059, 4190.7723279466045, 4758.2386818108935, 4767.237242041257, 4768.165571025057, 3731.3470142724914, 3761.097336639242, 3804.524434445694, 3846.7307288489537, 3853.845846166178, 1249.2005116725304, 1270.4410059573759, 1271.4596296574105, 1283.153118941494, 1292.179466039072, 786.2373497707215, 845.4039901869168, 879.3448880584006, 912.4342907397456, 919.5080631861922, 5395.568354531628, 5499.403103859944, 5536.501714845684, 5702.087665973508, 5772.5670574707065, 410.5073911306444, 426.46052743279773, 426.6586730615495, 435.6754218107467, 441.9845305414295, 3703.518542589446, 3791.5071040764524, 3864.497615310048, 3873.3538246245234, 3945.8027098644952, 9665.0, 10182.083612474913, 10182.745431364126, 10186.796264074677, 10188.847167292497, 9719.0, 9901.950490247647, 10090.495475226357, 10099.94950025245, 10104.141148002354, 7685.346745526581, 7707.884381734279, 7806.921930780733, 7844.411669124838, 7946.523208607502, 5405.297311349499, 5505.614606977473, 5521.668699878021, 5596.104623260258, 5638.830835074954, 9282.58228379711, 9283.48940808262, 9283.582238799405, 9285.0, 9379.812403752023, 7925.167857374892, 9232.95383523078, 9385.15533601979, 9481.762955926157, 9582.329236953625, 7015.579065256101, 7065.187503437171, 7099.325564071405, 7196.316349946746, 7202.747903823341, 7777.300042996158, 7868.803279918048, 7882.172371900868, 7884.763457096296, 7886.526808391515, 5813.302403711582, 6860.897086543606, 7047.083879095685, 7114.57312561248, 7188.928110718826, 6691.698873550799, 6927.099477067949, 6966.930330696831, 7042.295770422917, 7110.30719724979, 6400.839979000562, 6574.178227721535, 6643.0, 6658.1344425224415, 6720.0, 3936.0, 4545.2954792007295, 4806.735629540409, 4879.268109783561, 4936.284238785284, 4531.3429552714015, 4834.444038935568, 4843.515648435128, 4864.343313652753, 5024.874378140576], "value": 4274.747755250766, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.866745630738, 300.316779327031, 304.8064479055799, 310.9284864481169, 311.13814733189054, 4265.786710664462, 5089.236614507821, 5111.798727299091, 5140.5373516383515, 5151.150060240056, 4175.248455278049, 4639.976800116003, 5054.721990290533, 5070.898582028357, 5097.419799862036, 3689.3728066228673, 3808.428735689641, 3829.5787463379006, 3833.9616603833883, 3881.6506514413695, 3737.9813100934457, 3836.558795738484, 3852.4413959975786, 3944.7830369329677, 3983.546005707925, 2887.4802535543595, 3297.571315728952, 3433.639467855877, 3903.8048097595006, 3916.7649941003488, 3609.187932715144, 3683.2633473305314, 3696.131409118855, 3867.5939026402384, 3902.3951287550335, 2816.2959260184953, 3279.6392396836327, 3374.240795820945, 3392.643772403887, 3398.694117529434, 4134.979325103385, 4853.757312134415, 4897.530740777753, 4934.777934992934, 4935.580475659537, 3898.9610103899167, 4195.895102622429, 4289.227938971015, 4390.209762242795, 4432.578905004019, 5300.549453296474, 5316.0, 5347.46525347466, 5355.678659280456, 5376.274202982587, 3756.793376364299, 3763.247350529905, 3764.209516001643, 3764.6800021998165, 3781.9243615127543, 4640.79116439761, 4948.802047918043, 5544.97608372945, 5580.525655319303, 5604.691741954191, 3848.461215429842, 3862.497875276252, 3879.3017256893468, 3884.1649045455365, 3898.7075969302414, 3878.96121038786, 3930.4890364253038, 3933.350997085506, 3935.58676338986, 3942.8817135485983, 4068.8372465101656, 4182.498100227992, 4217.493900731932, 4483.529229430928, 4497.650704788551, 5015.623828212899, 5365.570754339644, 5382.973085134628, 5385.8114965976, 5392.838214853561, 1109.3454861631515, 1200.7452212438022, 1263.6651287408845, 1277.2847205564913, 1279.6289076167993, 852.9019162796234, 884.9955750221208, 892.5269607108113, 900.4147304252158, 901.9954900225588, 4317.762523061199, 4421.911561768811, 4594.97702511492, 4773.880652983703, 4869.513048695173, 4842.612590992712, 5448.809291674773, 5464.93433780409, 5472.015037293326, 5491.368492623399, 4242.6817988650355, 4389.385486031958, 4593.954060459419, 4758.643101767381, 4995.450500444948, 2580.6645136132556, 2598.597217431301, 2708.6478757761365, 2721.2108488538497, 2763.765079968225, 4516.232240519054, 4811.903761924742, 4867.70793752376, 5150.471926730202, 5429.321334833146, 4066.9389959150635, 4727.479977202505, 4877.975610121926, 5088.313077734532, 5369.19462080691, 5145.76844042019, 5183.740812959337, 5204.375474943031, 5678.574106941914, 5740.225069615632, 5207.531322181022, 5512.889742205213, 5523.861903452445, 5532.640378375393, 5561.63849349791, 4814.7833347498745, 5094.388673359221, 5446.782128714807, 5492.780288788404, 5500.50495455411, 5013.899722005613, 5640.23856779346, 5707.429257074259, 5719.8856022880145, 5797.797077102281, 3002.609660744089, 3730.47773311742, 3751.9062023449633, 3758.4174452959833, 3764.1342491226624, 5266.499682530153, 5491.615586908878, 5518.944810552004, 5543.584231182596, 5562.193481945176, 5361.356637203405, 5395.0, 5395.784168633368, 5410.296661433988, 5441.211024401518, 4928.353018766015, 5256.9737151314, 5394.757235924314, 5419.853811834029, 5425.755840987086, 4639.605633521053, 4913.459519452929, 5085.898282034413, 5119.692818430906, 5301.284326615858, 4710.905781884411, 4827.744786355643, 4842.51574842527, 5075.416327122428, 5364.9731751341, 5211.0, 5326.786928522815, 5350.876315973689, 5359.678419294854, 5385.542228910586], "value": 3888.4990173671376, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.0642201834862, 720.502853031408, 757.0877093102812, 775.9767206983789, 780.3055280800087, 11592.0, 14927.104373737584, 14957.551273461786, 14976.400943962242, 15006.474773382934, 13312.733745325088, 13490.392932318045, 13490.865091349084, 13500.054996150273, 13505.257210853399, 656.5437021270219, 681.9761308354208, 683.2484267305948, 828.9253967142971, 850.4727069217095, 815.282551354807, 841.5203334099566, 846.3525403066628, 858.8883445152121, 861.3970220845401, 900.3742399032642, 902.1069141549851, 903.9096090390941, 905.6105874473974, 906.6600024990629, 685.338648204485, 895.6775560798108, 897.8294124116462, 898.8606765951288, 899.5052721003487, 532.1113740054119, 650.9772157974448, 672.6905623413236, 678.6538865178745, 679.789265327745, 13850.93074534631, 13876.722465550733, 13896.305184740722, 13896.58310250684, 13923.0, 12568.120231583793, 12646.367681615882, 13028.41372138256, 13054.15148015376, 13064.673383165402, 11817.527298908119, 11885.22746021506, 11959.40202989847, 12055.457504412323, 12397.318147501885, 4308.892277693051, 4337.284348082562, 4339.696221264513, 4515.390422293014, 4536.34223037661, 94451.0, 96445.0, 98273.0, 98539.0, 98879.50560247224, 10182.287239893285, 10280.07479326864, 10332.121769649513, 10333.121684656888, 10638.042576168182, 18142.365017224332, 19014.61970760605, 19382.4185274442, 19424.320148794723, 19448.222071116998, 7431.591262480507, 7549.849003020019, 7591.0, 7613.0, 7710.113336966208, 4233.449651545279, 4257.254980378421, 4307.655387568987, 4314.56854314566, 4417.249067658506, 3413.2149605590357, 3519.7712148710766, 3526.18897653536, 3526.9118272042892, 3532.1346270163976, 542.5632365945373, 656.3797211634959, 656.5305806348483, 677.9186497620317, 678.4979115454528, 526.6208330002393, 579.6174524813603, 649.1301655781276, 669.825845280221, 678.6504949950779, 7701.845963080707, 9441.15029647335, 9674.516274186262, 9804.656087827268, 10032.347897386646, 565.8868226354746, 596.6628854697083, 614.261639560044, 637.1363760999059, 639.398964972924, 4151.535530150167, 4458.197524445566, 4485.775711214426, 4491.573300536444, 4644.16405047088, 51161.48838511642, 67214.3278567208, 77483.0, 98435.50782246042, 101253.0, 48881.75559122253, 61765.42635891444, 75183.62408187924, 89201.0, 95356.52321738347, 45767.084658306645, 75230.0, 76923.23076769161, 78704.0, 83242.16757832465, 8460.576971151295, 8603.784905377415, 8666.869996950178, 8724.607392667473, 8795.780105497413, 49213.03147874045, 50730.74634626803, 52655.73672131615, 53037.40887773373, 55551.44448555625, 68950.96573551501, 71149.28850711427, 75461.24538754542, 78113.0, 79035.41929161499, 12105.81841272364, 12400.31798251105, 12455.501779928702, 12529.561465348668, 12968.157069790434, 13904.72190556163, 14025.929870350583, 14084.577462676136, 14352.852150189861, 14466.238777918028, 13187.340632968122, 13250.734985300047, 13440.193588384729, 13585.116967397087, 14010.719785604027, 10747.785044299226, 13244.933775331061, 13327.466901323838, 13378.531751388655, 13676.863231367559, 12018.519259229533, 12347.75304493923, 12535.24788512692, 12783.296918669563, 12786.168899021533, 10907.618233361794, 11102.61140860066, 11228.55085796559, 11378.0, 11457.255278406878, 8704.434211776468, 9598.85601715961, 11150.330980141218, 11368.431578421212, 11413.714657133638], "value": 7157.509122355315, "unit": "score"}], "name": "dromaeo_css", "value": 6940.008027351707, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 112.0, 112.0, 111.0, 112.0, 111.0, 111.0, 118.0, 164.0], "value": 116.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 113.0, 108.0, 160.0, 140.0, 139.0, 112.0, 110.0, 141.0, 111.0], "value": 128.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 182.0, 181.0, 184.0, 183.0, 181.0, 183.0, 179.0, 179.0, 181.0], "value": 181.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 58.0, 87.0, 60.0, 59.0, 58.0, 57.0, 81.0, 58.0], "value": 65.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 70.0, 92.0, 70.0, 68.0, 68.0, 90.0, 68.0, 69.0, 96.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 84.0, 87.0, 85.0, 86.0, 84.0, 88.0, 84.0, 88.0, 84.0], "value": 85.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 96.0, 95.0, 96.0, 95.0, 94.0, 95.0, 97.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 85.0, 85.0, 84.0, 85.0, 84.0, 87.0, 85.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 53.0, 53.0, 55.0, 56.0, 54.0, 55.0, 54.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 69.0, 77.0, 74.0, 71.0, 70.0, 73.0, 72.0, 72.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 86.0, 90.0, 86.0, 86.0, 85.0, 89.0, 87.0, 91.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 148.0, 146.0, 146.0, 134.0, 144.0, 188.0, 155.0], "value": 150.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 234.0, 235.0, 173.0, 174.0, 173.0, 173.0, 173.0, 174.0, 172.0], "value": 185.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 84.0, 89.0, 68.0, 68.0, 68.0, 67.0, 66.0, 67.0, 67.0], "value": 70.3, "unit": "score"}], "name": "kraken", "value": 1455.8999999999996, "alertThreshold": 2.0}]} 16:49:34 INFO - Return code: 0 16:49:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:49:34 INFO - # TBPL SUCCESS # 16:49:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:49:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:49:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:49:34 INFO - 2016-11-16 16:49:34.570 screenresolution[2247:280745] starting screenresolution argv=screenresolution get 16:49:34 INFO - 2016-11-16 16:49:34.573 screenresolution[2247:280745] Display 0: 1600x1200x32@60 16:49:34 INFO - 2016-11-16 16:49:34.578 screenresolution[2248:280748] starting screenresolution argv=screenresolution list 16:49:34 INFO - Available Modes on Display 0 16:49:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:49:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:49:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:49:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:49:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:49:34 INFO - Intel Iris: 16:49:34 INFO - Chipset Model: Intel Iris 16:49:34 INFO - Type: GPU 16:49:34 INFO - Bus: Built-In 16:49:34 INFO - VRAM (Dynamic, Max): 1536 MB 16:49:34 INFO - Vendor: Intel (0x8086) 16:49:34 INFO - Device ID: 0x0a2e 16:49:34 INFO - Revision ID: 0x0009 16:49:34 INFO - Displays: 16:49:34 INFO - Display: 16:49:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:49:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:49:34 INFO - Display Serial Number: 1600x1200 60 16:49:34 INFO - Main Display: Yes 16:49:34 INFO - Mirror: Off 16:49:34 INFO - Online: Yes 16:49:34 INFO - Rotation: Supported 16:49:34 INFO - Return code: 0 16:49:34 INFO - Running post-action listener: _resource_record_post_action 16:49:34 INFO - [mozharness: 2016-11-17 00:49:34.817711Z] Finished run-tests step (success) 16:49:34 INFO - Running post-run listener: _resource_record_post_run 16:49:34 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 7647744; Write bytes: 699987968; Read time: 69; Write time: 1934 16:49:34 INFO - TinderboxPrint: CPU usage
53.4% 16:49:34 INFO - TinderboxPrint: I/O read bytes / time
7,647,744 / 69 16:49:34 INFO - TinderboxPrint: I/O write bytes / time
699,987,968 / 1,934 16:49:34 INFO - TinderboxPrint: CPU idle
2,259.5 (46.6%) 16:49:34 INFO - TinderboxPrint: CPU system
970.8 (20.0%) 16:49:34 INFO - TinderboxPrint: CPU user
1,623.5 (33.4%) 16:49:34 INFO - TinderboxPrint: Swap in / out
415,232,000 / 0 16:49:34 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 377262592; Write bytes: 372172800; Read time: 28099; Write time: 742 16:49:34 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 7647744; Write bytes: 297848832; Read time: 69; Write time: 1130 16:49:35 INFO - Running post-run listener: _upload_blobber_files 16:49:35 INFO - Blob upload gear active. 16:49:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:49:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:49:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:49:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:49:35 INFO - (blobuploader) - INFO - Open directory for files ... 16:49:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:49:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:49:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:49:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:49:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:49:36 INFO - (blobuploader) - INFO - Done attempting. 16:49:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:49:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:49:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:49:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:49:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:49:37 INFO - (blobuploader) - INFO - Done attempting. 16:49:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:49:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:49:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:49:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:49:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:49:39 INFO - (blobuploader) - INFO - Done attempting. 16:49:39 INFO - (blobuploader) - INFO - Iteration through files over. 16:49:39 INFO - Return code: 0 16:49:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:49:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:49:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f41883dd6f30ce676af86c81b0fe77bbf11cbc102b946472a564addb96b87e9f526d3d8157b10a3b7d855c3839264171eab6dc42ea5c69eda7c2f0feefce6b7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e29c7694d2eade34a93787e25fb562c0739ccf92080d7d24f34ca006e2f36981ad91f5455e4fed423c76018be3cd62772d9d79ac28002166ede4e33ec6ec62ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3ce118ace6533ddf90e7b0e22bd4a5cf6819b828942e26c77995e3cb32c30a84575f5035cbc5eacb72e51d9cd19c702c9180e1fd1a3587d2b136e414292c4dff"} 16:49:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:49:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:49:39 INFO - Contents: 16:49:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f41883dd6f30ce676af86c81b0fe77bbf11cbc102b946472a564addb96b87e9f526d3d8157b10a3b7d855c3839264171eab6dc42ea5c69eda7c2f0feefce6b7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e29c7694d2eade34a93787e25fb562c0739ccf92080d7d24f34ca006e2f36981ad91f5455e4fed423c76018be3cd62772d9d79ac28002166ede4e33ec6ec62ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3ce118ace6533ddf90e7b0e22bd4a5cf6819b828942e26c77995e3cb32c30a84575f5035cbc5eacb72e51d9cd19c702c9180e1fd1a3587d2b136e414292c4dff"} 16:49:39 INFO - Running post-run listener: copy_logs_to_upload_dir 16:49:39 INFO - Copying logs to upload dir... 16:49:39 INFO - mkdir: /builds/slave/test/build/upload/logs 16:49:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.793240 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-11-16 16:49:39.713943) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-16 16:49:39.717368) ========= 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.TUg5PfXss6/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.4rC1Y6RXKJ/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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/Graphics/sha512/f41883dd6f30ce676af86c81b0fe77bbf11cbc102b946472a564addb96b87e9f526d3d8157b10a3b7d855c3839264171eab6dc42ea5c69eda7c2f0feefce6b7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e29c7694d2eade34a93787e25fb562c0739ccf92080d7d24f34ca006e2f36981ad91f5455e4fed423c76018be3cd62772d9d79ac28002166ede4e33ec6ec62ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3ce118ace6533ddf90e7b0e22bd4a5cf6819b828942e26c77995e3cb32c30a84575f5035cbc5eacb72e51d9cd19c702c9180e1fd1a3587d2b136e414292c4dff"} build_url:https://queue.taskcluster.net/v1/task/DUesqtwSSKipEzq01bzPEw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011210 build_url: 'https://queue.taskcluster.net/v1/task/DUesqtwSSKipEzq01bzPEw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f41883dd6f30ce676af86c81b0fe77bbf11cbc102b946472a564addb96b87e9f526d3d8157b10a3b7d855c3839264171eab6dc42ea5c69eda7c2f0feefce6b7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e29c7694d2eade34a93787e25fb562c0739ccf92080d7d24f34ca006e2f36981ad91f5455e4fed423c76018be3cd62772d9d79ac28002166ede4e33ec6ec62ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3ce118ace6533ddf90e7b0e22bd4a5cf6819b828942e26c77995e3cb32c30a84575f5035cbc5eacb72e51d9cd19c702c9180e1fd1a3587d2b136e414292c4dff"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-16 16:49:39.750874) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 16:49:39.751204) ========= 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.TUg5PfXss6/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.4rC1Y6RXKJ/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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.004623 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 16:49:39.798745) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-16 16:49:39.799079) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-16 16:49:39.799403) ========= ========= Total master_lag: 0.18 =========