builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0148 starttime: 1485479769.62 results: success (0) buildid: 20170126160921 builduid: 6487840f9d654d09adf50c11a60b7a79 revision: 3219566164175783539ba1976267fbd3517bd70f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-26 17:16:09.618932) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-26 17:16:09.619382) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-26 17:16:09.619667) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-26 17:16:09.646143) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 17:16:09.646531) ========= 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.CsZdZBElpC/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.zoHcWtIx2c/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-26 17:16:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 44.5M=0s 2017-01-26 17:16:09 (44.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.141623 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 17:16:09.809575) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 17:16:09.809922) ========= 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.CsZdZBElpC/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.zoHcWtIx2c/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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.028069 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 17:16:09.860041) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2017-01-26 17:16:09.860452) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3219566164175783539ba1976267fbd3517bd70f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3219566164175783539ba1976267fbd3517bd70f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CsZdZBElpC/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.zoHcWtIx2c/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-26 17:16:09,944 truncating revision to first 12 chars 2017-01-26 17:16:09,945 Setting DEBUG logging. 2017-01-26 17:16:09,945 attempt 1/10 2017-01-26 17:16:09,945 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/321956616417?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-26 17:16:12,876 unpacking tar archive at: mozilla-central-321956616417/testing/mozharness/ program finished with exit code 0 elapsedTime=3.190284 ========= master_lag: 3.44 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2017-01-26 17:16:16.493530) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-26 17:16:16.493879) ========= script_repo_revision: 3219566164175783539ba1976267fbd3517bd70f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-26 17:16:16.494282) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-26 17:16:16.494554) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-26 17:16:16.516402) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-01-26 17:16:16.516820) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CsZdZBElpC/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.zoHcWtIx2c/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 17:16:16 INFO - MultiFileLogger online at 20170126 17:16:16 in /builds/slave/test 17:16:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:16:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:16:16 INFO - {'append_to_log': False, 17:16:16 INFO - 'base_work_dir': '/builds/slave/test', 17:16:16 INFO - 'blob_upload_branch': 'Firefox', 17:16:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:16:16 INFO - 'branch': 'Firefox', 17:16:16 INFO - 'buildbot_json_path': 'buildprops.json', 17:16:16 INFO - 'config_files': ('talos/mac_config.py',), 17:16:16 INFO - 'default_actions': ('clobber', 17:16:16 INFO - 'read-buildbot-config', 17:16:16 INFO - 'download-and-extract', 17:16:16 INFO - 'populate-webroot', 17:16:16 INFO - 'create-virtualenv', 17:16:16 INFO - 'install', 17:16:16 INFO - 'run-tests'), 17:16:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:16:16 INFO - 'download_minidump_stackwalk': True, 17:16:16 INFO - 'download_symbols': 'ondemand', 17:16:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:16:16 INFO - 'tooltool.py': '/tools/tooltool.py', 17:16:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:16:16 INFO - '/tools/misc-python/virtualenv.py')}, 17:16:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:16:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:16:16 INFO - 'installer_path': 'installer.exe', 17:16:16 INFO - 'log_level': 'info', 17:16:16 INFO - 'log_name': 'talos', 17:16:16 INFO - 'log_to_console': True, 17:16:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:16:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:16:16 INFO - 'opt_config_files': (), 17:16:16 INFO - 'pip_index': False, 17:16:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:16:16 INFO - 'cmd': ('bash', 17:16:16 INFO - '-c', 17:16:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:16:16 INFO - 'enabled': True, 17:16:16 INFO - 'halt_on_failure': False, 17:16:16 INFO - 'name': 'check_screen_resolution'},), 17:16:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:16:16 INFO - 'cmd': ('bash', 17:16:16 INFO - '-c', 17:16:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:16:16 INFO - 'enabled': True, 17:16:16 INFO - 'halt_on_failure': False, 17:16:16 INFO - 'name': 'check_screen_resolution'},), 17:16:16 INFO - 'run_cmd_checks_enabled': True, 17:16:16 INFO - 'sps_profile': False, 17:16:16 INFO - 'sps_profile_interval': 0, 17:16:16 INFO - 'suite': 'dromaeojs', 17:16:16 INFO - 'system_bits': '32', 17:16:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:16:16 INFO - 'title': 't-yosemite-r7-0148', 17:16:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:16:16 INFO - 'use_talos_json': True, 17:16:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:16:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:16:16 INFO - 'work_dir': 'build'} 17:16:16 INFO - [mozharness: 2017-01-27 01:16:16.717973Z] Running clobber step. 17:16:16 INFO - Running pre-action listener: _resource_record_pre_action 17:16:16 INFO - Running main action method: clobber 17:16:16 INFO - rmtree: /builds/slave/test/build 17:16:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:16:19 INFO - Running post-action listener: _resource_record_post_action 17:16:19 INFO - [mozharness: 2017-01-27 01:16:19.136689Z] Finished clobber step (success) 17:16:19 INFO - [mozharness: 2017-01-27 01:16:19.136896Z] Running read-buildbot-config step. 17:16:19 INFO - Running pre-action listener: _resource_record_pre_action 17:16:19 INFO - Running main action method: read_buildbot_config 17:16:19 INFO - Using buildbot properties: 17:16:19 INFO - { 17:16:19 INFO - "project": "", 17:16:19 INFO - "product": "firefox", 17:16:19 INFO - "script_repo_revision": "production", 17:16:19 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 17:16:19 INFO - "repository": "", 17:16:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 17:16:19 INFO - "buildid": "20170126160921", 17:16:19 INFO - "pgo_build": "False", 17:16:19 INFO - "basedir": "/builds/slave/test", 17:16:19 INFO - "buildnumber": 122, 17:16:19 INFO - "slavename": "t-yosemite-r7-0148", 17:16:19 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 17:16:19 INFO - "platform": "yosemite_r7", 17:16:19 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:16:19 INFO - "branch": "mozilla-central", 17:16:19 INFO - "repo_path": "mozilla-central", 17:16:19 INFO - "revision": "3219566164175783539ba1976267fbd3517bd70f", 17:16:19 INFO - "stage_platform": "macosx64", 17:16:19 INFO - "builduid": "6487840f9d654d09adf50c11a60b7a79", 17:16:19 INFO - "slavebuilddir": "test" 17:16:19 INFO - } 17:16:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/eCChVesETUiL7rgOtgtczg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 17:16:19 INFO - Running post-action listener: _resource_record_post_action 17:16:19 INFO - [mozharness: 2017-01-27 01:16:19.140220Z] Finished read-buildbot-config step (success) 17:16:19 INFO - [mozharness: 2017-01-27 01:16:19.140362Z] Running download-and-extract step. 17:16:19 INFO - Running pre-action listener: _resource_record_pre_action 17:16:19 INFO - Running main action method: download_and_extract 17:16:19 INFO - mkdir: /builds/slave/test/build/tests 17:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:19 INFO - trying https://queue.taskcluster.net/v1/task/eCChVesETUiL7rgOtgtczg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 17:16:19 INFO - Downloading https://queue.taskcluster.net/v1/task/eCChVesETUiL7rgOtgtczg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 17:16:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eCChVesETUiL7rgOtgtczg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 17:16:20 INFO - Downloaded 1199 bytes. 17:16:20 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 17:16:20 INFO - Using the following test package requirements: 17:16:20 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 17:16:20 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:16:20 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 17:16:20 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:16:20 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 17:16:20 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:16:20 INFO - u'jsshell-mac.zip'], 17:16:20 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:16:20 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 17:16:20 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 17:16:20 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:16:20 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 17:16:20 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:16:20 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 17:16:20 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:16:20 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 17:16:20 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:16:20 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 17:16:20 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:16:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eCChVesETUiL7rgOtgtczg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 17:16:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eCChVesETUiL7rgOtgtczg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:16:20 INFO - Fetch https://queue.taskcluster.net/v1/task/eCChVesETUiL7rgOtgtczg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 17:16:20 INFO - Expected file size: 16362686 17:16:20 INFO - Obtained file size: 16362686 17:16:27 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:16:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eCChVesETUiL7rgOtgtczg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 17:16:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eCChVesETUiL7rgOtgtczg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:16:27 INFO - Fetch https://queue.taskcluster.net/v1/task/eCChVesETUiL7rgOtgtczg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 17:16:28 INFO - Expected file size: 16362686 17:16:28 INFO - Obtained file size: 16362686 17:16:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eCChVesETUiL7rgOtgtczg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 17:16:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eCChVesETUiL7rgOtgtczg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:16:35 INFO - Fetch https://queue.taskcluster.net/v1/task/eCChVesETUiL7rgOtgtczg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 17:16:36 INFO - Expected file size: 14403438 17:16:36 INFO - Obtained file size: 14403438 17:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:36 INFO - trying https://queue.taskcluster.net/v1/task/eCChVesETUiL7rgOtgtczg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 17:16:36 INFO - Downloading https://queue.taskcluster.net/v1/task/eCChVesETUiL7rgOtgtczg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 17:16:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eCChVesETUiL7rgOtgtczg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 17:16:38 INFO - Downloaded 70129093 bytes. 17:16:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eCChVesETUiL7rgOtgtczg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 17:16:38 INFO - mkdir: /builds/slave/test/properties 17:16:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:16:38 INFO - Writing to file /builds/slave/test/properties/build_url 17:16:38 INFO - Contents: 17:16:38 INFO - build_url:https://queue.taskcluster.net/v1/task/eCChVesETUiL7rgOtgtczg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 17:16:39 INFO - Running post-action listener: _resource_record_post_action 17:16:39 INFO - Running post-action listener: set_extra_try_arguments 17:16:39 INFO - [mozharness: 2017-01-27 01:16:39.274715Z] Finished download-and-extract step (success) 17:16:39 INFO - [mozharness: 2017-01-27 01:16:39.274867Z] Running populate-webroot step. 17:16:39 INFO - Running pre-action listener: _resource_record_pre_action 17:16:39 INFO - Running main action method: populate_webroot 17:16:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:16:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:16:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:16:39 INFO - '--tppagecycles', 17:16:39 INFO - '7'], 17:16:39 INFO - 'tests': ['tsvgm']}}, 17:16:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:16:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:16:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:16:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:16:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:16:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:16:39 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:16:39 INFO - 'talos_options': ['--disable-e10s'], 17:16:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:16:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:16:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:16:39 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:16:39 INFO - 'talos_options': ['--disable-e10s'], 17:16:39 INFO - 'tests': ['damp', 'tps']}, 17:16:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:16:39 INFO - 'tests': ['damp', 'tps']}, 17:16:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:16:39 INFO - 'tests': ['dromaeo_dom']}, 17:16:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:16:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:16:39 INFO - 'tests': ['basic_compositor_video']}, 17:16:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:16:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:16:39 INFO - 'tests': ['a11yr', 17:16:39 INFO - 'ts_paint', 17:16:39 INFO - 'tpaint', 17:16:39 INFO - 'sessionrestore', 17:16:39 INFO - 'sessionrestore_no_auto_restore', 17:16:39 INFO - 'tabpaint']}, 17:16:39 INFO - 'other-e10s': {'tests': ['a11yr', 17:16:39 INFO - 'ts_paint', 17:16:39 INFO - 'tpaint', 17:16:39 INFO - 'sessionrestore', 17:16:39 INFO - 'sessionrestore_no_auto_restore', 17:16:39 INFO - 'tabpaint']}, 17:16:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:16:39 INFO - 'ts_paint', 17:16:39 INFO - 'tpaint', 17:16:39 INFO - 'sessionrestore', 17:16:39 INFO - 'sessionrestore_no_auto_restore', 17:16:39 INFO - 'tabpaint']}, 17:16:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:16:39 INFO - 'ts_paint', 17:16:39 INFO - 'tpaint', 17:16:39 INFO - 'sessionrestore', 17:16:39 INFO - 'sessionrestore_no_auto_restore', 17:16:39 INFO - 'tabpaint']}, 17:16:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:16:39 INFO - 'tests': ['a11yr', 17:16:39 INFO - 'ts_paint', 17:16:39 INFO - 'tpaint', 17:16:39 INFO - 'sessionrestore', 17:16:39 INFO - 'sessionrestore_no_auto_restore', 17:16:39 INFO - 'tabpaint']}, 17:16:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:16:39 INFO - 'tests': ['a11yr', 17:16:39 INFO - 'ts_paint', 17:16:39 INFO - 'tpaint', 17:16:39 INFO - 'sessionrestore', 17:16:39 INFO - 'sessionrestore_no_auto_restore', 17:16:39 INFO - 'tabpaint']}, 17:16:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:16:39 INFO - 'tests': ['tsvgx', 17:16:39 INFO - 'tsvgr_opacity', 17:16:39 INFO - 'tart', 17:16:39 INFO - 'tscrollx', 17:16:39 INFO - 'cart', 17:16:39 INFO - 'tsvg_static']}, 17:16:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:16:39 INFO - 'tsvgr_opacity', 17:16:39 INFO - 'tart', 17:16:39 INFO - 'tscrollx', 17:16:39 INFO - 'cart', 17:16:39 INFO - 'tsvg_static']}, 17:16:39 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:16:39 INFO - 'talos_options': ['--disable-e10s'], 17:16:39 INFO - 'tests': ['tp5o']}, 17:16:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:16:39 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:16:39 INFO - 'talos_options': ['--disable-e10s', 17:16:39 INFO - '--xperf_path', 17:16:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:16:39 INFO - 'tests': ['tp5n']}, 17:16:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:16:39 INFO - 'talos_options': ['--xperf_path', 17:16:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:16:39 INFO - 'tests': ['tp5n']}}, 17:16:39 INFO - 'talos.zip': {'path': '', 17:16:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:16:39 INFO - Running post-action listener: _resource_record_post_action 17:16:39 INFO - [mozharness: 2017-01-27 01:16:39.293496Z] Finished populate-webroot step (success) 17:16:39 INFO - [mozharness: 2017-01-27 01:16:39.293608Z] Running create-virtualenv step. 17:16:39 INFO - Running pre-action listener: _resource_record_pre_action 17:16:39 INFO - Running main action method: create_virtualenv 17:16:39 INFO - Creating virtualenv /builds/slave/test/build/venv 17:16:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:16:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:16:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:16:39 INFO - Using real prefix '/tools/python27' 17:16:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:16:40 INFO - Installing distribute.............................................................................................................................................................................................done. 17:16:43 INFO - Installing pip.................done. 17:16:43 INFO - Return code: 0 17:16:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:16:43 INFO - Reading from file tmpfile_stdout 17:16:43 INFO - Output received: 17:16:43 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) 17:16:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:16:43 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')]} 17:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:43 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')]} 17:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:43 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 0x101860b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101863768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95c04e4f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10163ed30>, '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 0x101565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101633be8>, '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.CsZdZBElpC/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.zoHcWtIx2c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:16:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:16:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsZdZBElpC/Render', 17:16:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:16:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:16:43 INFO - 'HOME': '/Users/cltbld', 17:16:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:16:43 INFO - 'LOGNAME': 'cltbld', 17:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:43 INFO - 'MOZ_NO_REMOTE': '1', 17:16:43 INFO - 'NO_EM_RESTART': '1', 17:16:43 INFO - 'PAGER': '/bin/cat', 17:16:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:43 INFO - 'PWD': '/builds/slave/test', 17:16:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:16:43 INFO - 'SHELL': '/bin/bash', 17:16:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zoHcWtIx2c/Listeners', 17:16:43 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 17:16:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:16:43 INFO - 'USER': 'cltbld', 17:16:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:16:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:43 INFO - 'XPC_FLAGS': '0x0', 17:16:43 INFO - 'XPC_SERVICE_NAME': '0', 17:16:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:16:43 INFO - Cleaning up... 17:16:43 INFO - Return code: 0 17:16:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:16:43 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')]} 17:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:43 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')]} 17:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:43 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 0x101860b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101863768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95c04e4f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10163ed30>, '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 0x101565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101633be8>, '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.CsZdZBElpC/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.zoHcWtIx2c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:16:43 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 17:16:43 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 17:16:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsZdZBElpC/Render', 17:16:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:16:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:16:43 INFO - 'HOME': '/Users/cltbld', 17:16:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:16:43 INFO - 'LOGNAME': 'cltbld', 17:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:43 INFO - 'MOZ_NO_REMOTE': '1', 17:16:43 INFO - 'NO_EM_RESTART': '1', 17:16:43 INFO - 'PAGER': '/bin/cat', 17:16:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:43 INFO - 'PWD': '/builds/slave/test', 17:16:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:16:43 INFO - 'SHELL': '/bin/bash', 17:16:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zoHcWtIx2c/Listeners', 17:16:43 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 17:16:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:16:43 INFO - 'USER': 'cltbld', 17:16:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:16:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:43 INFO - 'XPC_FLAGS': '0x0', 17:16:43 INFO - 'XPC_SERVICE_NAME': '0', 17:16:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:44 INFO - Downloading/unpacking psutil>=3.1.1 17:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:16:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:16:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:16:47 INFO - Installing collected packages: psutil 17:16:47 INFO - Running setup.py install for psutil 17:16:47 INFO - building 'psutil._psutil_osx' extension 17:16:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 17:16:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 17:16:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 17:16:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 17:16:48 INFO - building 'psutil._psutil_posix' extension 17:16:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 17:16:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:16:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:16:48 INFO - ^ 17:16:48 INFO - 1 warning generated. 17:16:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 17:16:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:16:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:16:48 INFO - Successfully installed psutil 17:16:48 INFO - Cleaning up... 17:16:48 INFO - Return code: 0 17:16:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:16:48 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')]} 17:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:48 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')]} 17:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:48 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 0x101860b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101863768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95c04e4f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10163ed30>, '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 0x101565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101633be8>, '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.CsZdZBElpC/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.zoHcWtIx2c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:16:48 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 17:16:48 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 17:16:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsZdZBElpC/Render', 17:16:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:16:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:16:48 INFO - 'HOME': '/Users/cltbld', 17:16:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:16:48 INFO - 'LOGNAME': 'cltbld', 17:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:48 INFO - 'MOZ_NO_REMOTE': '1', 17:16:48 INFO - 'NO_EM_RESTART': '1', 17:16:48 INFO - 'PAGER': '/bin/cat', 17:16:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:48 INFO - 'PWD': '/builds/slave/test', 17:16:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:16:48 INFO - 'SHELL': '/bin/bash', 17:16:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zoHcWtIx2c/Listeners', 17:16:48 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 17:16:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:16:48 INFO - 'USER': 'cltbld', 17:16:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:16:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:48 INFO - 'XPC_FLAGS': '0x0', 17:16:48 INFO - 'XPC_SERVICE_NAME': '0', 17:16:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:16:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:16:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:16:51 INFO - Installing collected packages: mozsystemmonitor 17:16:51 INFO - Running setup.py install for mozsystemmonitor 17:16:51 INFO - Successfully installed mozsystemmonitor 17:16:51 INFO - Cleaning up... 17:16:52 INFO - Return code: 0 17:16:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101860b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101863768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95c04e4f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10163ed30>, '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 0x101565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101633be8>, '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.CsZdZBElpC/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.zoHcWtIx2c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:16:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:16:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:16:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsZdZBElpC/Render', 17:16:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:16:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:16:52 INFO - 'HOME': '/Users/cltbld', 17:16:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:16:52 INFO - 'LOGNAME': 'cltbld', 17:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:52 INFO - 'MOZ_NO_REMOTE': '1', 17:16:52 INFO - 'NO_EM_RESTART': '1', 17:16:52 INFO - 'PAGER': '/bin/cat', 17:16:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:52 INFO - 'PWD': '/builds/slave/test', 17:16:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:16:52 INFO - 'SHELL': '/bin/bash', 17:16:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zoHcWtIx2c/Listeners', 17:16:52 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 17:16:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:16:52 INFO - 'USER': 'cltbld', 17:16:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:16:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:52 INFO - 'XPC_FLAGS': '0x0', 17:16:52 INFO - 'XPC_SERVICE_NAME': '0', 17:16:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:52 INFO - Downloading/unpacking jsonschema==2.5.1 17:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:16:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:55 INFO - Downloading functools32-3.2.3-2.tar.gz 17:16:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:16:55 INFO - warning: no files found matching '*.txt' 17:16:55 INFO - no previously-included directories found matching 'build' 17:16:55 INFO - no previously-included directories found matching 'dist' 17:16:55 INFO - no previously-included directories found matching '.git*' 17:16:55 INFO - Installing collected packages: jsonschema, functools32 17:16:55 INFO - Running setup.py install for functools32 17:16:55 INFO - warning: no files found matching '*.txt' 17:16:55 INFO - no previously-included directories found matching 'build' 17:16:55 INFO - no previously-included directories found matching 'dist' 17:16:55 INFO - no previously-included directories found matching '.git*' 17:16:55 INFO - Successfully installed jsonschema functools32 17:16:55 INFO - Cleaning up... 17:16:55 INFO - Return code: 0 17:16:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:16:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:16:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101860b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101863768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95c04e4f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10163ed30>, '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 0x101565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101633be8>, '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.CsZdZBElpC/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.zoHcWtIx2c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:16:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:16:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:16:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsZdZBElpC/Render', 17:16:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:16:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:16:55 INFO - 'HOME': '/Users/cltbld', 17:16:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:16:55 INFO - 'LOGNAME': 'cltbld', 17:16:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:55 INFO - 'MOZ_NO_REMOTE': '1', 17:16:55 INFO - 'NO_EM_RESTART': '1', 17:16:55 INFO - 'PAGER': '/bin/cat', 17:16:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:16:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:55 INFO - 'PWD': '/builds/slave/test', 17:16:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:16:55 INFO - 'SHELL': '/bin/bash', 17:16:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zoHcWtIx2c/Listeners', 17:16:55 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 17:16:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:16:55 INFO - 'USER': 'cltbld', 17:16:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:16:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:16:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:55 INFO - 'XPC_FLAGS': '0x0', 17:16:55 INFO - 'XPC_SERVICE_NAME': '0', 17:16:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:16:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:16:56 INFO - Cleaning up... 17:16:56 INFO - Return code: 0 17:16:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:16:56 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')]} 17:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:56 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')]} 17:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:56 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 0x101860b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101863768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95c04e4f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10163ed30>, '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 0x101565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101633be8>, '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.CsZdZBElpC/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.zoHcWtIx2c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:16:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:16:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsZdZBElpC/Render', 17:16:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:16:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:16:56 INFO - 'HOME': '/Users/cltbld', 17:16:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:16:56 INFO - 'LOGNAME': 'cltbld', 17:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:56 INFO - 'MOZ_NO_REMOTE': '1', 17:16:56 INFO - 'NO_EM_RESTART': '1', 17:16:56 INFO - 'PAGER': '/bin/cat', 17:16:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:56 INFO - 'PWD': '/builds/slave/test', 17:16:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:16:56 INFO - 'SHELL': '/bin/bash', 17:16:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zoHcWtIx2c/Listeners', 17:16:56 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 17:16:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:16:56 INFO - 'USER': 'cltbld', 17:16:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:16:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:56 INFO - 'XPC_FLAGS': '0x0', 17:16:56 INFO - 'XPC_SERVICE_NAME': '0', 17:16:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:16:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:56 INFO - Downloading/unpacking blobuploader==1.2.4 17:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:58 INFO - Downloading blobuploader-1.2.4.tar.gz 17:16:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:16:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:16:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:00 INFO - Downloading docopt-0.6.1.tar.gz 17:17:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:17:00 INFO - Installing collected packages: blobuploader, requests, docopt 17:17:00 INFO - Running setup.py install for blobuploader 17:17:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:17:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:17:00 INFO - Running setup.py install for requests 17:17:00 INFO - Running setup.py install for docopt 17:17:01 INFO - Successfully installed blobuploader requests docopt 17:17:01 INFO - Cleaning up... 17:17:01 INFO - Return code: 0 17:17:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17: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')]} 17:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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')]} 17:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:01 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 0x101860b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101863768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95c04e4f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10163ed30>, '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 0x101565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101633be8>, '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.CsZdZBElpC/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.zoHcWtIx2c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:17:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:17:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsZdZBElpC/Render', 17:17:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:01 INFO - 'HOME': '/Users/cltbld', 17:17:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:01 INFO - 'LOGNAME': 'cltbld', 17:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:01 INFO - 'MOZ_NO_REMOTE': '1', 17:17:01 INFO - 'NO_EM_RESTART': '1', 17:17:01 INFO - 'PAGER': '/bin/cat', 17:17:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:01 INFO - 'PWD': '/builds/slave/test', 17:17:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:01 INFO - 'SHELL': '/bin/bash', 17:17:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zoHcWtIx2c/Listeners', 17:17:01 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 17:17:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:01 INFO - 'USER': 'cltbld', 17:17:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:01 INFO - 'XPC_FLAGS': '0x0', 17:17:01 INFO - 'XPC_SERVICE_NAME': '0', 17:17:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:17:01 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-qoxYXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:17:01 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-qwg0GF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:17:01 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-cWkWoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:17:01 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-i90nbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:17:01 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-o_p0kE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:17:01 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-NVXz2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:17:02 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-z5EGAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:17:02 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-2omJ8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:17:02 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-DX3B37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:17:02 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-LLxmtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:17:02 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-lhhW4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:17:02 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-rjHj7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:17:02 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-5lXcOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:17:02 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-7SQQDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:02 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-u2bvmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:17:03 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-EeUV3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:17:03 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-gkEtJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:17:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:17:03 INFO - Running setup.py install for manifestparser 17:17:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:17:03 INFO - Running setup.py install for mozcrash 17:17:03 INFO - Running setup.py install for mozdebug 17:17:03 INFO - Running setup.py install for mozdevice 17:17:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:17:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:17:03 INFO - Running setup.py install for mozfile 17:17:03 INFO - Running setup.py install for mozhttpd 17:17:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:17:04 INFO - Running setup.py install for mozinfo 17:17:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:17:04 INFO - Running setup.py install for mozInstall 17:17:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:17:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:17:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:17:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:17:04 INFO - Running setup.py install for mozleak 17:17:04 INFO - Running setup.py install for mozlog 17:17:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:17:04 INFO - Running setup.py install for moznetwork 17:17:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:17:04 INFO - Running setup.py install for mozprocess 17:17:05 INFO - Running setup.py install for mozprofile 17:17:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:17:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:17:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:17:05 INFO - Running setup.py install for mozrunner 17:17:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:17:05 INFO - Running setup.py install for mozscreenshot 17:17:05 INFO - Running setup.py install for moztest 17:17:05 INFO - Running setup.py install for mozversion 17:17:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:17:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:17:05 INFO - Cleaning up... 17:17:05 INFO - Return code: 0 17:17:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17: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')]} 17:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:06 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')]} 17:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:06 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 0x101860b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101863768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95c04e4f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10163ed30>, '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 0x101565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101633be8>, '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.CsZdZBElpC/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.zoHcWtIx2c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:17:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:17:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsZdZBElpC/Render', 17:17:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:06 INFO - 'HOME': '/Users/cltbld', 17:17:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:06 INFO - 'LOGNAME': 'cltbld', 17:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:06 INFO - 'MOZ_NO_REMOTE': '1', 17:17:06 INFO - 'NO_EM_RESTART': '1', 17:17:06 INFO - 'PAGER': '/bin/cat', 17:17:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:06 INFO - 'PWD': '/builds/slave/test', 17:17:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:06 INFO - 'SHELL': '/bin/bash', 17:17:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zoHcWtIx2c/Listeners', 17:17:06 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 17:17:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:06 INFO - 'USER': 'cltbld', 17:17:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:06 INFO - 'XPC_FLAGS': '0x0', 17:17:06 INFO - 'XPC_SERVICE_NAME': '0', 17:17:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:17:07 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-OkDgEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:17:07 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-c_pcQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:17:07 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)) 17:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:17:07 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-vHY5cN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:17:07 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-AILkwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:17:07 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-PydBUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:17:07 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-9vIplC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:17:07 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-zQ9xEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:17:07 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-WBwmNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:17:07 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-wiwQb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:17:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:17:08 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-PQXNDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:17:08 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)) 17:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:17:08 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-WYBbdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:17:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:17:08 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-MJa9bb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:17:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:17:08 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-we4aYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:17:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:17:08 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-5vcRo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:17:08 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)) 17:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:08 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-wm_lkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:17:08 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-BB4Zm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:17:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:17:08 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-af5SE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:17:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:17:08 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)) 17:17:08 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)) 17:17:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:17:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:17:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:17:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17:11 INFO - Downloading blessings-1.6.tar.gz 17:17:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:17:12 INFO - Installing collected packages: blessings 17:17:12 INFO - Running setup.py install for blessings 17:17:12 INFO - Successfully installed blessings 17:17:12 INFO - Cleaning up... 17:17:12 INFO - Return code: 0 17:17:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:17:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:17:12 INFO - Reading from file tmpfile_stdout 17:17:12 INFO - Current package versions: 17:17:12 INFO - blessings == 1.6 17:17:12 INFO - blobuploader == 1.2.4 17:17:12 INFO - docopt == 0.6.1 17:17:12 INFO - functools32 == 3.2.3-2 17:17:12 INFO - jsonschema == 2.5.1 17:17:12 INFO - manifestparser == 1.1 17:17:12 INFO - mozInstall == 1.12 17:17:12 INFO - mozcrash == 1.0 17:17:12 INFO - mozdebug == 0.1 17:17:12 INFO - mozdevice == 0.49 17:17:12 INFO - mozfile == 1.2 17:17:12 INFO - mozhttpd == 0.7 17:17:12 INFO - mozinfo == 0.9 17:17:12 INFO - mozleak == 0.1 17:17:12 INFO - mozlog == 3.4 17:17:12 INFO - moznetwork == 0.27 17:17:12 INFO - mozprocess == 0.24 17:17:12 INFO - mozprofile == 0.28 17:17:12 INFO - mozrunner == 6.13 17:17:12 INFO - mozscreenshot == 0.1 17:17:12 INFO - mozsystemmonitor == 0.3 17:17:12 INFO - moztest == 0.8 17:17:12 INFO - mozversion == 1.4 17:17:12 INFO - psutil == 3.1.1 17:17:12 INFO - requests == 1.2.3 17:17:12 INFO - wsgiref == 0.1.2 17:17:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:12 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 0x101860b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101863768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95c04e4f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10163ed30>, '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 0x101565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101633be8>, '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.CsZdZBElpC/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.zoHcWtIx2c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:17:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:17:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsZdZBElpC/Render', 17:17:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:12 INFO - 'HOME': '/Users/cltbld', 17:17:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:12 INFO - 'LOGNAME': 'cltbld', 17:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:12 INFO - 'MOZ_NO_REMOTE': '1', 17:17:12 INFO - 'NO_EM_RESTART': '1', 17:17:12 INFO - 'PAGER': '/bin/cat', 17:17:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:12 INFO - 'PWD': '/builds/slave/test', 17:17:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:12 INFO - 'SHELL': '/bin/bash', 17:17:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zoHcWtIx2c/Listeners', 17:17:12 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 17:17:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:12 INFO - 'USER': 'cltbld', 17:17:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:12 INFO - 'XPC_FLAGS': '0x0', 17:17:12 INFO - 'XPC_SERVICE_NAME': '0', 17:17:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:17:12 INFO - Cleaning up... 17:17:12 INFO - Return code: 0 17:17:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:12 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 0x101860b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101863768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95c04e4f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10163ed30>, '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 0x101565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101633be8>, '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.CsZdZBElpC/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.zoHcWtIx2c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:17:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:17:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsZdZBElpC/Render', 17:17:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:12 INFO - 'HOME': '/Users/cltbld', 17:17:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:12 INFO - 'LOGNAME': 'cltbld', 17:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:12 INFO - 'MOZ_NO_REMOTE': '1', 17:17:12 INFO - 'NO_EM_RESTART': '1', 17:17:12 INFO - 'PAGER': '/bin/cat', 17:17:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:12 INFO - 'PWD': '/builds/slave/test', 17:17:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:12 INFO - 'SHELL': '/bin/bash', 17:17:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zoHcWtIx2c/Listeners', 17:17:12 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 17:17:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:12 INFO - 'USER': 'cltbld', 17:17:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:12 INFO - 'XPC_FLAGS': '0x0', 17:17:12 INFO - 'XPC_SERVICE_NAME': '0', 17:17:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:17:13 INFO - Cleaning up... 17:17:13 INFO - Return code: 0 17:17:13 INFO - Running post-action listener: _resource_record_post_action 17:17:13 INFO - Running post-action listener: _start_resource_monitoring 17:17:13 INFO - Starting resource monitoring. 17:17:13 INFO - [mozharness: 2017-01-27 01:17:13.124331Z] Finished create-virtualenv step (success) 17:17:13 INFO - [mozharness: 2017-01-27 01:17:13.125297Z] Running install step. 17:17:13 INFO - Running pre-action listener: _resource_record_pre_action 17:17:13 INFO - Running main action method: install 17:17:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:17:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:17:13 INFO - Reading from file tmpfile_stdout 17:17:13 INFO - Detecting whether we're running mozinstall >=1.0... 17:17:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:17:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:17:13 INFO - Reading from file tmpfile_stdout 17:17:13 INFO - Output received: 17:17:13 INFO - Usage: mozinstall [options] installer 17:17:13 INFO - Options: 17:17:13 INFO - -h, --help show this help message and exit 17:17:13 INFO - -d DEST, --destination=DEST 17:17:13 INFO - Directory to install application into. [default: 17:17:13 INFO - "/builds/slave/test"] 17:17:13 INFO - --app=APP Application being installed. [default: firefox] 17:17:13 INFO - mkdir: /builds/slave/test/build/application 17:17:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:17:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:17:36 INFO - Reading from file tmpfile_stdout 17:17:36 INFO - Output received: 17:17:36 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:17:36 INFO - Running post-action listener: _resource_record_post_action 17:17:36 INFO - [mozharness: 2017-01-27 01:17:36.050326Z] Finished install step (success) 17:17:36 INFO - [mozharness: 2017-01-27 01:17:36.050478Z] Running run-tests step. 17:17:36 INFO - Running pre-action listener: _resource_record_pre_action 17:17:36 INFO - Running main action method: run_tests 17:17:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:17:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:17:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:17:36 INFO - 2017-01-26 17:17:36.065 screenresolution[1618:7381] starting screenresolution argv=screenresolution get 17:17:36 INFO - 2017-01-26 17:17:36.067 screenresolution[1618:7381] Display 0: 1600x1200x32@60 17:17:36 INFO - 2017-01-26 17:17:36.073 screenresolution[1619:7383] starting screenresolution argv=screenresolution list 17:17:36 INFO - Available Modes on Display 0 17:17:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:17:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:17:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:17:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:17:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:17:36 INFO - Intel Iris: 17:17:36 INFO - Chipset Model: Intel Iris 17:17:36 INFO - Type: GPU 17:17:36 INFO - Bus: Built-In 17:17:36 INFO - VRAM (Dynamic, Max): 1536 MB 17:17:36 INFO - Vendor: Intel (0x8086) 17:17:36 INFO - Device ID: 0x0a2e 17:17:36 INFO - Revision ID: 0x0009 17:17:36 INFO - Displays: 17:17:36 INFO - Display: 17:17:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:17:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:17:36 INFO - Display Serial Number: 1600x1200 60 17:17:36 INFO - Main Display: Yes 17:17:36 INFO - Mirror: Off 17:17:36 INFO - Online: Yes 17:17:36 INFO - Rotation: Supported 17:17:36 INFO - Return code: 0 17:17:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:17:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:17:36 INFO - Python 2.7.3 17:17:36 INFO - Return code: 0 17:17:36 INFO - grabbing minidump binary from tooltool 17:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:36 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 0x10163ed30>, '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 0x101565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101633be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:17:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:17:36 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 17:17:36 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 17:17:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:17:36 INFO - Return code: 0 17:17:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:17:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:17:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:17:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:17:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:17:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eCChVesETUiL7rgOtgtczg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0148', '--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 17:17:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eCChVesETUiL7rgOtgtczg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0148 --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 17:17:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CsZdZBElpC/Render', 17:17:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:36 INFO - 'HOME': '/Users/cltbld', 17:17:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:36 INFO - 'LOGNAME': 'cltbld', 17:17:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:17:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:36 INFO - 'MOZ_NO_REMOTE': '1', 17:17:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:17:36 INFO - 'NO_EM_RESTART': '1', 17:17:36 INFO - 'PAGER': '/bin/cat', 17:17:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:36 INFO - 'PWD': '/builds/slave/test', 17:17:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:17:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:36 INFO - 'SHELL': '/bin/bash', 17:17:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zoHcWtIx2c/Listeners', 17:17:36 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 17:17:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:36 INFO - 'USER': 'cltbld', 17:17:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:36 INFO - 'XPC_FLAGS': '0x0', 17:17:36 INFO - 'XPC_SERVICE_NAME': '0', 17:17:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eCChVesETUiL7rgOtgtczg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0148', '--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 17:17:36 INFO - mozversion application_buildid: 20170126160921 17:17:36 INFO - mozversion application_changeset: 3219566164175783539ba1976267fbd3517bd70f 17:17:36 INFO - mozversion application_display_name: Nightly 17:17:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:17:36 INFO - mozversion application_name: Firefox 17:17:36 INFO - mozversion application_remotingname: firefox 17:17:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:17:36 INFO - mozversion application_vendor: Mozilla 17:17:36 INFO - mozversion application_version: 54.0a1 17:17:36 INFO - mozversion platform_buildid: 20170126160921 17:17:36 INFO - mozversion platform_changeset: 3219566164175783539ba1976267fbd3517bd70f 17:17:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:17:36 INFO - mozversion platform_version: 54.0a1 17:17:36 INFO - using testdate: 1485479856 17:17:36 INFO - actual date: 1485479856 17:17:36 INFO - starting webserver on 'localhost:49240' 17:17:36 INFO - SUITE-START | Running 2 tests 17:17:36 INFO - TEST-START | dromaeo_css 17:17:36 INFO - operating with platform_type : mac_ 17:17:36 INFO - Initialising browser for dromaeo_css test... 17:17:36 INFO - TEST-INFO | started process 1629 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/tmpSy3VvQ/profile http://localhost:49240/getInfo.html) 17:17:39 INFO - PROCESS | 1629 | __metrics Screen width/height:1600/1200 17:17:39 INFO - PROCESS | 1629 | colorDepth:24 17:17:39 INFO - PROCESS | 1629 | Browser inner width/height: 1024/689 17:17:39 INFO - PROCESS | 1629 | __metrics 17:17:39 INFO - PROCESS | 1629 | 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" 17:17:39 INFO - PROCESS | 1629 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:17:40 INFO - TEST-INFO | 1629: exit 0 17:17:40 INFO - Browser initialized. 17:17:40 INFO - Running cycle 1/1 for dromaeo_css test... 17:17:40 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/tmpSy3VvQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:17:52 INFO - PROCESS | 1631 | RSS: Main: 235425792 17:17:52 INFO - PROCESS | 1631 | 17:20:56 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 17:20:57 INFO - PROCESS | 1631 | RSS: Main: 365809664 17:20:57 INFO - PROCESS | 1631 | 17:22:41 INFO - PROCESS | 1631 | ************************* 17:22:41 INFO - PROCESS | 1631 | A coding exception was thrown and uncaught in a Task. 17:22:41 INFO - PROCESS | 1631 | 17:22:41 ERROR - PROCESS | 1631 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:22:41 INFO - PROCESS | 1631 | Full stack: 17:22:41 INFO - PROCESS | 1631 | ************************* 17:24:00 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 17:24:01 INFO - PROCESS | 1631 | RSS: Main: 367562752 17:24:01 INFO - PROCESS | 1631 | 17:27:03 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 17:27:04 INFO - PROCESS | 1631 | RSS: Main: 333385728 17:27:04 INFO - PROCESS | 1631 | 17:30:06 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 17:30:07 INFO - PROCESS | 1631 | RSS: Main: 335495168 17:30:07 INFO - PROCESS | 1631 | 17:33:11 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 17:33:11 INFO - PROCESS | 1631 | RSS: Main: 330944512 17:33:11 INFO - PROCESS | 1631 | 17:36:15 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 17:36:15 INFO - PROCESS | 1631 | RSS: Main: 568586240 17:36:15 INFO - PROCESS | 1631 | 17:36:15 INFO - PROCESS | 1631 | __start_tp_report 17:36:15 INFO - PROCESS | 1631 | _x_x_mozilla_page_load 17:36:15 INFO - PROCESS | 1631 | _x_x_mozilla_page_load_details 17:36:15 INFO - PROCESS | 1631 | |i|pagename|runs| 17:36:15 INFO - PROCESS | 1631 | |0;dojo.html;2469.2715648883577;3320.103572035552;3332.166958260435;3360.6639336066382;3369.8483568239426;5469.917951230735;5562.666240025596;5566.081596536576;5601.579881508887;5656.349519805223;4706.105839890419;5556.388797232301;5593.188987596806;5678.772849086032;5682.289713785777;5025.246213068051;5062.0888240116765;5081.542661160494;5094.77073531692;5112.872178195537;4672.3197140521215;5101.107306221415;5210.16637338026;5229.790808367661;5276;5199.220116982445;5224.582033437335;5240.9213861792105;5242.580593552526;5244.659097158673;5011.899762004776;5027.572656324217;5080.669756465818;5088.92366614501;5090.821821236239;5091.414487333967;5116.641835071547;5137.332146820927;5143.485651434864;5170.922436163461;5570.972145139289;5573.27547418833;5579;5592.832215033555;5608.6634801911605;6055.5761096723245;6111.87776244477;6177.62934223948;6190.7523699052435;6228.844278893019;6072.878542429171;6121.112438696408;6175.258968923713;6186.226721659793;6191.783287584958;5653.236813030229;5701.914471282851;5715.371309155989;5725.513331366838;5726.484616384545;6161.353057928943;6200.844978875564;6223.3465486123305;6226.003839385767;6227.875442491125;6100.816975490742;6112;6113.602615829956;6115.235595550556;6130.816075517741;6011.12838638395;6078.817635470943;6099.573029887865;6115.301188036035;6136.365905528278;6051.273847138372;6102.755889764359;6119.694015299217;6139.386061393914;6158.291796443466;6114.024767184464;6168.722407491584;6187.041008643668;6193.102000209944;6202.5658203925295;4929.531694489017;4942.135126352874;4945.876353091202;4950.232713929347;4969.254611808257;4361.01877077655;4372.715773474714;4375;4396.900774806299;4416.492103408149;5621.550275977912;5676.978143934049;5692.516136128393;5734.77060917567;5748.109043098327;6062.727177277033;6129.570930034944;6169.629822210592;6189.381061893775;6222.81331560054;5507;5507.0637991541535;5540.2243685884005;5692.658440493584;5694.202811606378;5318.441563635763;5324.440933701983;5326.2543243945875;5326.520613144836;5327.547158491571;6162.168107305636;6196.876062478816;6221.688915554114;6231.501479881598;6232;6148.754049838135;6178.196834411498;6178.567500274938;6209.534284928739;6215.751369945332;6267.4045965633195;6271.905921411274;6281;6289.654069026247;6306.1801965746;6066.484348830399;6107.328193898578;6118.143459915705;6191.071339299141;6203.945329294121;6147.692615369303;6153.107799368977;6197.442230199304;6232.781852635136;6245.500359971283;5954.225950626391;6079.726412311368;6085.4523092921845;6106.2061931948565;6121.337218310049;5898.938191125467;6084.33072362031;6089.847753806191;6089.847753806191;6099.542534310033;5757.884842303214;5762.366139724543;5878.088896221093;5935.347111817783;6024;4976.900461990812;6103.69481525913;6115.694215289129;6134.202553667995;6141.048137538689;5869.413058694267;5927.2590926134235;5936.940630593812;5941.079132734433;5941.435563621449 17:36:15 INFO - PROCESS | 1631 | |1;ext.html;417.48857649379505;444.36677734228715;479;486.734729572383;511.9897602047957;30619.540706889413;40497.785066448014;41980;42153.57846421535;42191;43256.56743432565;43498.91252718684;43632.56367436325;43637.78181109098;43740;8356.874646880302;9199.586018629177;9393.76515587109;9396.671116510923;9403.247740180803;8352.037271241254;11078.335299881992;11309.660710178709;11335;11520.02079823216;11223.719407014809;11274.492647830868;11293.604723834667;11319.717007074847;11331.603393881216;8353.164683531659;11089.55641774328;11227.101831853432;11336.886631133748;11340.092792576615;8351.582420878993;10885.401302928336;11163.83254251187;11175.944120279428;11350.262232954832;40760.573379931855;41040.58959410398;41051.38422923659;41202.79398603018;41290.38064429036;3973.662238709713;3999.8800035998966;4005.859794907193;4040.353543433066;4153.8961525961795;30175.0947471574;30275.394492110034;30569.694303056905;31276.905308314326;31724.524132138038;3127.3119913618966;3145.308032232905;3145.7326127279207;3163.193385686658;3189.3940151371166;473699;479018;480327;482403;482722;61013.69493152506;61408.385916140265;61540.69229653913;61618.69190654018;61694.69152654208;59412.40587594155;59602.105968410506;59715;59719.40280597138;59836.70081649564;15428.151451670266;15891;15892.920535397248;15909.045457272601;15969;11148.052415544607;11434.542618295342;12389.1947023445;12457.875421245853;12459.127861049821;13712;14779.039362441406;16296.348146074024;16443.342266309453;16613.83386166147;7044.506884518035;7165.498415110997;7231.902748203068;7258.274172582699;7373.81565460857;755.3277582951177;844.2444012608681;861.978450538729;867.9826403471895;872.1118777845893;26884.731152688615;28179.859100704365;29414.027183224505;29815.40369192604;30374.696253037186;1007.2697294461603;1016.755978565139;1030.7423144213947;1041.7864337810731;1068.7862427514528;12421.565245216554;14432.134071955716;15401.691966160839;15535.922320388325;15982.840171598367;515134;585711;590553;590833.2750017507;591194;59881;60007;60126;60217.397826022054;60241;1371.8765311122047;1396.5461225101883;1413.6324555615408;1416.7591509443214;1421.147311613024;20869;28344.858275708488;29071.709282907745;29927;29929.401411972074;50270.748646256536;50507.74746126246;50560.48318550449;50683.74658126686;50879;507759;508142;509207;509232;510114;38917.61082389253;39462.81611551658;39558.95834881912;39768.403473947335;39931.60068399395;44632.66102016815;44935;46001.53998459972;46293;46344.30483542817;38026.619733802305;38643.42034869423;38769.6123038766;39586.40620390639;40313.929365892436;37471.79681728318;37620.435693465166;38608.80695596504;39109.8044509787;39168.804155979036;29246.561301580066;36277.09307267339;37310.62689373072;37426.8128659355;37797.62202377941;31778;33568.328633427685;33622;33659.49510757292;33883.814066507555;24157.879210603835;24338;24434.877825610758;25111.99552017899;25152.24543263705 17:36:15 INFO - PROCESS | 1631 | |2;jquery.html;325.9511073339;338.64780628146735;366.66083872418005;387.6956589077575;425.52978958251134;15105.697886042273;15106.697866042672;16012.519624411272;20553.69169462459;21185;20563.794362056375;20657.690134647994;21068.473288167803;21731.782682173172;21818.563628727417;4628.398308219927;5810.331811841639;6083.239595050619;6086.665233412161;6095.908561371583;5952.761889524414;5989.161517387569;6035.094735789645;6046.093086037085;6051.848703782419;5727.3699893011735;5877.412258774131;6007.699615019232;6015.097735339712;6023.578349515536;5914.9112763308585;5979.880402391971;5983.491403230731;5989.460948514655;5993.550483713695;4849.127157111719;5000.949990500121;5040.798368065273;5047.268146118792;5218.582513398919;25078.49843003148;25258.621120683205;25313;25336.619950700755;25564;3070;3123.094302652228;3124.4063627910623;3157.5263710443387;3262.3964566555264;12008.759824803543;14402.639934001629;15003.699926001418;15641.452549160726;15799.921000394925;1575.2675006122208;1808.728690696393;1855.5361159710073;1855.9628807423776;1858.6468570971472;128483;131180;131761;133262;133483;11050.557977680963;11083.949469348196;11164.497597608128;11174.832377514344;11230.3261804292;13948.372323245478;13974;13998.230097344744;14027.438902443992;14037;8168.264856162974;8446.493210407396;8451.197136272167;8558.700445484503;8622.82754344922;8357.707480238163;8361.289290410383;8363.247307742333;8520.233179013918;8556.058833528306;5714.9714251429305;6728.3271672832325;6887;6911.099255043772;6916.377526022682;1875.5217419557925;1913.7990510996424;1917.3672688012923;1921.5196200949763;1923.5768131011155;961.110972350573;975.6097560975525;1015.5480811039017;1026.7946410717886;1103.9503222355013;19532.14444627758;20106.69839952402;21141.154353825983;21877.67183492217;22020;1063.8936106389299;1073.586669132374;1076.2143635146388;1084.9294795838246;1089.4117176724637;10763.677089687166;11621.24461909973;11630.302181868945;11642.301461912313;11655.941720291345;703468;708121;710031.4404106694;726776;727225.3638731772;76732;110217;111390.44304778587;131181;137388;984.2126298960802;988.6737376665683;1035.1460045462522;1035.6892932120334;1038.8078205532001;19652.606947860677;19679.40961771149;20045.59908801845;20172.092255848227;20414.489637759176;52522;56238.43761562332;56276;57953.710231448575;58163;56604.71697641486;59137;76377.23622763701;76680.61659691666;81938;5776.595638305278;6020.247469066367;8028;8263;8466.872996904927;9353.345265831327;11386.316820990767;12682.556110536087;12725.681857953625;13314.06801523884;8828.38201325901;11038.889611103787;11061.059809915925;11359.886401135884;11442.256253343507;10921.945390272998;11040.834387484354;11106.389148596581;11347.20569560123;11374.20380573352;8306.410727954104;11454.312741235553;11640.01059909917;11780;11950;6685;8090.555019473985;8091.271785539094;8451.197136272045;8519.95740021296;10381.117605003357;10867.728306792393;11055.060319872578;11095.723991741053;11476.196666233618 17:36:15 INFO - PROCESS | 1631 | |3;mootools.html;1299.3373379576415;1405.4869972460049;1423.6939058102505;1423.75084360237;1428.5857101440583;7939.642716077776;8304.833903321938;8315.210055044769;8323.375746818983;8346.290565301957;7289.854202915939;7584.165741768401;7928.3657307415415;8040.35677145827;8172.795680108;2258.6160352740035;2293.151533932439;2303.49323148907;2303.79265866072;2306.261996161229;2266.829987750917;2299.8505097168713;2301.2866011536394;2304.043821813945;2311.1217737259817;1978.8416926645834;2057.19769289977;2198.681191227271;2198.87857192832;2274.101729816721;2263.9660405093937;2277.089164334263;2277.555876604063;2279.452931296477;2283.200879692111;2200.9779902201094;2248.1007596961344;2279.2022792022826;2281.1217681192693;2295.3228797504776;7999;8080.8383832323025;8087.919120808775;8090.110087890327;8104.432689711723;4976.776045077944;5123.513266239701;5133.358330208724;5134.229865520165;5145.151050076733;3319.5020746887917;3459.15250763562;3495.9475607865647;3537.1157210697324;3553.342631613134;1135.517405102828;1171.3059962087166;1178.499137866412;1220.8107743299802;1231.778279909616;10458.424786636808;10561.894381056169;10615.044645981821;10627.043566079014;10628.937106289464;3651.434027725707;3856.633619806114;4519;4553.385292985471;4620.5379462053525;9333.160015598629;9333.533323333806;9348.532573371303;9353.298502612332;9363.157315841607;5188.351456067991;5191.714455704972;5195.584353251731;5201.115810312256;5204.531592156724;4083.3670781028986;4259.637930775857;4398.626116780109;4663.440387153495;4675.3220782986955;3741.120836603396;3766.981165094157;3855.380740089169;3862.0731024553907;3886.1644746379097;1239.3183748938047;1251.2117366059324;1252.1047451072527;1256.428325112072;1261.4764872577778;766.3639179481017;849.587949844325;898.2364989758784;905.9909400906039;931.5063016601213;5378.811741589104;5389.299391079213;5583.664980101207;5735.569832262597;5756.510696590753;937.0863408176973;945.0039499376445;979.480875136179;988.3543899407406;998.1266391907081;3545.9645403545633;3775.320442320409;3785.545734511876;3828.8085595720104;3936.3505021671676;9464.384814987005;9731.978142295098;9800.950995244979;9816.558254878548;9848.556814943344;9172.587233574372;9597;9736.269779766546;9737.951310243403;9763.804723905625;6277.654728989858;7515;7693.846123077619;7704.92295077042;7714.382849372149;5510.504054634942;5585.664860108406;5587.804426845041;5753.964286428483;5867.559933004956;9044.773880653036;9181.724548263563;9188.173064424234;9193.632254709737;9198.080191980749;8951.955240223757;9122;9187.173154416134;9279.814403712024;9312.767180820534;6216.595921265103;6765.797026089225;6946.826329341807;7076.186238582423;7112.253213412517;7770.572618506037;7779;7906.762797115865;7930.325922296669;7934.047914250327;6918.517119901396;7082.822929426806;7085.433165346657;7189.5686258824635;7222.241664625139;6685.33146685347;6686.431653309329;6908.3437073477935;6922.411595014279;6934.4452443805385;6045.21412216409;6215.409536094064;6281.214848143982;6284.591501552384;6326.272478664829;3942.9014274643364;4621.075784842978;4639.466461356988;4710.458297295855;4808.2547205183255;4237.427947227208;4739.502352253102;5067.569256613229;5074.797008119782;5145.871353216199 17:36:15 INFO - PROCESS | 1631 | |4;prototype.html;331.9170207448138;359.6439524870379;365.18199233716484;365.2694610778443;369.4716555325883;4409.250427427337;5189.9101188750365;5191.117510023296;5221.973890130544;5241.5806735461165;5155.613329000331;5158.252053452256;5204.245384419266;5211.45279745626;5211.609129315298;3545.3795585772514;3638.599754027055;3908.514764389528;3966.226585815767;4054.2904991626497;3386.6782655647676;3506.1059429845354;3878.437626544149;4083.631983285603;4140.958590414102;4065.2316242434486;4074.816633251496;4092.611201935826;4096.97951510242;4102.876913692594;3480.7737497062735;3645.924452286555;3975.840966361342;3980.363141897297;4043.1509383029597;3164.1430404329476;3294.6540613235506;3328;3592.982035089834;3616.439451884936;4743.051389722069;5054.989002199575;5060.418051924039;5071.0365030644425;5110.696772323071;3973.781442020688;4047.4535937648334;4427.512973572904;4684.672072954894;4689.2966055091665;4322.82708691652;5491.890162196773;5513.62159460135;5527.723613819293;5541.390447050821;3337.632860385356;3994.5020617268524;4005.898377946059;4042.090529630839;4046.332355161395;4959.876003099916;5525.502704756591;5538.556915446755;5642.520385767215;5781.392953739839;3479.834255524377;3538.4161613333513;3622.8007459589976;4109.568495308009;4131;3488.4825101080605;4152.522459917148;4169.207850508394;4181.055809048807;4196.643285320721;4643.674942754043;4728.4798672146035;4766.404199475066;4786.856394308176;4803.423589169252;4744.926494087574;4859.854204373803;5615;5634.690092044895;5651.858703532444;1157.8147496400536;1180.014687735733;1309.240640428549;1362.7887677410017;1374.8762611365025;804.3967024731452;880.9823803524022;953.4374718915873;971.504532688334;991.1921783746224;4609.792559334771;4852.611791056707;4935.358403407534;4946.876328091755;4976.751162441936;4351.912961740811;4852.878678033077;5030.673006254582;5319.627626066215;5333.093374126408;3990.8004599769897;4568.259044573229;4576.352513095283;4627.976860115745;4822.517748225219;2324.697789287382;2413.915512957038;2659.380510197454;2776.6390369251867;2813.0027680346775;5510.614257001971;5516.310461192351;5567.331920169525;5590.944090559124;5648.237487939158;5135.922961155586;5169.053639425491;5423.511883930465;5534.335879694462;5582.385937546866;4327.564246647212;4584.4498660161;4791.808327666924;5504.394516603171;5522.861928451821;4856.514348565115;5045.268436076822;5330.680159190461;5347.55082971489;5356.517913387814;4341.854901941209;5150.948490515047;5231.581473482036;5262.8947421052135;5269.9447215586715;4786.569208771228;5472.398036216093;5635.577331700057;5638.915416268841;5740.827775166752;3621.3300539399243;3928.7624398314438;4052.371882358239;4058;4062.9390559141048;4499.66252531068;4531.705439146445;5208.401033881152;5586.357568879631;5713.342965558848;4688.038952014897;4699.6371052394425;5288.992085486822;5307.150855863043;5471.863203419787;5072.695638261716;5483.945160548503;5506.5870059744875;5507.173923911445;5512.503874651301;5001;5089.26205700164;5306.787728490817;5339.679619222859;5396.3524377075;5194.584433245256;5476.589255805751;5543.944560554504;5556;5606.831795046155;5398.62209645321;5428.6199966002005;5449.547703533505;5469.9179512306555;5470.72646367672 17:36:15 INFO - PROCESS | 1631 | |5;yui.html;718.9784306470808;719.33820884786;726.5277569579772;778.5990215039252;842.9536375499347;15099.924500377496;16117.194140292968;16167.75748363774;16183.190840457988;16188.75716864248;14772.6306842329;14911.776323355158;14912.925435372836;14917.179555124463;14922;673.3266733266734;694.035290945586;696.6516741629185;843.7595285343679;857.1086070486687;849.8342823149488;862.4609618988133;864.5979619476942;866.3372520022189;867.9305655547541;918.4305730447132;919.7976445182082;920.0293690156882;922.1101636920404;923.0354279777648;713.2439614009115;734.2914087905144;919.0441940381995;919.1268295119596;919.462114662923;655.5509476008949;667.6828506459442;672.5191488086042;675.166169780321;676.4993904510676;14996.850031499764;15447.691046179127;15510.457134000257;15524;15536.611584710472;10881.292715973437;13061.346932653425;13254.66863328415;13637.74642549012;14026.158430494203;13015.154014988995;13071.607851764462;13085.018623603268;13225.669358266121;13372.866271337356;4493.4832494263255;4517.548245175489;4555.521670224612;4671.906561868744;4724.385829842133;105578;106600.4669976653;106784.93215067827;107778;109820;10873.821052788233;10925.781484370267;11101.38942358178;11136.832947505794;11362;21230.46923826886;21285.46786330354;21293.041813118445;21293.68059479109;21314.467138321357;7593.886091708629;7679.884801727979;7779.3776497880035;7925.0489941207425;7970.840583188304;4199.202151591188;4200.432941552851;4242.53332133465;4260.829566817354;4262.7016108872085;3401.523786669868;3491.877784277538;3492.9126771830906;3494.266204097117;3499.5975462821593;634.536788144657;642.2838535033404;648.5298158834902;657.2638644717947;658.0359772932677;501.9196928491424;532.547334765454;541.1557969567488;545.3895213685428;553.8006317725616;9481.525923703788;9817.116459518678;9878.654247101316;10032.247581431422;10187.7453063674;604.7157835817159;624.4504835744607;645.9741610335628;662.493192707579;689.3692271571456;4451.666125040635;4746.6891942256425;4831.154547954094;4865.318855360252;4939.802407903644;96465.5176724112;97043.02956970481;98272;98408.01591984132;103726.48136759269;86418.56790716006;88002.55998719965;89613.55193223992;90264.5486772562;91555.54222228847;76667.46665066667;78263.21736782673;78985.21014789894;79294;80998.59500702695;7510.436717246119;9188.632454701738;9273.953630231807;9404.905950940403;9484.430934143973;48344.75827620839;50613.98772024613;51316.74341628268;51405.742971284904;53699;54111.188332174264;67769;68967;69749.30250697429;70207;9133.817323653622;11079;11191.888081119085;11262.267952583055;11281.21031527785;12292.569760058355;12405.255684658949;12719.109662323548;12927.418266177856;12998.610041698765;11504.94247528757;11851.822222666495;11903.82144267854;12118.878811211775;12280.631581052583;11579.305241685526;11773.17587768848;11867.169298149047;12132.090093243218;12231.204971676812;11779.528818847493;11872.465739041936;12029.278243305429;12215.08386871006;12219.51121955112;8400.705975290835;9500.47747373901;9690.854637180308;9814.362066465943;10358.741031474274;7815;8724.42333315175;8841;9293.559498277778;9878.802423951625 17:36:15 INFO - PROCESS | 1631 | __end_tp_report 17:36:15 INFO - PROCESS | 1631 | __start_cc_report 17:36:15 INFO - PROCESS | 1631 | _x_x_mozilla_cycle_collect,1405 17:36:15 INFO - PROCESS | 1631 | __end_cc_report 17:36:15 INFO - PROCESS | 1631 | __startTimestamp1485480975376__endTimestamp 17:36:15 INFO - PROCESS | 1631 | 17:36:15 INFO - PROCESS | 1631 | ------- Summary: start ------- 17:36:15 INFO - PROCESS | 1631 | Number of tests: 6 17:36:15 INFO - PROCESS | 1631 | 17:36:15 INFO - PROCESS | 1631 | [#0] dojo.html Cycles:165 Average:5666.26 Median:5935.35 stddev:663.31 (11.2%) stddev-sans-first:616.12 17:36:15 INFO - PROCESS | 1631 | Values: 2469.3 3320.1 3332.2 3360.7 3369.8 5469.9 5562.7 5566.1 5601.6 5656.3 4706.1 5556.4 5593.2 5678.8 5682.3 5025.2 5062.1 5081.5 5094.8 5112.9 4672.3 5101.1 5210.2 5229.8 5276.0 5199.2 5224.6 5240.9 5242.6 5244.7 5011.9 5027.6 5080.7 5088.9 5090.8 5091.4 5116.6 5137.3 5143.5 5170.9 5571.0 5573.3 5579.0 5592.8 5608.7 6055.6 6111.9 6177.6 6190.8 6228.8 6072.9 6121.1 6175.3 6186.2 6191.8 5653.2 5701.9 5715.4 5725.5 5726.5 6161.4 6200.8 6223.3 6226.0 6227.9 6100.8 6112.0 6113.6 6115.2 6130.8 6011.1 6078.8 6099.6 6115.3 6136.4 6051.3 6102.8 6119.7 6139.4 6158.3 6114.0 6168.7 6187.0 6193.1 6202.6 4929.5 4942.1 4945.9 4950.2 4969.3 4361.0 4372.7 4375.0 4396.9 4416.5 5621.6 5677.0 5692.5 5734.8 5748.1 6062.7 6129.6 6169.6 6189.4 6222.8 5507.0 5507.1 5540.2 5692.7 5694.2 5318.4 5324.4 5326.3 5326.5 5327.5 6162.2 6196.9 6221.7 6231.5 6232.0 6148.8 6178.2 6178.6 6209.5 6215.8 6267.4 6271.9 6281.0 6289.7 6306.2 6066.5 6107.3 6118.1 6191.1 6203.9 6147.7 6153.1 6197.4 6232.8 6245.5 5954.2 6079.7 6085.5 6106.2 6121.3 5898.9 6084.3 6089.8 6089.8 6099.5 5757.9 5762.4 5878.1 5935.3 6024.0 4976.9 6103.7 6115.7 6134.2 6141.0 5869.4 5927.3 5936.9 5941.1 5941.4 17:36:15 INFO - PROCESS | 1631 | 17:36:15 INFO - PROCESS | 1631 | [#1] ext.html Cycles:180 Average:66426.14 Median:39139.30 stddev:139202.26 (355.7%) stddev-sans-first:139504.54 17:36:15 INFO - PROCESS | 1631 | Values: 417.5 444.4 479.0 486.7 512.0 30619.5 40497.8 41980.0 42153.6 42191.0 43256.6 43498.9 43632.6 43637.8 43740.0 8356.9 9199.6 9393.8 9396.7 9403.2 8352.0 11078.3 11309.7 11335.0 11520.0 11223.7 11274.5 11293.6 11319.7 11331.6 8353.2 11089.6 11227.1 11336.9 11340.1 8351.6 10885.4 11163.8 11175.9 11350.3 40760.6 41040.6 41051.4 41202.8 41290.4 3973.7 3999.9 4005.9 4040.4 4153.9 30175.1 30275.4 30569.7 31276.9 31724.5 3127.3 3145.3 3145.7 3163.2 3189.4 473699.0 479018.0 480327.0 482403.0 482722.0 61013.7 61408.4 61540.7 61618.7 61694.7 59412.4 59602.1 59715.0 59719.4 59836.7 15428.2 15891.0 15892.9 15909.0 15969.0 11148.1 11434.5 12389.2 12457.9 12459.1 13712.0 14779.0 16296.3 16443.3 16613.8 7044.5 7165.5 7231.9 7258.3 7373.8 755.3 844.2 862.0 868.0 872.1 26884.7 28179.9 29414.0 29815.4 30374.7 1007.3 1016.8 1030.7 1041.8 1068.8 12421.6 14432.1 15401.7 15535.9 15982.8 515134.0 585711.0 590553.0 590833.3 591194.0 59881.0 60007.0 60126.0 60217.4 60241.0 1371.9 1396.5 1413.6 1416.8 1421.1 20869.0 28344.9 29071.7 29927.0 29929.4 50270.7 50507.7 50560.5 50683.7 50879.0 507759.0 508142.0 509207.0 509232.0 510114.0 38917.6 39462.8 39559.0 39768.4 39931.6 44632.7 44935.0 46001.5 46293.0 46344.3 38026.6 38643.4 38769.6 39586.4 40313.9 37471.8 37620.4 38608.8 39109.8 39168.8 29246.6 36277.1 37310.6 37426.8 37797.6 31778.0 33568.3 33622.0 33659.5 33883.8 24157.9 24338.0 24434.9 25112.0 25152.2 17:36:15 INFO - PROCESS | 1631 | 17:36:15 INFO - PROCESS | 1631 | [#2] jquery.html Cycles:180 Average:38230.45 Median:21948.84 stddev:118385.69 (539.4%) stddev-sans-first:118683.58 17:36:15 INFO - PROCESS | 1631 | Values: 326.0 338.6 366.7 387.7 425.5 15105.7 15106.7 16012.5 20553.7 21185.0 20563.8 20657.7 21068.5 21731.8 21818.6 4628.4 5810.3 6083.2 6086.7 6095.9 5952.8 5989.2 6035.1 6046.1 6051.8 5727.4 5877.4 6007.7 6015.1 6023.6 5914.9 5979.9 5983.5 5989.5 5993.6 4849.1 5000.9 5040.8 5047.3 5218.6 25078.5 25258.6 25313.0 25336.6 25564.0 3070.0 3123.1 3124.4 3157.5 3262.4 12008.8 14402.6 15003.7 15641.5 15799.9 1575.3 1808.7 1855.5 1856.0 1858.6 128483.0 131180.0 131761.0 133262.0 133483.0 11050.6 11083.9 11164.5 11174.8 11230.3 13948.4 13974.0 13998.2 14027.4 14037.0 8168.3 8446.5 8451.2 8558.7 8622.8 8357.7 8361.3 8363.2 8520.2 8556.1 5715.0 6728.3 6887.0 6911.1 6916.4 1875.5 1913.8 1917.4 1921.5 1923.6 961.1 975.6 1015.5 1026.8 1104.0 19532.1 20106.7 21141.2 21877.7 22020.0 1063.9 1073.6 1076.2 1084.9 1089.4 10763.7 11621.2 11630.3 11642.3 11655.9 703468.0 708121.0 710031.4 726776.0 727225.4 76732.0 110217.0 111390.4 131181.0 137388.0 984.2 988.7 1035.1 1035.7 1038.8 19652.6 19679.4 20045.6 20172.1 20414.5 52522.0 56238.4 56276.0 57953.7 58163.0 56604.7 59137.0 76377.2 76680.6 81938.0 5776.6 6020.2 8028.0 8263.0 8466.9 9353.3 11386.3 12682.6 12725.7 13314.1 8828.4 11038.9 11061.1 11359.9 11442.3 10921.9 11040.8 11106.4 11347.2 11374.2 8306.4 11454.3 11640.0 11780.0 11950.0 6685.0 8090.6 8091.3 8451.2 8520.0 10381.1 10867.7 11055.1 11095.7 11476.2 17:36:15 INFO - PROCESS | 1631 | 17:36:15 INFO - PROCESS | 1631 | [#3] mootools.html Cycles:180 Average:5320.42 Median:5384.06 stddev:2894.12 (53.8%) stddev-sans-first:2886.46 17:36:15 INFO - PROCESS | 1631 | Values: 1299.3 1405.5 1423.7 1423.8 1428.6 7939.6 8304.8 8315.2 8323.4 8346.3 7289.9 7584.2 7928.4 8040.4 8172.8 2258.6 2293.2 2303.5 2303.8 2306.3 2266.8 2299.9 2301.3 2304.0 2311.1 1978.8 2057.2 2198.7 2198.9 2274.1 2264.0 2277.1 2277.6 2279.5 2283.2 2201.0 2248.1 2279.2 2281.1 2295.3 7999.0 8080.8 8087.9 8090.1 8104.4 4976.8 5123.5 5133.4 5134.2 5145.2 3319.5 3459.2 3495.9 3537.1 3553.3 1135.5 1171.3 1178.5 1220.8 1231.8 10458.4 10561.9 10615.0 10627.0 10628.9 3651.4 3856.6 4519.0 4553.4 4620.5 9333.2 9333.5 9348.5 9353.3 9363.2 5188.4 5191.7 5195.6 5201.1 5204.5 4083.4 4259.6 4398.6 4663.4 4675.3 3741.1 3767.0 3855.4 3862.1 3886.2 1239.3 1251.2 1252.1 1256.4 1261.5 766.4 849.6 898.2 906.0 931.5 5378.8 5389.3 5583.7 5735.6 5756.5 937.1 945.0 979.5 988.4 998.1 3546.0 3775.3 3785.5 3828.8 3936.4 9464.4 9732.0 9801.0 9816.6 9848.6 9172.6 9597.0 9736.3 9738.0 9763.8 6277.7 7515.0 7693.8 7704.9 7714.4 5510.5 5585.7 5587.8 5754.0 5867.6 9044.8 9181.7 9188.2 9193.6 9198.1 8952.0 9122.0 9187.2 9279.8 9312.8 6216.6 6765.8 6946.8 7076.2 7112.3 7770.6 7779.0 7906.8 7930.3 7934.0 6918.5 7082.8 7085.4 7189.6 7222.2 6685.3 6686.4 6908.3 6922.4 6934.4 6045.2 6215.4 6281.2 6284.6 6326.3 3942.9 4621.1 4639.5 4710.5 4808.3 4237.4 4739.5 5067.6 5074.8 5145.9 17:36:15 INFO - PROCESS | 1631 | 17:36:15 INFO - PROCESS | 1631 | [#4] prototype.html Cycles:180 Average:4384.81 Median:4852.75 stddev:1311.44 (27.0%) stddev-sans-first:1279.36 17:36:15 INFO - PROCESS | 1631 | Values: 331.9 359.6 365.2 365.3 369.5 4409.3 5189.9 5191.1 5222.0 5241.6 5155.6 5158.3 5204.2 5211.5 5211.6 3545.4 3638.6 3908.5 3966.2 4054.3 3386.7 3506.1 3878.4 4083.6 4141.0 4065.2 4074.8 4092.6 4097.0 4102.9 3480.8 3645.9 3975.8 3980.4 4043.2 3164.1 3294.7 3328.0 3593.0 3616.4 4743.1 5055.0 5060.4 5071.0 5110.7 3973.8 4047.5 4427.5 4684.7 4689.3 4322.8 5491.9 5513.6 5527.7 5541.4 3337.6 3994.5 4005.9 4042.1 4046.3 4959.9 5525.5 5538.6 5642.5 5781.4 3479.8 3538.4 3622.8 4109.6 4131.0 3488.5 4152.5 4169.2 4181.1 4196.6 4643.7 4728.5 4766.4 4786.9 4803.4 4744.9 4859.9 5615.0 5634.7 5651.9 1157.8 1180.0 1309.2 1362.8 1374.9 804.4 881.0 953.4 971.5 991.2 4609.8 4852.6 4935.4 4946.9 4976.8 4351.9 4852.9 5030.7 5319.6 5333.1 3990.8 4568.3 4576.4 4628.0 4822.5 2324.7 2413.9 2659.4 2776.6 2813.0 5510.6 5516.3 5567.3 5590.9 5648.2 5135.9 5169.1 5423.5 5534.3 5582.4 4327.6 4584.4 4791.8 5504.4 5522.9 4856.5 5045.3 5330.7 5347.6 5356.5 4341.9 5150.9 5231.6 5262.9 5269.9 4786.6 5472.4 5635.6 5638.9 5740.8 3621.3 3928.8 4052.4 4058.0 4062.9 4499.7 4531.7 5208.4 5586.4 5713.3 4688.0 4699.6 5289.0 5307.2 5471.9 5072.7 5483.9 5506.6 5507.2 5512.5 5001.0 5089.3 5306.8 5339.7 5396.4 5194.6 5476.6 5543.9 5556.0 5606.8 5398.6 5428.6 5449.5 5469.9 5470.7 17:36:15 INFO - PROCESS | 1631 | 17:36:15 INFO - PROCESS | 1631 | [#5] yui.html Cycles:180 Average:20117.01 Median:50965.37 stddev:29303.26 (57.5%) stddev-sans-first:29349.27 17:36:15 INFO - PROCESS | 1631 | Values: 719.0 719.3 726.5 778.6 843.0 15099.9 16117.2 16167.8 16183.2 16188.8 14772.6 14911.8 14912.9 14917.2 14922.0 673.3 694.0 696.7 843.8 857.1 849.8 862.5 864.6 866.3 867.9 918.4 919.8 920.0 922.1 923.0 713.2 734.3 919.0 919.1 919.5 655.6 667.7 672.5 675.2 676.5 14996.9 15447.7 15510.5 15524.0 15536.6 10881.3 13061.3 13254.7 13637.7 14026.2 13015.2 13071.6 13085.0 13225.7 13372.9 4493.5 4517.5 4555.5 4671.9 4724.4 105578.0 106600.5 106784.9 107778.0 109820.0 10873.8 10925.8 11101.4 11136.8 11362.0 21230.5 21285.5 21293.0 21293.7 21314.5 7593.9 7679.9 7779.4 7925.0 7970.8 4199.2 4200.4 4242.5 4260.8 4262.7 3401.5 3491.9 3492.9 3494.3 3499.6 634.5 642.3 648.5 657.3 658.0 501.9 532.5 541.2 545.4 553.8 9481.5 9817.1 9878.7 10032.2 10187.7 604.7 624.5 646.0 662.5 689.4 4451.7 4746.7 4831.2 4865.3 4939.8 96465.5 97043.0 98272.0 98408.0 103726.5 86418.6 88002.6 89613.6 90264.5 91555.5 76667.5 78263.2 78985.2 79294.0 80998.6 7510.4 9188.6 9274.0 9404.9 9484.4 48344.8 50614.0 51316.7 51405.7 53699.0 54111.2 67769.0 68967.0 69749.3 70207.0 9133.8 11079.0 11191.9 11262.3 11281.2 12292.6 12405.3 12719.1 12927.4 12998.6 11504.9 11851.8 11903.8 12118.9 12280.6 11579.3 11773.2 11867.2 12132.1 12231.2 11779.5 11872.5 12029.3 12215.1 12219.5 8400.7 9500.5 9690.9 9814.4 10358.7 7815.0 8724.4 8841.0 9293.6 9878.8 17:36:15 INFO - PROCESS | 1631 | -------- Summary: end -------- 17:36:15 INFO - PROCESS | 1631 | 17:36:16 INFO - TEST-INFO | 1631: exit 0 17:36:16 INFO - TEST-OK | dromaeo_css | took 1119464ms 17:36:16 INFO - TEST-START | kraken 17:36:16 INFO - operating with platform_type : mac_ 17:36:16 INFO - Initialising browser for kraken test... 17:36:16 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/tmp_i2NBd/profile http://localhost:49240/getInfo.html) 17:36:18 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 17:36:18 INFO - PROCESS | 1641 | colorDepth:24 17:36:18 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 17:36:18 INFO - PROCESS | 1641 | __metrics 17:36:18 INFO - PROCESS | 1641 | 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" 17:36:18 INFO - PROCESS | 1641 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:36:19 INFO - TEST-INFO | 1641: exit 0 17:36:19 INFO - Browser initialized. 17:36:19 INFO - Running cycle 1/1 for kraken test... 17:36:19 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/tmp_i2NBd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:36:31 INFO - PROCESS | 1642 | RSS: Main: 235360256 17:36:31 INFO - PROCESS | 1642 | 17:36:34 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 17:36:35 INFO - PROCESS | 1642 | RSS: Main: 288468992 17:36:35 INFO - PROCESS | 1642 | 17:36:37 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 17:36:38 INFO - PROCESS | 1642 | RSS: Main: 289058816 17:36:38 INFO - PROCESS | 1642 | 17:36:41 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 17:36:42 INFO - PROCESS | 1642 | RSS: Main: 380633088 17:36:42 INFO - PROCESS | 1642 | 17:36:44 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 17:36:44 INFO - PROCESS | 1642 | RSS: Main: 281890816 17:36:44 INFO - PROCESS | 1642 | 17:36:46 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:36:47 INFO - PROCESS | 1642 | RSS: Main: 284753920 17:36:47 INFO - PROCESS | 1642 | 17:36:50 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 17:36:50 INFO - PROCESS | 1642 | RSS: Main: 327438336 17:36:50 INFO - PROCESS | 1642 | 17:36:53 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 17:36:54 INFO - PROCESS | 1642 | RSS: Main: 330469376 17:36:54 INFO - PROCESS | 1642 | 17:36:57 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 17:36:57 INFO - PROCESS | 1642 | RSS: Main: 326057984 17:36:57 INFO - PROCESS | 1642 | 17:36:59 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:37:00 INFO - PROCESS | 1642 | RSS: Main: 304046080 17:37:00 INFO - PROCESS | 1642 | 17:37:02 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:37:02 INFO - PROCESS | 1642 | RSS: Main: 308690944 17:37:02 INFO - PROCESS | 1642 | 17:37:04 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:37:05 INFO - PROCESS | 1642 | RSS: Main: 309727232 17:37:05 INFO - PROCESS | 1642 | 17:37:08 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:37:09 INFO - PROCESS | 1642 | RSS: Main: 326770688 17:37:09 INFO - PROCESS | 1642 | 17:37:12 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:37:12 INFO - PROCESS | 1642 | RSS: Main: 320667648 17:37:12 INFO - PROCESS | 1642 | 17:37:14 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 17:37:14 INFO - PROCESS | 1642 | RSS: Main: 365391872 17:37:14 INFO - PROCESS | 1642 | 17:37:14 INFO - PROCESS | 1642 | __start_tp_report 17:37:14 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 17:37:14 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 17:37:14 INFO - PROCESS | 1642 | |i|pagename|runs| 17:37:14 INFO - PROCESS | 1642 | |0;ai-astar;115;115;115;114;115;116;116;114;114;115 17:37:14 INFO - PROCESS | 1642 | |1;audio-beat-detection;143;110;110;153;143;142;110;112;129;110 17:37:14 INFO - PROCESS | 1642 | |2;audio-dft;182;188;183;187;184;185;183;184;184;186 17:37:14 INFO - PROCESS | 1642 | |3;audio-fft;78;58;59;88;60;58;61;60;76;58 17:37:14 INFO - PROCESS | 1642 | |4;audio-oscillator;91;71;86;70;68;69;86;73;102;112 17:37:14 INFO - PROCESS | 1642 | |5;imaging-gaussian-blur;90;87;89;87;89;86;90;87;89;91 17:37:14 INFO - PROCESS | 1642 | |6;imaging-darkroom;98;98;98;101;98;97;97;98;98;97 17:37:14 INFO - PROCESS | 1642 | |7;imaging-desaturate;87;86;89;88;89;85;88;87;87;85 17:37:14 INFO - PROCESS | 1642 | |8;json-parse-financial;58;56;57;57;57;57;56;55;55;55 17:37:14 INFO - PROCESS | 1642 | |9;json-stringify-tinderbox;70;73;80;73;73;71;72;72;71;72 17:37:14 INFO - PROCESS | 1642 | |10;stanford-crypto-aes;85;88;87;87;86;85;87;87;90;87 17:37:14 INFO - PROCESS | 1642 | |11;stanford-crypto-ccm;124;138;150;143;155;152;141;140;182;157 17:37:14 INFO - PROCESS | 1642 | |12;stanford-crypto-pbkdf2;175;170;184;172;174;173;172;175;175;174 17:37:14 INFO - PROCESS | 1642 | |13;stanford-crypto-sha256-iterative;66;68;67;67;67;66;67;65;69;65 17:37:14 INFO - PROCESS | 1642 | __end_tp_report 17:37:14 INFO - PROCESS | 1642 | __start_cc_report 17:37:14 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,1974 17:37:14 INFO - PROCESS | 1642 | __end_cc_report 17:37:14 INFO - PROCESS | 1642 | __startTimestamp1485481034843__endTimestamp 17:37:14 INFO - PROCESS | 1642 | 17:37:14 INFO - PROCESS | 1642 | ------- Summary: start ------- 17:37:14 INFO - PROCESS | 1642 | Number of tests: 14 17:37:14 INFO - PROCESS | 1642 | 17:37:14 INFO - PROCESS | 1642 | [#0] ai-astar Cycles:10 Average:114.90 Median:115.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 17:37:14 INFO - PROCESS | 1642 | Values: 115.0 115.0 115.0 114.0 115.0 116.0 116.0 114.0 114.0 115.0 17:37:14 INFO - PROCESS | 1642 | 17:37:14 INFO - PROCESS | 1642 | [#1] audio-beat-detection Cycles:10 Average:126.20 Median:135.50 stddev:17.61 (13.0%) stddev-sans-first:17.60 17:37:14 INFO - PROCESS | 1642 | Values: 143.0 110.0 110.0 153.0 143.0 142.0 110.0 112.0 129.0 110.0 17:37:14 INFO - PROCESS | 1642 | 17:37:14 INFO - PROCESS | 1642 | [#2] audio-dft Cycles:10 Average:184.60 Median:184.50 stddev:1.90 (1.0%) stddev-sans-first:1.76 17:37:14 INFO - PROCESS | 1642 | Values: 182.0 188.0 183.0 187.0 184.0 185.0 183.0 184.0 184.0 186.0 17:37:14 INFO - PROCESS | 1642 | 17:37:14 INFO - PROCESS | 1642 | [#3] audio-fft Cycles:10 Average:65.60 Median:60.50 stddev:10.88 (18.0%) stddev-sans-first:10.57 17:37:14 INFO - PROCESS | 1642 | Values: 78.0 58.0 59.0 88.0 60.0 58.0 61.0 60.0 76.0 58.0 17:37:14 INFO - PROCESS | 1642 | 17:37:14 INFO - PROCESS | 1642 | [#4] audio-oscillator Cycles:10 Average:82.80 Median:72.00 stddev:15.34 (21.3%) stddev-sans-first:15.98 17:37:14 INFO - PROCESS | 1642 | Values: 91.0 71.0 86.0 70.0 68.0 69.0 86.0 73.0 102.0 112.0 17:37:14 INFO - PROCESS | 1642 | 17:37:14 INFO - PROCESS | 1642 | [#5] imaging-gaussian-blur Cycles:10 Average:88.50 Median:89.00 stddev:1.65 (1.9%) stddev-sans-first:1.66 17:37:14 INFO - PROCESS | 1642 | Values: 90.0 87.0 89.0 87.0 89.0 86.0 90.0 87.0 89.0 91.0 17:37:14 INFO - PROCESS | 1642 | 17:37:14 INFO - PROCESS | 1642 | [#6] imaging-darkroom Cycles:10 Average:98.00 Median:98.00 stddev:1.15 (1.2%) stddev-sans-first:1.22 17:37:14 INFO - PROCESS | 1642 | Values: 98.0 98.0 98.0 101.0 98.0 97.0 97.0 98.0 98.0 97.0 17:37:14 INFO - PROCESS | 1642 | 17:37:14 INFO - PROCESS | 1642 | [#7] imaging-desaturate Cycles:10 Average:87.10 Median:87.50 stddev:1.45 (1.7%) stddev-sans-first:1.54 17:37:14 INFO - PROCESS | 1642 | Values: 87.0 86.0 89.0 88.0 89.0 85.0 88.0 87.0 87.0 85.0 17:37:14 INFO - PROCESS | 1642 | 17:37:14 INFO - PROCESS | 1642 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:57.00 stddev:1.06 (1.9%) stddev-sans-first:0.93 17:37:14 INFO - PROCESS | 1642 | Values: 58.0 56.0 57.0 57.0 57.0 57.0 56.0 55.0 55.0 55.0 17:37:14 INFO - PROCESS | 1642 | 17:37:14 INFO - PROCESS | 1642 | [#9] json-stringify-tinderbox Cycles:10 Average:72.70 Median:72.50 stddev:2.75 (3.8%) stddev-sans-first:2.74 17:37:14 INFO - PROCESS | 1642 | Values: 70.0 73.0 80.0 73.0 73.0 71.0 72.0 72.0 71.0 72.0 17:37:14 INFO - PROCESS | 1642 | 17:37:14 INFO - PROCESS | 1642 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:87.00 stddev:1.45 (1.7%) stddev-sans-first:1.36 17:37:14 INFO - PROCESS | 1642 | Values: 85.0 88.0 87.0 87.0 86.0 85.0 87.0 87.0 90.0 87.0 17:37:14 INFO - PROCESS | 1642 | 17:37:14 INFO - PROCESS | 1642 | [#11] stanford-crypto-ccm Cycles:10 Average:148.20 Median:151.00 stddev:15.35 (10.2%) stddev-sans-first:13.55 17:37:14 INFO - PROCESS | 1642 | Values: 124.0 138.0 150.0 143.0 155.0 152.0 141.0 140.0 182.0 157.0 17:37:14 INFO - PROCESS | 1642 | 17:37:14 INFO - PROCESS | 1642 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.40 Median:174.50 stddev:3.75 (2.1%) stddev-sans-first:3.97 17:37:14 INFO - PROCESS | 1642 | Values: 175.0 170.0 184.0 172.0 174.0 173.0 172.0 175.0 175.0 174.0 17:37:14 INFO - PROCESS | 1642 | 17:37:14 INFO - PROCESS | 1642 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.25 (1.9%) stddev-sans-first:1.30 17:37:14 INFO - PROCESS | 1642 | Values: 66.0 68.0 67.0 67.0 67.0 66.0 67.0 65.0 69.0 65.0 17:37:14 INFO - PROCESS | 1642 | -------- Summary: end -------- 17:37:14 INFO - PROCESS | 1642 | 17:37:15 INFO - TEST-INFO | 1642: exit 0 17:37:15 INFO - TEST-OK | kraken | took 59741ms 17:37:15 INFO - SUITE-END | took 1179s 17:37:15 INFO - Completed test suite (00:19:39) 17:37:15 INFO - javascript benchmark 17:37:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7190.714755959051, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2469.2715648883577, 3320.103572035552, 3332.166958260435, 3360.6639336066382, 3369.8483568239426, 5469.917951230735, 5562.666240025596, 5566.081596536576, 5601.579881508887, 5656.349519805223, 4706.105839890419, 5556.388797232301, 5593.188987596806, 5678.772849086032, 5682.289713785777, 5025.246213068051, 5062.0888240116765, 5081.542661160494, 5094.77073531692, 5112.872178195537, 4672.3197140521215, 5101.107306221415, 5210.16637338026, 5229.790808367661, 5276.0, 5199.220116982445, 5224.582033437335, 5240.9213861792105, 5242.580593552526, 5244.659097158673, 5011.899762004776, 5027.572656324217, 5080.669756465818, 5088.92366614501, 5090.821821236239, 5091.414487333967, 5116.641835071547, 5137.332146820927, 5143.485651434864, 5170.922436163461, 5570.972145139289, 5573.27547418833, 5579.0, 5592.832215033555, 5608.6634801911605, 6055.5761096723245, 6111.87776244477, 6177.62934223948, 6190.7523699052435, 6228.844278893019, 6072.878542429171, 6121.112438696408, 6175.258968923713, 6186.226721659793, 6191.783287584958, 5653.236813030229, 5701.914471282851, 5715.371309155989, 5725.513331366838, 5726.484616384545, 6161.353057928943, 6200.844978875564, 6223.3465486123305, 6226.003839385767, 6227.875442491125, 6100.816975490742, 6112.0, 6113.602615829956, 6115.235595550556, 6130.816075517741, 6011.12838638395, 6078.817635470943, 6099.573029887865, 6115.301188036035, 6136.365905528278, 6051.273847138372, 6102.755889764359, 6119.694015299217, 6139.386061393914, 6158.291796443466, 6114.024767184464, 6168.722407491584, 6187.041008643668, 6193.102000209944, 6202.5658203925295, 4929.531694489017, 4942.135126352874, 4945.876353091202, 4950.232713929347, 4969.254611808257, 4361.01877077655, 4372.715773474714, 4375.0, 4396.900774806299, 4416.492103408149, 5621.550275977912, 5676.978143934049, 5692.516136128393, 5734.77060917567, 5748.109043098327, 6062.727177277033, 6129.570930034944, 6169.629822210592, 6189.381061893775, 6222.81331560054, 5507.0, 5507.0637991541535, 5540.2243685884005, 5692.658440493584, 5694.202811606378, 5318.441563635763, 5324.440933701983, 5326.2543243945875, 5326.520613144836, 5327.547158491571, 6162.168107305636, 6196.876062478816, 6221.688915554114, 6231.501479881598, 6232.0, 6148.754049838135, 6178.196834411498, 6178.567500274938, 6209.534284928739, 6215.751369945332, 6267.4045965633195, 6271.905921411274, 6281.0, 6289.654069026247, 6306.1801965746, 6066.484348830399, 6107.328193898578, 6118.143459915705, 6191.071339299141, 6203.945329294121, 6147.692615369303, 6153.107799368977, 6197.442230199304, 6232.781852635136, 6245.500359971283, 5954.225950626391, 6079.726412311368, 6085.4523092921845, 6106.2061931948565, 6121.337218310049, 5898.938191125467, 6084.33072362031, 6089.847753806191, 6089.847753806191, 6099.542534310033, 5757.884842303214, 5762.366139724543, 5878.088896221093, 5935.347111817783, 6024.0, 4976.900461990812, 6103.69481525913, 6115.694215289129, 6134.202553667995, 6141.048137538689, 5869.413058694267, 5927.2590926134235, 5936.940630593812, 5941.079132734433, 5941.435563621449], "value": 5621.30070034098, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.48857649379505, 444.36677734228715, 479.0, 486.734729572383, 511.9897602047957, 30619.540706889413, 40497.785066448014, 41980.0, 42153.57846421535, 42191.0, 43256.56743432565, 43498.91252718684, 43632.56367436325, 43637.78181109098, 43740.0, 8356.874646880302, 9199.586018629177, 9393.76515587109, 9396.671116510923, 9403.247740180803, 8352.037271241254, 11078.335299881992, 11309.660710178709, 11335.0, 11520.02079823216, 11223.719407014809, 11274.492647830868, 11293.604723834667, 11319.717007074847, 11331.603393881216, 8353.164683531659, 11089.55641774328, 11227.101831853432, 11336.886631133748, 11340.092792576615, 8351.582420878993, 10885.401302928336, 11163.83254251187, 11175.944120279428, 11350.262232954832, 40760.573379931855, 41040.58959410398, 41051.38422923659, 41202.79398603018, 41290.38064429036, 3973.662238709713, 3999.8800035998966, 4005.859794907193, 4040.353543433066, 4153.8961525961795, 30175.0947471574, 30275.394492110034, 30569.694303056905, 31276.905308314326, 31724.524132138038, 3127.3119913618966, 3145.308032232905, 3145.7326127279207, 3163.193385686658, 3189.3940151371166, 473699.0, 479018.0, 480327.0, 482403.0, 482722.0, 61013.69493152506, 61408.385916140265, 61540.69229653913, 61618.69190654018, 61694.69152654208, 59412.40587594155, 59602.105968410506, 59715.0, 59719.40280597138, 59836.70081649564, 15428.151451670266, 15891.0, 15892.920535397248, 15909.045457272601, 15969.0, 11148.052415544607, 11434.542618295342, 12389.1947023445, 12457.875421245853, 12459.127861049821, 13712.0, 14779.039362441406, 16296.348146074024, 16443.342266309453, 16613.83386166147, 7044.506884518035, 7165.498415110997, 7231.902748203068, 7258.274172582699, 7373.81565460857, 755.3277582951177, 844.2444012608681, 861.978450538729, 867.9826403471895, 872.1118777845893, 26884.731152688615, 28179.859100704365, 29414.027183224505, 29815.40369192604, 30374.696253037186, 1007.2697294461603, 1016.755978565139, 1030.7423144213947, 1041.7864337810731, 1068.7862427514528, 12421.565245216554, 14432.134071955716, 15401.691966160839, 15535.922320388325, 15982.840171598367, 515134.0, 585711.0, 590553.0, 590833.2750017507, 591194.0, 59881.0, 60007.0, 60126.0, 60217.397826022054, 60241.0, 1371.8765311122047, 1396.5461225101883, 1413.6324555615408, 1416.7591509443214, 1421.147311613024, 20869.0, 28344.858275708488, 29071.709282907745, 29927.0, 29929.401411972074, 50270.748646256536, 50507.74746126246, 50560.48318550449, 50683.74658126686, 50879.0, 507759.0, 508142.0, 509207.0, 509232.0, 510114.0, 38917.61082389253, 39462.81611551658, 39558.95834881912, 39768.403473947335, 39931.60068399395, 44632.66102016815, 44935.0, 46001.53998459972, 46293.0, 46344.30483542817, 38026.619733802305, 38643.42034869423, 38769.6123038766, 39586.40620390639, 40313.929365892436, 37471.79681728318, 37620.435693465166, 38608.80695596504, 39109.8044509787, 39168.804155979036, 29246.561301580066, 36277.09307267339, 37310.62689373072, 37426.8128659355, 37797.62202377941, 31778.0, 33568.328633427685, 33622.0, 33659.49510757292, 33883.814066507555, 24157.879210603835, 24338.0, 24434.877825610758, 25111.99552017899, 25152.24543263705], "value": 19939.19895521361, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.9511073339, 338.64780628146735, 366.66083872418005, 387.6956589077575, 425.52978958251134, 15105.697886042273, 15106.697866042672, 16012.519624411272, 20553.69169462459, 21185.0, 20563.794362056375, 20657.690134647994, 21068.473288167803, 21731.782682173172, 21818.563628727417, 4628.398308219927, 5810.331811841639, 6083.239595050619, 6086.665233412161, 6095.908561371583, 5952.761889524414, 5989.161517387569, 6035.094735789645, 6046.093086037085, 6051.848703782419, 5727.3699893011735, 5877.412258774131, 6007.699615019232, 6015.097735339712, 6023.578349515536, 5914.9112763308585, 5979.880402391971, 5983.491403230731, 5989.460948514655, 5993.550483713695, 4849.127157111719, 5000.949990500121, 5040.798368065273, 5047.268146118792, 5218.582513398919, 25078.49843003148, 25258.621120683205, 25313.0, 25336.619950700755, 25564.0, 3070.0, 3123.094302652228, 3124.4063627910623, 3157.5263710443387, 3262.3964566555264, 12008.759824803543, 14402.639934001629, 15003.699926001418, 15641.452549160726, 15799.921000394925, 1575.2675006122208, 1808.728690696393, 1855.5361159710073, 1855.9628807423776, 1858.6468570971472, 128483.0, 131180.0, 131761.0, 133262.0, 133483.0, 11050.557977680963, 11083.949469348196, 11164.497597608128, 11174.832377514344, 11230.3261804292, 13948.372323245478, 13974.0, 13998.230097344744, 14027.438902443992, 14037.0, 8168.264856162974, 8446.493210407396, 8451.197136272167, 8558.700445484503, 8622.82754344922, 8357.707480238163, 8361.289290410383, 8363.247307742333, 8520.233179013918, 8556.058833528306, 5714.9714251429305, 6728.3271672832325, 6887.0, 6911.099255043772, 6916.377526022682, 1875.5217419557925, 1913.7990510996424, 1917.3672688012923, 1921.5196200949763, 1923.5768131011155, 961.110972350573, 975.6097560975525, 1015.5480811039017, 1026.7946410717886, 1103.9503222355013, 19532.14444627758, 20106.69839952402, 21141.154353825983, 21877.67183492217, 22020.0, 1063.8936106389299, 1073.586669132374, 1076.2143635146388, 1084.9294795838246, 1089.4117176724637, 10763.677089687166, 11621.24461909973, 11630.302181868945, 11642.301461912313, 11655.941720291345, 703468.0, 708121.0, 710031.4404106694, 726776.0, 727225.3638731772, 76732.0, 110217.0, 111390.44304778587, 131181.0, 137388.0, 984.2126298960802, 988.6737376665683, 1035.1460045462522, 1035.6892932120334, 1038.8078205532001, 19652.606947860677, 19679.40961771149, 20045.59908801845, 20172.092255848227, 20414.489637759176, 52522.0, 56238.43761562332, 56276.0, 57953.710231448575, 58163.0, 56604.71697641486, 59137.0, 76377.23622763701, 76680.61659691666, 81938.0, 5776.595638305278, 6020.247469066367, 8028.0, 8263.0, 8466.872996904927, 9353.345265831327, 11386.316820990767, 12682.556110536087, 12725.681857953625, 13314.06801523884, 8828.38201325901, 11038.889611103787, 11061.059809915925, 11359.886401135884, 11442.256253343507, 10921.945390272998, 11040.834387484354, 11106.389148596581, 11347.20569560123, 11374.20380573352, 8306.410727954104, 11454.312741235553, 11640.01059909917, 11780.0, 11950.0, 6685.0, 8090.555019473985, 8091.271785539094, 8451.197136272045, 8519.95740021296, 10381.117605003357, 10867.728306792393, 11055.060319872578, 11095.723991741053, 11476.196666233618], "value": 9841.453168436834, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1299.3373379576415, 1405.4869972460049, 1423.6939058102505, 1423.75084360237, 1428.5857101440583, 7939.642716077776, 8304.833903321938, 8315.210055044769, 8323.375746818983, 8346.290565301957, 7289.854202915939, 7584.165741768401, 7928.3657307415415, 8040.35677145827, 8172.795680108, 2258.6160352740035, 2293.151533932439, 2303.49323148907, 2303.79265866072, 2306.261996161229, 2266.829987750917, 2299.8505097168713, 2301.2866011536394, 2304.043821813945, 2311.1217737259817, 1978.8416926645834, 2057.19769289977, 2198.681191227271, 2198.87857192832, 2274.101729816721, 2263.9660405093937, 2277.089164334263, 2277.555876604063, 2279.452931296477, 2283.200879692111, 2200.9779902201094, 2248.1007596961344, 2279.2022792022826, 2281.1217681192693, 2295.3228797504776, 7999.0, 8080.8383832323025, 8087.919120808775, 8090.110087890327, 8104.432689711723, 4976.776045077944, 5123.513266239701, 5133.358330208724, 5134.229865520165, 5145.151050076733, 3319.5020746887917, 3459.15250763562, 3495.9475607865647, 3537.1157210697324, 3553.342631613134, 1135.517405102828, 1171.3059962087166, 1178.499137866412, 1220.8107743299802, 1231.778279909616, 10458.424786636808, 10561.894381056169, 10615.044645981821, 10627.043566079014, 10628.937106289464, 3651.434027725707, 3856.633619806114, 4519.0, 4553.385292985471, 4620.5379462053525, 9333.160015598629, 9333.533323333806, 9348.532573371303, 9353.298502612332, 9363.157315841607, 5188.351456067991, 5191.714455704972, 5195.584353251731, 5201.115810312256, 5204.531592156724, 4083.3670781028986, 4259.637930775857, 4398.626116780109, 4663.440387153495, 4675.3220782986955, 3741.120836603396, 3766.981165094157, 3855.380740089169, 3862.0731024553907, 3886.1644746379097, 1239.3183748938047, 1251.2117366059324, 1252.1047451072527, 1256.428325112072, 1261.4764872577778, 766.3639179481017, 849.587949844325, 898.2364989758784, 905.9909400906039, 931.5063016601213, 5378.811741589104, 5389.299391079213, 5583.664980101207, 5735.569832262597, 5756.510696590753, 937.0863408176973, 945.0039499376445, 979.480875136179, 988.3543899407406, 998.1266391907081, 3545.9645403545633, 3775.320442320409, 3785.545734511876, 3828.8085595720104, 3936.3505021671676, 9464.384814987005, 9731.978142295098, 9800.950995244979, 9816.558254878548, 9848.556814943344, 9172.587233574372, 9597.0, 9736.269779766546, 9737.951310243403, 9763.804723905625, 6277.654728989858, 7515.0, 7693.846123077619, 7704.92295077042, 7714.382849372149, 5510.504054634942, 5585.664860108406, 5587.804426845041, 5753.964286428483, 5867.559933004956, 9044.773880653036, 9181.724548263563, 9188.173064424234, 9193.632254709737, 9198.080191980749, 8951.955240223757, 9122.0, 9187.173154416134, 9279.814403712024, 9312.767180820534, 6216.595921265103, 6765.797026089225, 6946.826329341807, 7076.186238582423, 7112.253213412517, 7770.572618506037, 7779.0, 7906.762797115865, 7930.325922296669, 7934.047914250327, 6918.517119901396, 7082.822929426806, 7085.433165346657, 7189.5686258824635, 7222.241664625139, 6685.33146685347, 6686.431653309329, 6908.3437073477935, 6922.411595014279, 6934.4452443805385, 6045.21412216409, 6215.409536094064, 6281.214848143982, 6284.591501552384, 6326.272478664829, 3942.9014274643364, 4621.075784842978, 4639.466461356988, 4710.458297295855, 4808.2547205183255, 4237.427947227208, 4739.502352253102, 5067.569256613229, 5074.797008119782, 5145.871353216199], "value": 4334.473328800562, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.9170207448138, 359.6439524870379, 365.18199233716484, 365.2694610778443, 369.4716555325883, 4409.250427427337, 5189.9101188750365, 5191.117510023296, 5221.973890130544, 5241.5806735461165, 5155.613329000331, 5158.252053452256, 5204.245384419266, 5211.45279745626, 5211.609129315298, 3545.3795585772514, 3638.599754027055, 3908.514764389528, 3966.226585815767, 4054.2904991626497, 3386.6782655647676, 3506.1059429845354, 3878.437626544149, 4083.631983285603, 4140.958590414102, 4065.2316242434486, 4074.816633251496, 4092.611201935826, 4096.97951510242, 4102.876913692594, 3480.7737497062735, 3645.924452286555, 3975.840966361342, 3980.363141897297, 4043.1509383029597, 3164.1430404329476, 3294.6540613235506, 3328.0, 3592.982035089834, 3616.439451884936, 4743.051389722069, 5054.989002199575, 5060.418051924039, 5071.0365030644425, 5110.696772323071, 3973.781442020688, 4047.4535937648334, 4427.512973572904, 4684.672072954894, 4689.2966055091665, 4322.82708691652, 5491.890162196773, 5513.62159460135, 5527.723613819293, 5541.390447050821, 3337.632860385356, 3994.5020617268524, 4005.898377946059, 4042.090529630839, 4046.332355161395, 4959.876003099916, 5525.502704756591, 5538.556915446755, 5642.520385767215, 5781.392953739839, 3479.834255524377, 3538.4161613333513, 3622.8007459589976, 4109.568495308009, 4131.0, 3488.4825101080605, 4152.522459917148, 4169.207850508394, 4181.055809048807, 4196.643285320721, 4643.674942754043, 4728.4798672146035, 4766.404199475066, 4786.856394308176, 4803.423589169252, 4744.926494087574, 4859.854204373803, 5615.0, 5634.690092044895, 5651.858703532444, 1157.8147496400536, 1180.014687735733, 1309.240640428549, 1362.7887677410017, 1374.8762611365025, 804.3967024731452, 880.9823803524022, 953.4374718915873, 971.504532688334, 991.1921783746224, 4609.792559334771, 4852.611791056707, 4935.358403407534, 4946.876328091755, 4976.751162441936, 4351.912961740811, 4852.878678033077, 5030.673006254582, 5319.627626066215, 5333.093374126408, 3990.8004599769897, 4568.259044573229, 4576.352513095283, 4627.976860115745, 4822.517748225219, 2324.697789287382, 2413.915512957038, 2659.380510197454, 2776.6390369251867, 2813.0027680346775, 5510.614257001971, 5516.310461192351, 5567.331920169525, 5590.944090559124, 5648.237487939158, 5135.922961155586, 5169.053639425491, 5423.511883930465, 5534.335879694462, 5582.385937546866, 4327.564246647212, 4584.4498660161, 4791.808327666924, 5504.394516603171, 5522.861928451821, 4856.514348565115, 5045.268436076822, 5330.680159190461, 5347.55082971489, 5356.517913387814, 4341.854901941209, 5150.948490515047, 5231.581473482036, 5262.8947421052135, 5269.9447215586715, 4786.569208771228, 5472.398036216093, 5635.577331700057, 5638.915416268841, 5740.827775166752, 3621.3300539399243, 3928.7624398314438, 4052.371882358239, 4058.0, 4062.9390559141048, 4499.66252531068, 4531.705439146445, 5208.401033881152, 5586.357568879631, 5713.342965558848, 4688.038952014897, 4699.6371052394425, 5288.992085486822, 5307.150855863043, 5471.863203419787, 5072.695638261716, 5483.945160548503, 5506.5870059744875, 5507.173923911445, 5512.503874651301, 5001.0, 5089.26205700164, 5306.787728490817, 5339.679619222859, 5396.3524377075, 5194.584433245256, 5476.589255805751, 5543.944560554504, 5556.0, 5606.831795046155, 5398.62209645321, 5428.6199966002005, 5449.547703533505, 5469.9179512306555, 5470.72646367672], "value": 3986.7122389704214, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.9784306470808, 719.33820884786, 726.5277569579772, 778.5990215039252, 842.9536375499347, 15099.924500377496, 16117.194140292968, 16167.75748363774, 16183.190840457988, 16188.75716864248, 14772.6306842329, 14911.776323355158, 14912.925435372836, 14917.179555124463, 14922.0, 673.3266733266734, 694.035290945586, 696.6516741629185, 843.7595285343679, 857.1086070486687, 849.8342823149488, 862.4609618988133, 864.5979619476942, 866.3372520022189, 867.9305655547541, 918.4305730447132, 919.7976445182082, 920.0293690156882, 922.1101636920404, 923.0354279777648, 713.2439614009115, 734.2914087905144, 919.0441940381995, 919.1268295119596, 919.462114662923, 655.5509476008949, 667.6828506459442, 672.5191488086042, 675.166169780321, 676.4993904510676, 14996.850031499764, 15447.691046179127, 15510.457134000257, 15524.0, 15536.611584710472, 10881.292715973437, 13061.346932653425, 13254.66863328415, 13637.74642549012, 14026.158430494203, 13015.154014988995, 13071.607851764462, 13085.018623603268, 13225.669358266121, 13372.866271337356, 4493.4832494263255, 4517.548245175489, 4555.521670224612, 4671.906561868744, 4724.385829842133, 105578.0, 106600.4669976653, 106784.93215067827, 107778.0, 109820.0, 10873.821052788233, 10925.781484370267, 11101.38942358178, 11136.832947505794, 11362.0, 21230.46923826886, 21285.46786330354, 21293.041813118445, 21293.68059479109, 21314.467138321357, 7593.886091708629, 7679.884801727979, 7779.3776497880035, 7925.0489941207425, 7970.840583188304, 4199.202151591188, 4200.432941552851, 4242.53332133465, 4260.829566817354, 4262.7016108872085, 3401.523786669868, 3491.877784277538, 3492.9126771830906, 3494.266204097117, 3499.5975462821593, 634.536788144657, 642.2838535033404, 648.5298158834902, 657.2638644717947, 658.0359772932677, 501.9196928491424, 532.547334765454, 541.1557969567488, 545.3895213685428, 553.8006317725616, 9481.525923703788, 9817.116459518678, 9878.654247101316, 10032.247581431422, 10187.7453063674, 604.7157835817159, 624.4504835744607, 645.9741610335628, 662.493192707579, 689.3692271571456, 4451.666125040635, 4746.6891942256425, 4831.154547954094, 4865.318855360252, 4939.802407903644, 96465.5176724112, 97043.02956970481, 98272.0, 98408.01591984132, 103726.48136759269, 86418.56790716006, 88002.55998719965, 89613.55193223992, 90264.5486772562, 91555.54222228847, 76667.46665066667, 78263.21736782673, 78985.21014789894, 79294.0, 80998.59500702695, 7510.436717246119, 9188.632454701738, 9273.953630231807, 9404.905950940403, 9484.430934143973, 48344.75827620839, 50613.98772024613, 51316.74341628268, 51405.742971284904, 53699.0, 54111.188332174264, 67769.0, 68967.0, 69749.30250697429, 70207.0, 9133.817323653622, 11079.0, 11191.888081119085, 11262.267952583055, 11281.21031527785, 12292.569760058355, 12405.255684658949, 12719.109662323548, 12927.418266177856, 12998.610041698765, 11504.94247528757, 11851.822222666495, 11903.82144267854, 12118.878811211775, 12280.631581052583, 11579.305241685526, 11773.17587768848, 11867.169298149047, 12132.090093243218, 12231.204971676812, 11779.528818847493, 11872.465739041936, 12029.278243305429, 12215.08386871006, 12219.51121955112, 8400.705975290835, 9500.47747373901, 9690.854637180308, 9814.362066465943, 10358.741031474274, 7815.0, 8724.42333315175, 8841.0, 9293.559498277778, 9878.802423951625], "value": 7251.495673265049, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1452.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 115.0, 114.0, 115.0, 116.0, 116.0, 114.0, 114.0, 115.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 110.0, 153.0, 143.0, 142.0, 110.0, 112.0, 129.0, 110.0], "value": 126.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 188.0, 183.0, 187.0, 184.0, 185.0, 183.0, 184.0, 184.0, 186.0], "value": 184.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 58.0, 59.0, 88.0, 60.0, 58.0, 61.0, 60.0, 76.0, 58.0], "value": 65.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 71.0, 86.0, 70.0, 68.0, 69.0, 86.0, 73.0, 102.0, 112.0], "value": 82.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 87.0, 89.0, 86.0, 90.0, 87.0, 89.0, 91.0], "value": 88.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 98.0, 98.0, 101.0, 98.0, 97.0, 97.0, 98.0, 98.0, 97.0], "value": 98.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 89.0, 88.0, 89.0, 85.0, 88.0, 87.0, 87.0, 85.0], "value": 87.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 57.0, 57.0, 57.0, 57.0, 56.0, 55.0, 55.0, 55.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 80.0, 73.0, 73.0, 71.0, 72.0, 72.0, 71.0, 72.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 87.0, 87.0, 86.0, 85.0, 87.0, 87.0, 90.0, 87.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 138.0, 150.0, 143.0, 155.0, 152.0, 141.0, 140.0, 182.0, 157.0], "value": 148.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 170.0, 184.0, 172.0, 174.0, 173.0, 172.0, 175.0, 175.0, 174.0], "value": 174.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 67.0, 67.0, 66.0, 67.0, 65.0, 69.0, 65.0], "value": 66.7, "unit": "score"}]}]} 17:37:16 INFO - Return code: 0 17:37:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:37:16 ERROR - # TBPL SUCCESS # 17:37:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:37:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:37:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:37:16 INFO - 2017-01-26 17:37:16.134 screenresolution[1646:9696] starting screenresolution argv=screenresolution get 17:37:16 INFO - 2017-01-26 17:37:16.138 screenresolution[1646:9696] Display 0: 1600x1200x32@60 17:37:16 INFO - 2017-01-26 17:37:16.144 screenresolution[1647:9699] starting screenresolution argv=screenresolution list 17:37:16 INFO - Available Modes on Display 0 17:37:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:37:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:37:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:37:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:37:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:37:16 INFO - Intel Iris: 17:37:16 INFO - Chipset Model: Intel Iris 17:37:16 INFO - Type: GPU 17:37:16 INFO - Bus: Built-In 17:37:16 INFO - VRAM (Dynamic, Max): 1536 MB 17:37:16 INFO - Vendor: Intel (0x8086) 17:37:16 INFO - Device ID: 0x0a2e 17:37:16 INFO - Revision ID: 0x0009 17:37:16 INFO - Displays: 17:37:16 INFO - Display: 17:37:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:37:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:37:16 INFO - Display Serial Number: 1600x1200 60 17:37:16 INFO - Main Display: Yes 17:37:16 INFO - Mirror: Off 17:37:16 INFO - Online: Yes 17:37:16 INFO - Rotation: Supported 17:37:16 INFO - Return code: 0 17:37:16 INFO - Running post-action listener: _resource_record_post_action 17:37:16 INFO - [mozharness: 2017-01-27 01:37:16.388924Z] Finished run-tests step (success) 17:37:16 INFO - Running post-run listener: _resource_record_post_run 17:37:16 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 38925312; Write bytes: 550813184; Read time: 376; Write time: 1835 17:37:16 INFO - TinderboxPrint: CPU usage
53.5% 17:37:16 INFO - TinderboxPrint: I/O read bytes / time
38,925,312 / 376 17:37:16 INFO - TinderboxPrint: I/O write bytes / time
550,813,184 / 1,835 17:37:16 INFO - TinderboxPrint: CPU idle
2,235.6 (46.5%) 17:37:16 INFO - TinderboxPrint: CPU system
958.3 (19.9%) 17:37:16 INFO - TinderboxPrint: CPU user
1,615.9 (33.6%) 17:37:16 INFO - TinderboxPrint: Swap in / out
290,852,864 / 0 17:37:16 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 231856640; Write bytes: 224161792; Read time: 17580; Write time: 413 17:37:16 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 37991424; Write bytes: 297602560; Read time: 361; Write time: 1361 17:37:16 INFO - Running post-run listener: _upload_blobber_files 17:37:16 INFO - Blob upload gear active. 17:37:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:37:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:37:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:37:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:37:17 INFO - (blobuploader) - INFO - Open directory for files ... 17:37:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:37:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:37:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:18 INFO - (blobuploader) - INFO - Done attempting. 17:37:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:37:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:37:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:19 INFO - (blobuploader) - INFO - Done attempting. 17:37:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:37:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:37:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:20 INFO - (blobuploader) - INFO - Done attempting. 17:37:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:37:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:37:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:22 INFO - (blobuploader) - INFO - Done attempting. 17:37:22 INFO - (blobuploader) - INFO - Iteration through files over. 17:37:22 INFO - Return code: 0 17:37:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:37:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:37:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6409ff2763b7857b58132011061ba569269f62b39a1021e096ee6a4213880d300387527b39088a6087bb4f37f3e42f06438b09b902d6492f5389eb4e8461507e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ad4642936dfd13b83fbc9415394a3540290acd393c1e35aa96414b800a201d87071a0fc8fc33a51fd0be4c9e57621b41626253e4b33c95ccdfef7251a082ba6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac8df42c8765ebdb406846c3b9e3e321fe8953bee6efbf9b39e6446cbe6c1718fba2b346f9a6a01a524c1305bb2ffbe1b7bbfd7af037aaf5123c70505dff229d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e378b991036427464993df445a03e96735b914d4f2f7dac85d29beaa3119285e4a01d2acc7de48f560d8518dded0eab53b07263e3335255d2f3a7e4777111c6"} 17:37:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:37:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:37:22 INFO - Contents: 17:37:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6409ff2763b7857b58132011061ba569269f62b39a1021e096ee6a4213880d300387527b39088a6087bb4f37f3e42f06438b09b902d6492f5389eb4e8461507e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ad4642936dfd13b83fbc9415394a3540290acd393c1e35aa96414b800a201d87071a0fc8fc33a51fd0be4c9e57621b41626253e4b33c95ccdfef7251a082ba6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac8df42c8765ebdb406846c3b9e3e321fe8953bee6efbf9b39e6446cbe6c1718fba2b346f9a6a01a524c1305bb2ffbe1b7bbfd7af037aaf5123c70505dff229d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e378b991036427464993df445a03e96735b914d4f2f7dac85d29beaa3119285e4a01d2acc7de48f560d8518dded0eab53b07263e3335255d2f3a7e4777111c6"} 17:37:22 INFO - Running post-run listener: copy_logs_to_upload_dir 17:37:22 INFO - Copying logs to upload dir... 17:37:22 INFO - mkdir: /builds/slave/test/build/upload/logs 17:37:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.418571 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-01-26 17:37:22.972993) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-26 17:37:22.976270) ========= 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.CsZdZBElpC/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.zoHcWtIx2c/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6409ff2763b7857b58132011061ba569269f62b39a1021e096ee6a4213880d300387527b39088a6087bb4f37f3e42f06438b09b902d6492f5389eb4e8461507e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ad4642936dfd13b83fbc9415394a3540290acd393c1e35aa96414b800a201d87071a0fc8fc33a51fd0be4c9e57621b41626253e4b33c95ccdfef7251a082ba6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac8df42c8765ebdb406846c3b9e3e321fe8953bee6efbf9b39e6446cbe6c1718fba2b346f9a6a01a524c1305bb2ffbe1b7bbfd7af037aaf5123c70505dff229d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e378b991036427464993df445a03e96735b914d4f2f7dac85d29beaa3119285e4a01d2acc7de48f560d8518dded0eab53b07263e3335255d2f3a7e4777111c6"} build_url:https://queue.taskcluster.net/v1/task/eCChVesETUiL7rgOtgtczg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/eCChVesETUiL7rgOtgtczg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6409ff2763b7857b58132011061ba569269f62b39a1021e096ee6a4213880d300387527b39088a6087bb4f37f3e42f06438b09b902d6492f5389eb4e8461507e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ad4642936dfd13b83fbc9415394a3540290acd393c1e35aa96414b800a201d87071a0fc8fc33a51fd0be4c9e57621b41626253e4b33c95ccdfef7251a082ba6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac8df42c8765ebdb406846c3b9e3e321fe8953bee6efbf9b39e6446cbe6c1718fba2b346f9a6a01a524c1305bb2ffbe1b7bbfd7af037aaf5123c70505dff229d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e378b991036427464993df445a03e96735b914d4f2f7dac85d29beaa3119285e4a01d2acc7de48f560d8518dded0eab53b07263e3335255d2f3a7e4777111c6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-26 17:37:23.010859) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 17:37:23.011187) ========= 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.CsZdZBElpC/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.zoHcWtIx2c/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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.005010 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 17:37:23.059659) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-26 17:37:23.060000) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-26 17:37:23.060334) ========= ========= Total master_lag: 3.59 =========