builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0084 starttime: 1475642230.12 results: success (0) buildid: 20161004193600 builduid: 902b92fe5b1a4d02afbd3fa4d1a0c957 revision: af5a59737002cc4e8bb0f69acddb2583a9d952c6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 21:37:10.115449) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 21:37:10.115896) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 21:37:10.116165) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 21:37:10.140326) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 21:37:10.140660) ========= 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.pwSkaI98x9/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.UJGGrQIK3c/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-04 21:37:10-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.7M=0.001s 2016-10-04 21:37:10 (15.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123440 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 21:37:10.288266) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 21:37:10.288775) ========= 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.pwSkaI98x9/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.UJGGrQIK3c/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.028030 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 21:37:10.339618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 21:37:10.340170) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev af5a59737002cc4e8bb0f69acddb2583a9d952c6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev af5a59737002cc4e8bb0f69acddb2583a9d952c6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pwSkaI98x9/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.UJGGrQIK3c/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-04 21:37:10,413 truncating revision to first 12 chars 2016-10-04 21:37:10,414 Setting DEBUG logging. 2016-10-04 21:37:10,414 attempt 1/10 2016-10-04 21:37:10,414 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/af5a59737002?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 21:37:11,134 unpacking tar archive at: mozilla-aurora-af5a59737002/testing/mozharness/ program finished with exit code 0 elapsedTime=0.967849 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 21:37:11.330266) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 21:37:11.330581) ========= script_repo_revision: af5a59737002cc4e8bb0f69acddb2583a9d952c6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 21:37:11.331006) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 21:37:11.331281) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 21:37:11.349634) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-04 21:37:11.350250) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pwSkaI98x9/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.UJGGrQIK3c/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 21:37:11 INFO - MultiFileLogger online at 20161004 21:37:11 in /builds/slave/test 21:37:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 21:37:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:37:11 INFO - {'append_to_log': False, 21:37:11 INFO - 'base_work_dir': '/builds/slave/test', 21:37:11 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:37:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:37:11 INFO - 'branch': 'Mozilla-Aurora', 21:37:11 INFO - 'buildbot_json_path': 'buildprops.json', 21:37:11 INFO - 'config_files': ('talos/mac_config.py',), 21:37:11 INFO - 'default_actions': ('clobber', 21:37:11 INFO - 'read-buildbot-config', 21:37:11 INFO - 'download-and-extract', 21:37:11 INFO - 'populate-webroot', 21:37:11 INFO - 'create-virtualenv', 21:37:11 INFO - 'install', 21:37:11 INFO - 'run-tests'), 21:37:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:37:11 INFO - 'download_minidump_stackwalk': True, 21:37:11 INFO - 'download_symbols': 'ondemand', 21:37:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:37:11 INFO - 'tooltool.py': '/tools/tooltool.py', 21:37:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:37:11 INFO - '/tools/misc-python/virtualenv.py')}, 21:37:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:37:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:37:11 INFO - 'installer_path': 'installer.exe', 21:37:11 INFO - 'log_level': 'info', 21:37:11 INFO - 'log_name': 'talos', 21:37:11 INFO - 'log_to_console': True, 21:37:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:37:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:37:11 INFO - 'opt_config_files': (), 21:37:11 INFO - 'pip_index': False, 21:37:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:37:11 INFO - 'cmd': ('bash', 21:37:11 INFO - '-c', 21:37:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:37:11 INFO - 'enabled': True, 21:37:11 INFO - 'halt_on_failure': False, 21:37:11 INFO - 'name': 'check_screen_resolution'},), 21:37:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:37:11 INFO - 'cmd': ('bash', 21:37:11 INFO - '-c', 21:37:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:37:11 INFO - 'enabled': True, 21:37:11 INFO - 'halt_on_failure': False, 21:37:11 INFO - 'name': 'check_screen_resolution'},), 21:37:11 INFO - 'run_cmd_checks_enabled': True, 21:37:11 INFO - 'sps_profile': False, 21:37:11 INFO - 'sps_profile_interval': 0, 21:37:11 INFO - 'suite': 'dromaeojs', 21:37:11 INFO - 'system_bits': '32', 21:37:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:37:11 INFO - 'title': 't-yosemite-r7-0084', 21:37:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:37:11 INFO - 'use_talos_json': True, 21:37:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:37:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:37:11 INFO - 'work_dir': 'build'} 21:37:11 INFO - [mozharness: 2016-10-05 04:37:11.547684Z] Running clobber step. 21:37:11 INFO - Running pre-action listener: _resource_record_pre_action 21:37:11 INFO - Running main action method: clobber 21:37:11 INFO - rmtree: /builds/slave/test/build 21:37:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:37:14 INFO - Running post-action listener: _resource_record_post_action 21:37:14 INFO - [mozharness: 2016-10-05 04:37:14.313627Z] Finished clobber step (success) 21:37:14 INFO - [mozharness: 2016-10-05 04:37:14.313757Z] Running read-buildbot-config step. 21:37:14 INFO - Running pre-action listener: _resource_record_pre_action 21:37:14 INFO - Running main action method: read_buildbot_config 21:37:14 INFO - Using buildbot properties: 21:37:14 INFO - { 21:37:14 INFO - "project": "", 21:37:14 INFO - "product": "firefox", 21:37:14 INFO - "script_repo_revision": "production", 21:37:14 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 21:37:14 INFO - "repository": "", 21:37:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 21:37:14 INFO - "buildid": "20161004193600", 21:37:14 INFO - "pgo_build": "False", 21:37:14 INFO - "basedir": "/builds/slave/test", 21:37:14 INFO - "buildnumber": 36, 21:37:14 INFO - "slavename": "t-yosemite-r7-0084", 21:37:14 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 21:37:14 INFO - "platform": "yosemite_r7", 21:37:14 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 21:37:14 INFO - "branch": "mozilla-aurora", 21:37:14 INFO - "repo_path": "releases/mozilla-aurora", 21:37:14 INFO - "revision": "af5a59737002cc4e8bb0f69acddb2583a9d952c6", 21:37:14 INFO - "stage_platform": "macosx64", 21:37:14 INFO - "builduid": "902b92fe5b1a4d02afbd3fa4d1a0c957", 21:37:14 INFO - "slavebuilddir": "test" 21:37:14 INFO - } 21:37:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/N50Imj_0QLeZ3wI-dThumg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 21:37:14 INFO - Running post-action listener: _resource_record_post_action 21:37:14 INFO - [mozharness: 2016-10-05 04:37:14.317242Z] Finished read-buildbot-config step (success) 21:37:14 INFO - [mozharness: 2016-10-05 04:37:14.317365Z] Running download-and-extract step. 21:37:14 INFO - Running pre-action listener: _resource_record_pre_action 21:37:14 INFO - Running main action method: download_and_extract 21:37:14 INFO - mkdir: /builds/slave/test/build/tests 21:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:37:14 INFO - trying https://queue.taskcluster.net/v1/task/N50Imj_0QLeZ3wI-dThumg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 21:37:14 INFO - Downloading https://queue.taskcluster.net/v1/task/N50Imj_0QLeZ3wI-dThumg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 21:37:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N50Imj_0QLeZ3wI-dThumg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 21:37:15 INFO - Downloaded 1199 bytes. 21:37:15 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 21:37:15 INFO - Using the following test package requirements: 21:37:15 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 21:37:15 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:37:15 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 21:37:15 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:37:15 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 21:37:15 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:37:15 INFO - u'jsshell-mac.zip'], 21:37:15 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:37:15 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 21:37:15 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 21:37:15 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:37:15 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 21:37:15 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:37:15 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 21:37:15 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:37:15 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 21:37:15 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:37:15 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 21:37:15 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 21:37:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N50Imj_0QLeZ3wI-dThumg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 21:37:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N50Imj_0QLeZ3wI-dThumg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 21:37:15 INFO - Fetch https://queue.taskcluster.net/v1/task/N50Imj_0QLeZ3wI-dThumg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 21:37:15 INFO - Expected file size: 16434082 21:37:22 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 21:37:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N50Imj_0QLeZ3wI-dThumg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 21:37:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N50Imj_0QLeZ3wI-dThumg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 21:37:22 INFO - Fetch https://queue.taskcluster.net/v1/task/N50Imj_0QLeZ3wI-dThumg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 21:37:23 INFO - Expected file size: 16434082 21:37:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N50Imj_0QLeZ3wI-dThumg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 21:37:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N50Imj_0QLeZ3wI-dThumg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 21:37:30 INFO - Fetch https://queue.taskcluster.net/v1/task/N50Imj_0QLeZ3wI-dThumg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 21:37:30 INFO - Expected file size: 14414059 21:37:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:37:31 INFO - trying https://queue.taskcluster.net/v1/task/N50Imj_0QLeZ3wI-dThumg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:37:31 INFO - Downloading https://queue.taskcluster.net/v1/task/N50Imj_0QLeZ3wI-dThumg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 21:37:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N50Imj_0QLeZ3wI-dThumg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 21:37:34 INFO - Downloaded 115322914 bytes. 21:37:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N50Imj_0QLeZ3wI-dThumg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:37:34 INFO - mkdir: /builds/slave/test/properties 21:37:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:37:34 INFO - Writing to file /builds/slave/test/properties/build_url 21:37:34 INFO - Contents: 21:37:34 INFO - build_url:https://queue.taskcluster.net/v1/task/N50Imj_0QLeZ3wI-dThumg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:37:35 INFO - Running post-action listener: _resource_record_post_action 21:37:35 INFO - Running post-action listener: set_extra_try_arguments 21:37:35 INFO - [mozharness: 2016-10-05 04:37:35.279152Z] Finished download-and-extract step (success) 21:37:35 INFO - [mozharness: 2016-10-05 04:37:35.279279Z] Running populate-webroot step. 21:37:35 INFO - Running pre-action listener: _resource_record_pre_action 21:37:35 INFO - Running main action method: populate_webroot 21:37:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:37:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:37:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:37:35 INFO - '--tppagecycles', 21:37:35 INFO - '7'], 21:37:35 INFO - 'tests': ['tsvgm']}}, 21:37:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:37:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:37:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:37:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:37:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:37:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:37:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:37:35 INFO - 'talos_options': ['--disable-e10s'], 21:37:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:37:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:37:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:37:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:37:35 INFO - 'talos_options': ['--disable-e10s'], 21:37:35 INFO - 'tests': ['damp', 'tps']}, 21:37:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:37:35 INFO - 'tests': ['damp', 'tps']}, 21:37:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:37:35 INFO - 'tests': ['dromaeo_dom']}, 21:37:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:37:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:37:35 INFO - 'tests': ['basic_compositor_video']}, 21:37:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:37:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:37:35 INFO - 'tests': ['a11yr', 21:37:35 INFO - 'ts_paint', 21:37:35 INFO - 'tpaint', 21:37:35 INFO - 'sessionrestore', 21:37:35 INFO - 'sessionrestore_no_auto_restore', 21:37:35 INFO - 'tabpaint']}, 21:37:35 INFO - 'other-e10s': {'tests': ['a11yr', 21:37:35 INFO - 'ts_paint', 21:37:35 INFO - 'tpaint', 21:37:35 INFO - 'sessionrestore', 21:37:35 INFO - 'sessionrestore_no_auto_restore', 21:37:35 INFO - 'tabpaint']}, 21:37:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:37:35 INFO - 'ts_paint', 21:37:35 INFO - 'tpaint', 21:37:35 INFO - 'sessionrestore', 21:37:35 INFO - 'sessionrestore_no_auto_restore', 21:37:35 INFO - 'tabpaint']}, 21:37:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:37:35 INFO - 'ts_paint', 21:37:35 INFO - 'tpaint', 21:37:35 INFO - 'sessionrestore', 21:37:35 INFO - 'sessionrestore_no_auto_restore', 21:37:35 INFO - 'tabpaint']}, 21:37:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:37:35 INFO - 'tests': ['a11yr', 21:37:35 INFO - 'ts_paint', 21:37:35 INFO - 'tpaint', 21:37:35 INFO - 'sessionrestore', 21:37:35 INFO - 'sessionrestore_no_auto_restore', 21:37:35 INFO - 'tabpaint']}, 21:37:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:37:35 INFO - 'tests': ['a11yr', 21:37:35 INFO - 'ts_paint', 21:37:35 INFO - 'tpaint', 21:37:35 INFO - 'sessionrestore', 21:37:35 INFO - 'sessionrestore_no_auto_restore', 21:37:35 INFO - 'tabpaint']}, 21:37:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:37:35 INFO - 'tests': ['tsvgx', 21:37:35 INFO - 'tsvgr_opacity', 21:37:35 INFO - 'tart', 21:37:35 INFO - 'tscrollx', 21:37:35 INFO - 'cart']}, 21:37:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:37:35 INFO - 'tsvgr_opacity', 21:37:35 INFO - 'tart', 21:37:35 INFO - 'tscrollx', 21:37:35 INFO - 'cart']}, 21:37:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:37:35 INFO - 'talos_options': ['--disable-e10s'], 21:37:35 INFO - 'tests': ['tp5o']}, 21:37:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:37:35 INFO - 'tests': ['tp5o']}, 21:37:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:37:35 INFO - 'talos_options': ['--disable-e10s', 21:37:35 INFO - '--xperf_path', 21:37:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:37:35 INFO - 'tests': ['tp5n']}, 21:37:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:37:35 INFO - 'talos_options': ['--xperf_path', 21:37:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:37:35 INFO - 'tests': ['tp5n']}}, 21:37:35 INFO - 'talos.zip': {'path': '', 21:37:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:37:35 INFO - Running post-action listener: _resource_record_post_action 21:37:35 INFO - [mozharness: 2016-10-05 04:37:35.298561Z] Finished populate-webroot step (success) 21:37:35 INFO - [mozharness: 2016-10-05 04:37:35.298692Z] Running create-virtualenv step. 21:37:35 INFO - Running pre-action listener: _resource_record_pre_action 21:37:35 INFO - Running main action method: create_virtualenv 21:37:35 INFO - Creating virtualenv /builds/slave/test/build/venv 21:37:35 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 21:37:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:37:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:37:35 INFO - Using real prefix '/tools/python27' 21:37:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:37:36 INFO - Installing distribute.............................................................................................................................................................................................done. 21:37:38 INFO - Installing pip.................done. 21:37:38 INFO - Return code: 0 21:37:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:37:38 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')]} 21:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:38 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')]} 21:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:38 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 0x1021dc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102152570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9418475930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ff0d30>, '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 0x101e56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fe8b20>, '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.pwSkaI98x9/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.UJGGrQIK3c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 21:37:38 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 21:37:38 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 21:37:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pwSkaI98x9/Render', 21:37:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:37:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:37:38 INFO - 'HOME': '/Users/cltbld', 21:37:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:37:38 INFO - 'LOGNAME': 'cltbld', 21:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:37:38 INFO - 'MOZ_NO_REMOTE': '1', 21:37:38 INFO - 'NO_EM_RESTART': '1', 21:37:38 INFO - 'PAGER': '/bin/cat', 21:37:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:37:38 INFO - 'PWD': '/builds/slave/test', 21:37:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:37:38 INFO - 'SHELL': '/bin/bash', 21:37:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UJGGrQIK3c/Listeners', 21:37:38 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 21:37:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:37:38 INFO - 'USER': 'cltbld', 21:37:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:37:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:37:38 INFO - 'XPC_FLAGS': '0x0', 21:37:38 INFO - 'XPC_SERVICE_NAME': '0', 21:37:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:37:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:37:39 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 21:37:39 INFO - Cleaning up... 21:37:39 INFO - Return code: 0 21:37:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:37:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:37:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:37:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1021dc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102152570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9418475930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ff0d30>, '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 0x101e56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fe8b20>, '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.pwSkaI98x9/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.UJGGrQIK3c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 21:37:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:37:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pwSkaI98x9/Render', 21:37:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:37:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:37:39 INFO - 'HOME': '/Users/cltbld', 21:37:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:37:39 INFO - 'LOGNAME': 'cltbld', 21:37:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:37:39 INFO - 'MOZ_NO_REMOTE': '1', 21:37:39 INFO - 'NO_EM_RESTART': '1', 21:37:39 INFO - 'PAGER': '/bin/cat', 21:37:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:37:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:37:39 INFO - 'PWD': '/builds/slave/test', 21:37:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:37:39 INFO - 'SHELL': '/bin/bash', 21:37:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UJGGrQIK3c/Listeners', 21:37:39 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 21:37:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:37:39 INFO - 'USER': 'cltbld', 21:37:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:37:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:37:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:37:39 INFO - 'XPC_FLAGS': '0x0', 21:37:39 INFO - 'XPC_SERVICE_NAME': '0', 21:37:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:37:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:37:39 INFO - Downloading/unpacking psutil>=3.1.1 21:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:37:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:37:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:37:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:37:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:37:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:37:42 INFO - Installing collected packages: psutil 21:37:42 INFO - Running setup.py install for psutil 21:37:42 INFO - building 'psutil._psutil_osx' extension 21:37:42 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 21:37:43 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 21:37:43 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 21:37:43 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 21:37:43 INFO - building 'psutil._psutil_posix' extension 21:37:43 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 21:37:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:37:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:37:43 INFO - ^ 21:37:43 INFO - 1 warning generated. 21:37:43 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 21:37:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:37:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:37:43 INFO - Successfully installed psutil 21:37:43 INFO - Cleaning up... 21:37:43 INFO - Return code: 0 21:37:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:37: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')]} 21:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:37:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37: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')]} 21:37:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:37:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1021dc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102152570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9418475930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ff0d30>, '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 0x101e56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fe8b20>, '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.pwSkaI98x9/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.UJGGrQIK3c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 21:37: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:37: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 mozsystemmonitor==0.3 21:37:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pwSkaI98x9/Render', 21:37:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:37:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:37:43 INFO - 'HOME': '/Users/cltbld', 21:37:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:37:43 INFO - 'LOGNAME': 'cltbld', 21:37:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:37:43 INFO - 'MOZ_NO_REMOTE': '1', 21:37:43 INFO - 'NO_EM_RESTART': '1', 21:37:43 INFO - 'PAGER': '/bin/cat', 21:37:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:37:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:37:43 INFO - 'PWD': '/builds/slave/test', 21:37:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:37:43 INFO - 'SHELL': '/bin/bash', 21:37:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UJGGrQIK3c/Listeners', 21:37:43 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 21:37:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:37:43 INFO - 'USER': 'cltbld', 21:37:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:37:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:37:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:37:43 INFO - 'XPC_FLAGS': '0x0', 21:37:43 INFO - 'XPC_SERVICE_NAME': '0', 21:37:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:37:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:37:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:37:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:37:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:37:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:37:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:37:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:37:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:37:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:37:46 INFO - Installing collected packages: mozsystemmonitor 21:37:46 INFO - Running setup.py install for mozsystemmonitor 21:37:46 INFO - Successfully installed mozsystemmonitor 21:37:46 INFO - Cleaning up... 21:37:46 INFO - Return code: 0 21:37:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:37:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:37:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:37:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:46 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 0x1021dc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102152570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9418475930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ff0d30>, '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 0x101e56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fe8b20>, '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.pwSkaI98x9/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.UJGGrQIK3c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 21:37:46 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 21:37:46 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 21:37:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pwSkaI98x9/Render', 21:37:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:37:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:37:46 INFO - 'HOME': '/Users/cltbld', 21:37:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:37:46 INFO - 'LOGNAME': 'cltbld', 21:37:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:37:46 INFO - 'MOZ_NO_REMOTE': '1', 21:37:46 INFO - 'NO_EM_RESTART': '1', 21:37:46 INFO - 'PAGER': '/bin/cat', 21:37:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:37:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:37:46 INFO - 'PWD': '/builds/slave/test', 21:37:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:37:46 INFO - 'SHELL': '/bin/bash', 21:37:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UJGGrQIK3c/Listeners', 21:37:46 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 21:37:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:37:46 INFO - 'USER': 'cltbld', 21:37:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:37:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:37:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:37:46 INFO - 'XPC_FLAGS': '0x0', 21:37:46 INFO - 'XPC_SERVICE_NAME': '0', 21:37:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:37:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:37:47 INFO - Downloading/unpacking jsonschema==2.5.1 21:37:47 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 21:37:47 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 21:37:47 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 21:37:47 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 21:37:47 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 21:37:47 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 21:37:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:37:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:37: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 21:37: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 21:37: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 21:37: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 21:37: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 21:37: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 21:37:49 INFO - Downloading functools32-3.2.3-2.tar.gz 21:37:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:37:50 INFO - warning: no files found matching '*.txt' 21:37:50 INFO - no previously-included directories found matching 'build' 21:37:50 INFO - no previously-included directories found matching 'dist' 21:37:50 INFO - no previously-included directories found matching '.git*' 21:37:50 INFO - Installing collected packages: jsonschema, functools32 21:37:50 INFO - Running setup.py install for functools32 21:37:50 INFO - warning: no files found matching '*.txt' 21:37:50 INFO - no previously-included directories found matching 'build' 21:37:50 INFO - no previously-included directories found matching 'dist' 21:37:50 INFO - no previously-included directories found matching '.git*' 21:37:50 INFO - Successfully installed jsonschema functools32 21:37:50 INFO - Cleaning up... 21:37:50 INFO - Return code: 0 21:37:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:37:50 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')]} 21:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:37:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:50 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')]} 21:37:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:37:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:50 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 0x1021dc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102152570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9418475930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ff0d30>, '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 0x101e56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fe8b20>, '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.pwSkaI98x9/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.UJGGrQIK3c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 21:37:50 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 21:37:50 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 21:37:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pwSkaI98x9/Render', 21:37:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:37:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:37:50 INFO - 'HOME': '/Users/cltbld', 21:37:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:37:50 INFO - 'LOGNAME': 'cltbld', 21:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:37:50 INFO - 'MOZ_NO_REMOTE': '1', 21:37:50 INFO - 'NO_EM_RESTART': '1', 21:37:50 INFO - 'PAGER': '/bin/cat', 21:37:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:37:50 INFO - 'PWD': '/builds/slave/test', 21:37:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:37:50 INFO - 'SHELL': '/bin/bash', 21:37:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UJGGrQIK3c/Listeners', 21:37:50 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 21:37:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:37:50 INFO - 'USER': 'cltbld', 21:37:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:37:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:37:50 INFO - 'XPC_FLAGS': '0x0', 21:37:50 INFO - 'XPC_SERVICE_NAME': '0', 21:37:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:37:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:37:50 INFO - Cleaning up... 21:37:50 INFO - Return code: 0 21:37:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:37:50 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')]} 21:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:37:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:50 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')]} 21:37:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:37:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:50 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 0x1021dc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102152570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9418475930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ff0d30>, '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 0x101e56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fe8b20>, '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.pwSkaI98x9/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.UJGGrQIK3c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 21:37:50 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 21:37:50 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 21:37:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pwSkaI98x9/Render', 21:37:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:37:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:37:50 INFO - 'HOME': '/Users/cltbld', 21:37:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:37:50 INFO - 'LOGNAME': 'cltbld', 21:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:37:50 INFO - 'MOZ_NO_REMOTE': '1', 21:37:50 INFO - 'NO_EM_RESTART': '1', 21:37:50 INFO - 'PAGER': '/bin/cat', 21:37:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:37:50 INFO - 'PWD': '/builds/slave/test', 21:37:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:37:50 INFO - 'SHELL': '/bin/bash', 21:37:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UJGGrQIK3c/Listeners', 21:37:50 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 21:37:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:37:50 INFO - 'USER': 'cltbld', 21:37:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:37:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:37:50 INFO - 'XPC_FLAGS': '0x0', 21:37:50 INFO - 'XPC_SERVICE_NAME': '0', 21:37:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:37:50 INFO - Downloading/unpacking blobuploader==1.2.4 21:37:50 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 21:37:50 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 21:37:50 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 21:37:50 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 21:37:50 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 21:37:50 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 21:37:53 INFO - Downloading blobuploader-1.2.4.tar.gz 21:37:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:37:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:37:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:37:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:37:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:37:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:37:54 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 21:37:54 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 21:37:54 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 21:37:54 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 21:37:54 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 21:37:54 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 21:37:54 INFO - Downloading docopt-0.6.1.tar.gz 21:37:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:37:54 INFO - Installing collected packages: blobuploader, requests, docopt 21:37:54 INFO - Running setup.py install for blobuploader 21:37:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:37:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:37:54 INFO - Running setup.py install for requests 21:37:55 INFO - Running setup.py install for docopt 21:37:55 INFO - Successfully installed blobuploader requests docopt 21:37:55 INFO - Cleaning up... 21:37:55 INFO - Return code: 0 21:37:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:37: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')]} 21:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:37:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37: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')]} 21:37:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:37:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:37:55 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 0x1021dc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102152570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9418475930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ff0d30>, '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 0x101e56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fe8b20>, '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.pwSkaI98x9/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.UJGGrQIK3c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 21:37:55 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 21:37:55 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 21:37:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pwSkaI98x9/Render', 21:37:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:37:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:37:55 INFO - 'HOME': '/Users/cltbld', 21:37:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:37:55 INFO - 'LOGNAME': 'cltbld', 21:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:37:55 INFO - 'MOZ_NO_REMOTE': '1', 21:37:55 INFO - 'NO_EM_RESTART': '1', 21:37:55 INFO - 'PAGER': '/bin/cat', 21:37:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:37:55 INFO - 'PWD': '/builds/slave/test', 21:37:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:37:55 INFO - 'SHELL': '/bin/bash', 21:37:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UJGGrQIK3c/Listeners', 21:37:55 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 21:37:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:37:55 INFO - 'USER': 'cltbld', 21:37:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:37:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:37:55 INFO - 'XPC_FLAGS': '0x0', 21:37:55 INFO - 'XPC_SERVICE_NAME': '0', 21:37:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:37:55 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-I8JIm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:37:55 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-em0Ytb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:37:55 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-QanrJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:37:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-FAwwFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:37:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-3CoOlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:37:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-26pWdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:37:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-TLyPOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:37:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-PSnNF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:37:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-MSRVe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:37:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-vpHAwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:37:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-fwRMHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:37:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-qX15gU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:37:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-FwcXLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:37:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-oWStPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:37:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-JfjKkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:37:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-HcQGCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:37:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-mherw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:37:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:37:57 INFO - Running setup.py install for manifestparser 21:37:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:37:57 INFO - Running setup.py install for mozcrash 21:37:57 INFO - Running setup.py install for mozdebug 21:37:57 INFO - Running setup.py install for mozdevice 21:37:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:37:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:37:58 INFO - Running setup.py install for mozfile 21:37:58 INFO - Running setup.py install for mozhttpd 21:37:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:37:58 INFO - Running setup.py install for mozinfo 21:37:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:37:58 INFO - Running setup.py install for mozInstall 21:37:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:37:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:37:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:37:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:37:58 INFO - Running setup.py install for mozleak 21:37:58 INFO - Running setup.py install for mozlog 21:37:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:37:58 INFO - Running setup.py install for moznetwork 21:37:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:37:59 INFO - Running setup.py install for mozprocess 21:37:59 INFO - Running setup.py install for mozprofile 21:37:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:37:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:37:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:37:59 INFO - Running setup.py install for mozrunner 21:37:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:37:59 INFO - Running setup.py install for mozscreenshot 21:37:59 INFO - Running setup.py install for moztest 21:37:59 INFO - Running setup.py install for mozversion 21:38:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:38:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:38:00 INFO - Cleaning up... 21:38:00 INFO - Return code: 0 21:38:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:00 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 0x1021dc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102152570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9418475930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ff0d30>, '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 0x101e56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fe8b20>, '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.pwSkaI98x9/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.UJGGrQIK3c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 21:38:00 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 21:38:00 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 21:38:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pwSkaI98x9/Render', 21:38:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:00 INFO - 'HOME': '/Users/cltbld', 21:38:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:00 INFO - 'LOGNAME': 'cltbld', 21:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:00 INFO - 'MOZ_NO_REMOTE': '1', 21:38:00 INFO - 'NO_EM_RESTART': '1', 21:38:00 INFO - 'PAGER': '/bin/cat', 21:38:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:00 INFO - 'PWD': '/builds/slave/test', 21:38:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:00 INFO - 'SHELL': '/bin/bash', 21:38:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UJGGrQIK3c/Listeners', 21:38:00 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 21:38:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:00 INFO - 'USER': 'cltbld', 21:38:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:00 INFO - 'XPC_FLAGS': '0x0', 21:38:00 INFO - 'XPC_SERVICE_NAME': '0', 21:38:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:38:00 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-6PO533-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:38:00 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)) 21:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:38:00 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-JcHlg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:38:00 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-IsUYvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:38:00 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)) 21:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:38:00 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-fOy3My-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:38:00 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-WzVsdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:38:00 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)) 21:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:38:00 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-OhC7dw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:38:00 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)) 21:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:38:00 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-TpR7lB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:38:01 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)) 21:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:38:01 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-QjMd64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:38:01 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)) 21:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:38:01 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-2yUtVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:38:01 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)) 21:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:38:01 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-e7vmb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:38:01 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)) 21:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:38:01 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Dg02Gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:38:01 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)) 21:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:38:01 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-xpQ22w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:38:01 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-cApUf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:38:01 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)) 21:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:38:01 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Or8nRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 21:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:01 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-GUW6nB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:01 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)) 21:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:38:01 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-GNrq37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:38:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:38:02 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-3oUlB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:38:02 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)) 21:38:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:38:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:38:02 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)) 21:38:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:38:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:38:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:38:02 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 21:38:02 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 21:38:02 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 21:38:02 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 21:38:02 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 21:38:02 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 21:38:04 INFO - Downloading blessings-1.6.tar.gz 21:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:38:04 INFO - Installing collected packages: blessings 21:38:04 INFO - Running setup.py install for blessings 21:38:04 INFO - Successfully installed blessings 21:38:04 INFO - Cleaning up... 21:38:05 INFO - Return code: 0 21:38:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:38:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:38:05 INFO - Reading from file tmpfile_stdout 21:38:05 INFO - Current package versions: 21:38:05 INFO - blessings == 1.6 21:38:05 INFO - blobuploader == 1.2.4 21:38:05 INFO - docopt == 0.6.1 21:38:05 INFO - functools32 == 3.2.3-2 21:38:05 INFO - jsonschema == 2.5.1 21:38:05 INFO - manifestparser == 1.1 21:38:05 INFO - mozInstall == 1.12 21:38:05 INFO - mozcrash == 0.17 21:38:05 INFO - mozdebug == 0.1 21:38:05 INFO - mozdevice == 0.48 21:38:05 INFO - mozfile == 1.2 21:38:05 INFO - mozhttpd == 0.7 21:38:05 INFO - mozinfo == 0.9 21:38:05 INFO - mozleak == 0.1 21:38:05 INFO - mozlog == 3.4 21:38:05 INFO - moznetwork == 0.27 21:38:05 INFO - mozprocess == 0.23 21:38:05 INFO - mozprofile == 0.28 21:38:05 INFO - mozrunner == 6.12 21:38:05 INFO - mozscreenshot == 0.1 21:38:05 INFO - mozsystemmonitor == 0.3 21:38:05 INFO - moztest == 0.7 21:38:05 INFO - mozversion == 1.4 21:38:05 INFO - psutil == 3.1.1 21:38:05 INFO - requests == 1.2.3 21:38:05 INFO - wsgiref == 0.1.2 21:38:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:38: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')]} 21:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38: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')]} 21:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:05 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 0x1021dc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102152570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9418475930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ff0d30>, '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 0x101e56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fe8b20>, '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.pwSkaI98x9/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.UJGGrQIK3c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 21:38:05 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 21:38:05 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 21:38:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pwSkaI98x9/Render', 21:38:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:05 INFO - 'HOME': '/Users/cltbld', 21:38:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:05 INFO - 'LOGNAME': 'cltbld', 21:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:05 INFO - 'MOZ_NO_REMOTE': '1', 21:38:05 INFO - 'NO_EM_RESTART': '1', 21:38:05 INFO - 'PAGER': '/bin/cat', 21:38:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:05 INFO - 'PWD': '/builds/slave/test', 21:38:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:05 INFO - 'SHELL': '/bin/bash', 21:38:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UJGGrQIK3c/Listeners', 21:38:05 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 21:38:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:05 INFO - 'USER': 'cltbld', 21:38:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:05 INFO - 'XPC_FLAGS': '0x0', 21:38:05 INFO - 'XPC_SERVICE_NAME': '0', 21:38:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:05 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)) 21:38:05 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)) 21:38:05 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)) 21:38:05 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)) 21:38:05 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)) 21:38:05 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)) 21:38:05 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)) 21:38:05 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)) 21:38:05 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)) 21:38:05 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)) 21:38:05 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)) 21:38:05 INFO - Cleaning up... 21:38:05 INFO - Return code: 0 21:38:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:38: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')]} 21:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38: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')]} 21:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1021dc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102152570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9418475930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ff0d30>, '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 0x101e56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fe8b20>, '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.pwSkaI98x9/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.UJGGrQIK3c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 21:38:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:38:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pwSkaI98x9/Render', 21:38:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:05 INFO - 'HOME': '/Users/cltbld', 21:38:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:05 INFO - 'LOGNAME': 'cltbld', 21:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:05 INFO - 'MOZ_NO_REMOTE': '1', 21:38:05 INFO - 'NO_EM_RESTART': '1', 21:38:05 INFO - 'PAGER': '/bin/cat', 21:38:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:05 INFO - 'PWD': '/builds/slave/test', 21:38:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:05 INFO - 'SHELL': '/bin/bash', 21:38:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UJGGrQIK3c/Listeners', 21:38:05 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 21:38:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:05 INFO - 'USER': 'cltbld', 21:38:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:05 INFO - 'XPC_FLAGS': '0x0', 21:38:05 INFO - 'XPC_SERVICE_NAME': '0', 21:38:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:38:05 INFO - Cleaning up... 21:38:05 INFO - Return code: 0 21:38:05 INFO - Running post-action listener: _resource_record_post_action 21:38:05 INFO - Running post-action listener: _start_resource_monitoring 21:38:05 INFO - Starting resource monitoring. 21:38:05 INFO - [mozharness: 2016-10-05 04:38:05.889081Z] Finished create-virtualenv step (success) 21:38:05 INFO - [mozharness: 2016-10-05 04:38:05.890109Z] Running install step. 21:38:05 INFO - Running pre-action listener: _resource_record_pre_action 21:38:05 INFO - Running main action method: install 21:38:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:38:06 INFO - Reading from file tmpfile_stdout 21:38:06 INFO - Detecting whether we're running mozinstall >=1.0... 21:38:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:38:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:38:06 INFO - Reading from file tmpfile_stdout 21:38:06 INFO - Output received: 21:38:06 INFO - Usage: mozinstall [options] installer 21:38:06 INFO - Options: 21:38:06 INFO - -h, --help show this help message and exit 21:38:06 INFO - -d DEST, --destination=DEST 21:38:06 INFO - Directory to install application into. [default: 21:38:06 INFO - "/builds/slave/test"] 21:38:06 INFO - --app=APP Application being installed. [default: firefox] 21:38:06 INFO - mkdir: /builds/slave/test/build/application 21:38:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:38:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 21:38:38 INFO - Reading from file tmpfile_stdout 21:38:38 INFO - Output received: 21:38:38 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 21:38:38 INFO - Running post-action listener: _resource_record_post_action 21:38:38 INFO - [mozharness: 2016-10-05 04:38:38.392751Z] Finished install step (success) 21:38:38 INFO - [mozharness: 2016-10-05 04:38:38.392921Z] Running run-tests step. 21:38:38 INFO - Running pre-action listener: _resource_record_pre_action 21:38:38 INFO - Running main action method: run_tests 21:38:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:38:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:38:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:38:38 INFO - 2016-10-04 21:38:38.407 screenresolution[1642:7703] starting screenresolution argv=screenresolution get 21:38:38 INFO - 2016-10-04 21:38:38.410 screenresolution[1642:7703] Display 0: 1600x1200x32@60 21:38:38 INFO - 2016-10-04 21:38:38.416 screenresolution[1643:7705] starting screenresolution argv=screenresolution list 21:38:38 INFO - Available Modes on Display 0 21:38:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:38:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:38:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:38:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:38:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:38:38 INFO - Intel Iris: 21:38:38 INFO - Chipset Model: Intel Iris 21:38:38 INFO - Type: GPU 21:38:38 INFO - Bus: Built-In 21:38:38 INFO - VRAM (Dynamic, Max): 1536 MB 21:38:38 INFO - Vendor: Intel (0x8086) 21:38:38 INFO - Device ID: 0x0a2e 21:38:38 INFO - Revision ID: 0x0009 21:38:38 INFO - Displays: 21:38:38 INFO - Display: 21:38:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:38:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:38:38 INFO - Display Serial Number: 1600x1200 60 21:38:38 INFO - Main Display: Yes 21:38:38 INFO - Mirror: Off 21:38:38 INFO - Online: Yes 21:38:38 INFO - Rotation: Supported 21:38:38 INFO - Return code: 0 21:38:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:38:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:38:38 INFO - Python 2.7.3 21:38:38 INFO - Return code: 0 21:38:38 INFO - grabbing minidump binary from tooltool 21:38:38 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')]} 21:38:38 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 0x101ff0d30>, '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 0x101e56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fe8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:38:38 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 21:38:38 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 21:38:38 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 21:38:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:38:38 INFO - Return code: 0 21:38:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:38:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:38:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:38:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:38:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:38:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N50Imj_0QLeZ3wI-dThumg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--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 21:38:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N50Imj_0QLeZ3wI-dThumg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0084 --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 21:38:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pwSkaI98x9/Render', 21:38:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:38:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:38:38 INFO - 'HOME': '/Users/cltbld', 21:38:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:38:38 INFO - 'LOGNAME': 'cltbld', 21:38:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:38:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:38:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:38 INFO - 'MOZ_NO_REMOTE': '1', 21:38:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:38:38 INFO - 'NO_EM_RESTART': '1', 21:38:38 INFO - 'PAGER': '/bin/cat', 21:38:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:38:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:38 INFO - 'PWD': '/builds/slave/test', 21:38:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:38:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:38:38 INFO - 'SHELL': '/bin/bash', 21:38:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UJGGrQIK3c/Listeners', 21:38:38 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 21:38:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:38:38 INFO - 'USER': 'cltbld', 21:38:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:38:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:38:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:38 INFO - 'XPC_FLAGS': '0x0', 21:38:38 INFO - 'XPC_SERVICE_NAME': '0', 21:38:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:38:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N50Imj_0QLeZ3wI-dThumg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--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 21:38:38 INFO - mozversion application_buildid: 20161004193600 21:38:38 INFO - mozversion application_changeset: af5a59737002cc4e8bb0f69acddb2583a9d952c6 21:38:38 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:38:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:38:38 INFO - mozversion application_name: Firefox 21:38:38 INFO - mozversion application_remotingname: firefox-dev 21:38:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:38:38 INFO - mozversion application_vendor: Mozilla 21:38:38 INFO - mozversion application_version: 51.0a2 21:38:38 INFO - mozversion platform_buildid: 20161004193600 21:38:38 INFO - mozversion platform_changeset: af5a59737002cc4e8bb0f69acddb2583a9d952c6 21:38:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:38:38 INFO - mozversion platform_version: 51.0a2 21:38:38 INFO - using testdate: 1475642318 21:38:38 INFO - actual date: 1475642318 21:38:38 INFO - starting webserver on 'localhost:49274' 21:38:38 INFO - SUITE-START | Running 2 tests 21:38:38 INFO - TEST-START | dromaeo_css 21:38:38 INFO - operating with platform_type : mac_ 21:38:38 INFO - Initialising browser for dromaeo_css test... 21:38:39 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpQwsrog/profile http://localhost:49274/getInfo.html) 21:38:41 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 21:38:41 INFO - PROCESS | 1653 | colorDepth:24 21:38:41 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 21:38:41 INFO - PROCESS | 1653 | __metrics 21:38:41 INFO - PROCESS | 1653 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:38:41 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:38:42 INFO - TEST-INFO | 1653: exit 0 21:38:42 INFO - Browser initialized. 21:38:42 INFO - Running cycle 1/1 for dromaeo_css test... 21:38:42 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpQwsrog/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:38:54 INFO - PROCESS | 1655 | RSS: Main: 219627520 21:38:54 INFO - PROCESS | 1655 | 21:39:45 INFO - PROCESS | 1655 | 1475642385765 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:41:58 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 21:41:59 INFO - PROCESS | 1655 | RSS: Main: 364482560 21:41:59 INFO - PROCESS | 1655 | 21:45:02 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 21:45:03 INFO - PROCESS | 1655 | RSS: Main: 350769152 21:45:03 INFO - PROCESS | 1655 | 21:48:05 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 21:48:06 INFO - PROCESS | 1655 | RSS: Main: 321794048 21:48:06 INFO - PROCESS | 1655 | 21:51:08 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 21:51:09 INFO - PROCESS | 1655 | RSS: Main: 332271616 21:51:09 INFO - PROCESS | 1655 | 21:54:12 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 21:54:13 INFO - PROCESS | 1655 | RSS: Main: 316665856 21:54:13 INFO - PROCESS | 1655 | 21:57:16 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 21:57:16 INFO - PROCESS | 1655 | RSS: Main: 436105216 21:57:16 INFO - PROCESS | 1655 | 21:57:16 INFO - PROCESS | 1655 | __start_tp_report 21:57:16 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 21:57:16 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 21:57:16 INFO - PROCESS | 1655 | |i|pagename|runs| 21:57:16 INFO - PROCESS | 1655 | |0;dojo.html;3387.491876218567;3414.880479183228;3422.965770342297;3443.5006923996007;3459.688628023479;5828.621139625921;5919.644821310724;5921.940780592204;5927.792527261547;5942.494887934531;5839.32847722511;5922.378150294222;5931.288245410546;5935.673537955411;5948.910766338508;5315.707636080024;5324.094903866352;5336.599755018389;5390.676559406448;5428.61999660024;5307.203919412081;5309.601779866506;5340.985212809574;5442.510174084332;5456.836294911159;5418.485243901823;5426.2674538937135;5428.945710542884;5439.3200849893565;5442.510174084332;5418.972905135469;5418.972905135489;5423.457654234585;5426.945730542683;5438.320209973754;5265.578753699695;5361.276227709248;5374.27447294618;5384.380796208447;5388.084025715638;5978.40215978403;5985.610935289193;6024.397560243984;6026.427489388501;6038.698065096772;6184.5052395808225;6191.59754615953;6237.282712488077;6247.781327653511;6266.404691554295;6230.532710046765;6233.407826256498;6293.874122517524;6298.401651843067;6302.653354065525;5464.9453505464835;5812.738426770806;5942.64344139353;5983.042713165916;6019.969900150471;6231.065340198916;6286.968565157145;6289.433950944437;6325.810225693236;6333.176687030748;6224.346443623445;6230.221222347207;6251.343608921089;6255.906161407583;6270.655113968775;6293.433590976834;6321.209848768904;6330.955392360209;6342.4926005919415;6343.682815859189;6135.845176233341;6148.385161483816;6203.348648391944;6229.470495007885;6257.78097766576;6273.843153921189;6290.748370065237;6312.053192021233;6330.525210609223;6330.588511746721;5000.474950130184;5013.147764879979;5019.949800502021;5024.547790698854;5048.621353398436;4335.588119128678;4339.175556644227;4377.277749171415;4440.622547083534;4514.525974772667;5059.645824792303;5836.824895253149;5912.05407134865;5924.496417804535;5933.139694744238;6140;6290.119383286344;6301.243850737941;6318.462930650854;6330.366963303725;5713.285839270091;5758.7696492140685;5782.971085144632;5895.587308888423;5920.585559010828;5389.272448219519;5459.989901868167;5488.588355873326;5489.890202196014;5490.725463726798;6489.545731798728;6513.869722605426;6517.9348206517325;6521.34786521363;6526.477881769352;6183;6285.779997700241;6293.244810622755;6305.369463053658;6313.96843015782;6234.251889773256;6305.747770089145;6380.808575742735;6468.967655161882;6477.093206950936;5050.9747451263975;6207.81376558704;6314.968425157845;6327.367263273636;6342.2389313280855;4794.400699912511;4977.875553111201;6259.937400625936;6268.122462855295;6289.685515724287;6060.6969651516365;6222.968885155546;6239.625622462667;6244.469220116341;6264.185655864709;6118.741008805671;6120.569035656853;6137.131844484855;6182.1345011697495;6269.655168965751;6125.84685382869;6130.47890929276;6132.049532322497;6133.417325354084;6139.416755408229;6216.844578885564;6252.280987686474;6259.123722678738;6268.811935641938;6281.654509002049;5918.171455996078;5969.91045134332;6033.818985430444;6065.848353791191;6080.635161890301 21:57:16 INFO - PROCESS | 1655 | |1;ext.html;437.63894786800876;516.0813751522292;518.9429162792093;537.6720200677586;556.9331680198376;30469;40938.59061409385;42253;42503;42513;35824.2835143297;44158.55841441585;44199;44264.11471770563;44307.3353899691;8816.955915220415;9820.06709362613;9990.250731195154;10005.949970250138;10026.997300269988;8802.779930501725;9032.68385606504;9068.77328066797;9069.637214511411;12009;12022.51909923602;12326.013918886467;12339.506419743244;12358.258504489759;12383.752324953495;12282.38588070593;12346.938265308616;12355.196912200678;12359.505619775198;12369.072319576067;12100.576479823252;12216.900478956848;12219.96130328923;12226.266424014588;12228.327441990687;40595;40925.59074409248;40968;40985.590144098474;41091;3312.569365982431;3412.436947903593;3414.931701365984;3437.3112498814503;3488.7383446241633;30444.84777576098;31064.8446757767;31181.37637247265;31228.843855780804;31929.56316965742;3167.4456970030383;3247.4966380211104;3255.0723043932367;3305.140663427502;3321.8671253149846;533540;535152;535407;536445;537636;33498.330033399194;33957;62972.68513657402;63531;63650;35081.298374032885;35586.11034724101;35600;35646.46530302048;35708.464373034425;15163.241837908061;15277.923610381877;15281.847181528265;15292;15345.079295242098;12933.676658083436;13026.609201723963;13067.542636007884;13068.215907045418;13069.934650326688;7187.856242875113;7364.22675619063;7721.575313357707;7749.263819937097;7857.449978501564;2852.83033956077;3185.5221716742676;3190.2662387650507;3228.1445416964525;3229.257270827723;946.6213514594217;976.912077912977;1038.9896101038894;1077.2405454154803;1102.47081400928;25684.614730779052;29541.40917181644;30314.54528182079;30370.088897332673;30714.692853071185;942.797932635881;1030.4796077980573;1057.318029870729;1085.4355735017746;1170.268582136165;15017.924910375377;15503.379864805507;15582.9220853895;15895.682086358209;15931.283092260875;602644;603823;606707;609337;609575;50128.49871501311;50920;51206.975860483326;57151.714241428526;58253.8349233013;1372.0944176843236;1390.242317936727;1418.3688258724974;1420.4318272691007;1421.0976030220884;23845;25838;28861.54676852491;30002.79988800511;31350.529742054343;43959;48754.75622621864;49982.50017499778;50378.99242015213;50396;708980;710256;719336;901342;947746;26639;27411.31471713223;27464.94012948997;41856.79071604623;42358.36462453127;47949.760251198524;48293.36730899832;48309.51690483191;48364;48776.56117194055;36262.63737362698;38536.80731596436;38630.61369386382;39791.80104099461;40977.79511102426;39192;39233.411498828114;39333.80333098431;39490.01274968149;41082.1783564333;37802.62197377991;38255;38910.02724931899;39002.6099738999;39220.607793922834;33078;33945.151371215914;34595;34713;34798.82600586981;21357.572848543252;25588.744112558637;25853.741462585134;26043.218703438928;26050.218493445227 21:57:16 INFO - PROCESS | 1655 | |2;jquery.html;322.7079493058781;360.7889384709945;378.9545254569452;382.6364953294369;405.7849339849881;14439.783403248946;15400;20498.795012049857;20888.686669699928;21706.457338566543;20552.69170962433;20764.27325043624;21363.57272854546;21398.358049258546;21637.45906352342;5765.769369225236;6089.512838972893;6099.451049405553;6106.938930610704;6109.144719739218;4182.393552934823;4366.650667946573;4393.978030109845;4426;6014.338422773491;6644.601323920556;6645.102911106987;6745;6763.932360676404;6776.627285499296;6458.5479016468635;6696.799096027127;6710.798676039727;6744.898826517606;6746.123004009496;5588.55291576677;5848.064309710426;5850.531957443394;5855.092460668603;5857;25323.24030279076;25584.23247302584;25659.10193143231;25894.223173304832;25954.961801527916;1989.8408127349778;1994.5412555112405;2296.517731276434;2497.6628155198996;3002.3995200959675;14665.780013299809;15341;15535.766963495444;15692.215389230607;16061.277242524115;1859.7582314299054;1948.4641723526001;1963.7741659709172;1968.7440632717799;1971.7929617390112;115075;119186.80813191844;122144;123986;125386.37306813498;8818.33862460318;10395.94802025985;10999.395033273087;11041.282316649393;11184.944075279735;12038.578649747216;12705.618831435071;12723.872761272269;13451.058425910092;13460.326983650779;8595.398322117517;8607.22534971843;8746.212840844228;8806.559672016374;8816.250618697355;8804.647814087364;8826.470411775314;8857.955710221408;9011.729648110568;9038.502882341534;5520.558355331564;6328.430441260217;6470.741170353227;6623.30455302196;6661.533692641566;1617.8270753703705;1746.5678143922116;1758.6218962923033;1859.9256029758928;1874.3065065925696;984.675057231112;994.5773046455372;1001.9248556358157;1041.520900385831;1087.2660953856116;22113.778862211173;22426.05021128511;22546.21088261903;22655.773442265367;22775.886120569292;951.4338968313842;972.8492083727034;978.4325091446943;984.9901500985042;1018.791147814711;10923.672289831318;12032.27806331623;12093.972012379047;12360.072994525446;12537.749245015231;636403;641680;643944;652541;653559;85627;86583;88592.5570372144;142164;149894;954.2175416158683;961.4904100826573;1022.1822541966545;1026.071405378134;1028.4086650176177;19007.524811879815;19290.4212873614;19763.50591235173;19784.90107549453;19811.20755169777;46271.537284628066;59492.405075948685;59685.10472342832;59830.102548460934;60194;81777.59111204406;84046;84650.1534984667;86090.13909860821;87714.56142719246;8035.758927232192;8101.878471823045;8124.8781268279845;8332.16678332162;8378.874316885374;8804.735857924272;10902.509387077442;12791;12817.679558011125;13369.331533423485;11000.119990400588;11035.558577657124;11461.598844040418;11527.654170374903;11597.18819682614;8447.957760211406;10893.727656808644;11077.612283570037;11113.611023614458;11482.598109066143;11400.030997365317;11479.713007174887;11562.132840036862;11781.410929453665;11909.166358354832;7845.605202433341;7910.5649189295145;8331.250187483156;8481.703140390056;8519.872201916853;9549.52252387364;9961.107389595954;10905.236633435901;10963.342199468058;11234.83147752768 21:57:16 INFO - PROCESS | 1655 | |3;mootools.html;1313.474610155938;1459.525654162397;1499.5951093204835;1635.8200597934226;1813.320004998125;8007.839843203133;8516.659333626656;8788.165124313196;9019.95490022549;9020.54897255138;8892.155245251706;8980.955095224532;8981.236594889442;8985;8985.056569060236;2390.808735301176;2419.8185136114776;2423.164008417093;2424.3333083402117;2430.4045508850268;1958.4026871804094;2401.987990060047;2411.722651895037;2413.384586930339;2425.2724182745196;2383.6305372667266;2399.4961058177805;2412.9879350603223;2421.4793819328843;2426.3085020769086;2348.1781376518084;2366.325597204797;2373.477834876333;2376.215848769919;2391.8564886106715;2338.941526461835;2370.3837002379505;2377.4413012941945;2381.535600557892;2382.6783384243076;8346.83306333876;8427.030891447439;8919.152680495408;9003.234725048378;9017.504037277948;5284.048871203182;5487;5491.478309560585;5509.586780991402;5517.503424691757;3665.9450108248398;3709.109813644706;3720.4605332226674;3754.4931434256573;3769.6984241260634;950.6577632052456;1097.6158344579412;1111.2776695148139;1112.1769890281214;1117.7261570915095;11789.997850182745;11836.171467997243;11898.286102833858;11908.285502869856;11917.761644767143;4505.48186958504;4539.977300113478;4729.62163026957;4733.83431579893;4737.620990320835;9217.723468295962;9224.123708247706;9244.491552964651;9246.306527010502;9271.582778774837;5327.573794096463;5330.360356757136;5331.866703332447;5334.253204551366;5335.466453354711;4184.267753143188;4441.111777644484;4576.176288268077;4606.700564463299;4954.975225123923;3845.115623406576;3889.8055097245024;3926.9410958835642;3933.9016524587114;3946.8421263149726;1171.94140292985;1178.9941050294694;1182.9645110646695;1189.3696340939316;1191.976160476803;779.9961000194962;866.3502373220085;894.9239314658327;899.5322432335149;913.853783394667;5667.744951477111;5740.598158128891;5787.131930210502;5908.793192238251;6105.603135796159;933.705882646964;943.6414162618298;958.8609651600478;970.2626004236831;989.1295659819313;3842.558105817811;3869.9226015479535;3884.8251828667776;3967.484227050465;3988.7606743594897;10717.517711702993;10883.945580272048;11000.174986876016;11012.669619911416;11091.667249982513;10916.181286403551;10937.726556835984;10943.83584246237;10953.616623418142;10956.561737530568;7922.564258965697;8160.673573057011;8162.510249384937;8334.583270836434;8421.410501264974;5080.298100136496;5802.303723553201;5898.469137777621;5927.792527261525;6087.878242435215;9830.852537211804;10249.33379330341;10408.427536485566;10432.634857779942;10441.164706823587;7654.540727556365;8903.510306933182;9540.045995400682;10178.694639160542;10582.312149710244;7124.109486314211;7509.51188172767;7658.157602663814;7760.068791745027;7835;8429.831403372022;8443.788905277417;8519.659213631385;8536.786580335542;8554.059053503985;6945.236024037453;7470.252974702486;7712.730054448068;7741.032370953631;7772.417068719756;7529.962350188433;7563.319301262913;7581.696732130653;7598.544087354777;7748.806279843049;7060.399866011241;7087.114110736158;7101.360877520841;7175.461840362098;7178.389836863925;4787.712737235777;4975.950240497694;5017.749112544431;5087.745612719275;5105.846824595268;4976.154053810933;5040.143175660073;5043.092243396224;5137.101007323628;5144.871378215575 21:57:16 INFO - PROCESS | 1655 | |4;prototype.html;241.56759400672797;304.7029146582083;314.10480131624865;317.4112022198821;318.7450039968025;5413.675179489229;5419.539339156171;5464.617476776617;5471.5896307776875;5481.314835645544;4565.7444202844235;5105.846824595259;5231.346081739783;5290.814821481249;5385.5801566005575;3488.1454043759313;3990.5211374635082;4056.0530945146274;4117.794110294488;4163.958360416403;3442.6041005284337;4136.710430269883;4144.8963775905695;4178.289690752579;4195.160967806436;3476;3790.4503846942175;3921.8430562983845;4119.134981653841;4151.83392664293;4161.583841615845;4171.97914010431;4180.853670121562;4182.665386769082;4202.873913782591;3182.7612929030183;3190.8245046522434;3604.6034936157002;3649.4708267301357;3660.5058317127114;5005.824796132154;5041.143005689005;5287.154055351164;5293.4971177738435;5345.4387289334445;4581.427321584802;4733.290006499018;4750.572448479619;4751.857444276678;4754.405699287589;5650.70033892203;5655.236543066674;5701.657900525982;5704.71476426177;5735.254416925773;3596.5504311961004;3678.6137455567314;3854.8458061677497;3954.485916830822;4005.539362973237;5114.974425127851;5171.741412929338;5576.972115139439;5834.183214349994;5916.497097746696;3770;4040.959590404117;4056.7971601419813;4059.3910913362643;4101.487314085739;3439.9828000859834;3807.162424266657;4120.17596480705;4135.255653982312;4138.544760076389;3509.9122521936647;4364.716293440916;4665.323528088408;4730.2668086445965;4781.187198176319;5738.397468265855;5740.368559458456;5756.481916627524;5757.568182386338;5758.675504633958;1284.8715128487077;1363.4955066625214;1367.1748216131377;1381.3714759784475;1385.515069725588;712.1738783011785;852.5311078906576;880.2913654508054;900.7477906186278;920.1275404551706;4276.465441819772;4661.533846615379;4793.089313030513;4999;5027;5145.562627176657;5802.013657678205;5802.881948088917;5825.650460972355;5848.678322692293;4732.148213321566;5022.874428139326;5202.66182698131;5303.628745987821;5332.520073193431;2417.335232810956;2482.51590939765;2727.6454060971946;2847.0177788662877;3084.6915308468974;5343.278657381282;5992.610480318765;6013.488853447506;6057.273127224761;6105.778844231171;5492.5605951524585;5907.291125064934;5943.554233432424;5992.610480318765;6004.6697431640805;4654.069186162781;5265.631405801634;5817.767289308549;5945.702714864239;5978.100621198715;5163.483651634807;5384.730763461889;5435;5463.0060028088665;5858.8242352729485;5028.396592408934;5714.142878568082;5727.68497732612;5751.079827227623;5804.245448091721;5992.49063829562;6023.3374328824675;6051.485623722033;6080;6112.415688233825;3438.948415773715;3452.9482057769656;3799.4490798834568;3865.4781604483037;3945.6843452524304;4975.303457515878;5846.41535846429;5891.852703682443;5920.37836027211;5928.436798504135;5030.792609773554;5518.255035570307;5833.67914764692;5840.591158618856;5845.240118784531;4864.902701945871;4979.502049794992;5287.576993840406;5685.573581981285;5751.699320271758;4655.464621568563;5491.615586908878;5659.660800127945;5662.433756624305;5666.376698563073;5584.162375643686;5626.240457538343;5750.913736293875;5751.5398768099285;5784.50831679312;4908.803647854046;4960.875978100432;5143.691378517301;5189.910118874927;5276.947230527646 21:57:16 INFO - PROCESS | 1655 | |5;yui.html;745.3999530378045;764.904386951631;810.16552950461;817.1705718695529;827.536579515471;15481.38074477021;16339.34642614294;16379.672406551877;16387.672246555063;16388.426405075825;12813.679658008554;14308.21304828234;14740.04189727667;14910.850891491082;15093.245337733124;825.9628316725762;850.4684572142411;851.7700220940343;851.7913111287743;853.4580541356253;566.9234653321811;694.9339812717809;697.3828162076574;697.490831692862;699.3915293694492;734.6547122852278;877.6226222724226;900.6487469886749;909.9454032758023;915.1260546178383;904;904.6969265296134;905.0225756183339;905.1129892705153;907.3195103672246;525.5769105869773;666.2637785247281;668.5988406955836;668.7559040950067;670.9496787740939;12354.938225308906;14884;15221.695566088616;15237.466688665843;15255.313510892036;13858.792118118236;14132.364043618061;14337.49818756349;14352.282385880768;14613.342399592044;12335.074869384742;12677.619671409873;12941.48234070636;13518.391672374766;13575.389107490186;4561.384213131218;4678.157931572316;4738.147133515966;4798.952010479886;4861.246506791453;130451.69548304491;132136;132619.33690331582;133012;135736.96394554188;10811.567537298577;11299.435028248554;11399.829002564968;11534;11576;23056.308310750705;23153.842307884875;23211.53576928452;23612.64581031286;23727;7992.880106798402;7997.7600671979935;8113.148119447373;8162.795930101676;8220.465669731448;3970.82131304092;4452.9554704453185;4463.308187230984;4583.854036490878;4628.097520983376;3576.8926932192076;3688.7233457490797;3692.0585250760882;3693.316736403774;3698.9075273118387;672.1530871102447;673.1148539670415;683.7025893736142;691.3570379547069;695.5756988237172;470.76276424774386;537.0830050884161;602.5661523702927;611.4435863364317;620.1906512001791;7410.96294518524;8569.614367353484;8594.484330940164;9099.181073703267;9117.680881169259;497.8929530151035;580.5558747558122;589.8613825750945;621.8072397556772;649.5647915896361;3725.4970578972034;4021.678265738734;4367.192069467159;4384.64629626877;4419.204543182258;143543;149040;159714;162253;175796;84779.88050298791;113960.29059564113;114548;114938;131268;107199.46400268105;115029;117301;118356.40821795836;119818;9290.814183716153;9863;9928;9990.600375984879;9999.950000249952;62901;64434.355656442836;65063.67468162629;65865;66458.33541664522;80278.59860700658;98400.50799745956;99844;101728;103116.96883031074;12431.937840311102;12941.352932353533;13207.537736179187;13301.736335048156;13600;13922.860771392561;14076.577702668936;14408.207548584509;14463;15738.527844164693;11835.28988260707;12621.74756504883;13368.398422071225;13764.587062388144;14040.438382464587;13315.933420332836;13750.381232844346;13884.583462495737;13990.790138148139;14089.859101408854;12932.60746761852;12998.740025199631;13142.671433214246;13889.861101388857;14007.159570425807;11302.43487825589;11354.26197297173;11815.76368472643;11916.582919597773;12083.697907552381;11699.649010529698;11725.472353743931;11912.463939122934;11955.222910510789;11961.64115076549 21:57:16 INFO - PROCESS | 1655 | __end_tp_report 21:57:16 INFO - PROCESS | 1655 | __start_cc_report 21:57:16 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1346 21:57:16 INFO - PROCESS | 1655 | __end_cc_report 21:57:16 INFO - PROCESS | 1655 | __startTimestamp1475643436616__endTimestamp 21:57:16 INFO - PROCESS | 1655 | 21:57:16 INFO - PROCESS | 1655 | ------- Summary: start ------- 21:57:16 INFO - PROCESS | 1655 | Number of tests: 6 21:57:16 INFO - PROCESS | 1655 | 21:57:16 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5828.07 Median:6065.85 stddev:646.47 (10.7%) stddev-sans-first:619.46 21:57:16 INFO - PROCESS | 1655 | Values: 3387.5 3414.9 3423.0 3443.5 3459.7 5828.6 5919.6 5921.9 5927.8 5942.5 5839.3 5922.4 5931.3 5935.7 5948.9 5315.7 5324.1 5336.6 5390.7 5428.6 5307.2 5309.6 5341.0 5442.5 5456.8 5418.5 5426.3 5428.9 5439.3 5442.5 5419.0 5419.0 5423.5 5426.9 5438.3 5265.6 5361.3 5374.3 5384.4 5388.1 5978.4 5985.6 6024.4 6026.4 6038.7 6184.5 6191.6 6237.3 6247.8 6266.4 6230.5 6233.4 6293.9 6298.4 6302.7 5464.9 5812.7 5942.6 5983.0 6020.0 6231.1 6287.0 6289.4 6325.8 6333.2 6224.3 6230.2 6251.3 6255.9 6270.7 6293.4 6321.2 6331.0 6342.5 6343.7 6135.8 6148.4 6203.3 6229.5 6257.8 6273.8 6290.7 6312.1 6330.5 6330.6 5000.5 5013.1 5019.9 5024.5 5048.6 4335.6 4339.2 4377.3 4440.6 4514.5 5059.6 5836.8 5912.1 5924.5 5933.1 6140.0 6290.1 6301.2 6318.5 6330.4 5713.3 5758.8 5783.0 5895.6 5920.6 5389.3 5460.0 5488.6 5489.9 5490.7 6489.5 6513.9 6517.9 6521.3 6526.5 6183.0 6285.8 6293.2 6305.4 6314.0 6234.3 6305.7 6380.8 6469.0 6477.1 5051.0 6207.8 6315.0 6327.4 6342.2 4794.4 4977.9 6259.9 6268.1 6289.7 6060.7 6223.0 6239.6 6244.5 6264.2 6118.7 6120.6 6137.1 6182.1 6269.7 6125.8 6130.5 6132.0 6133.4 6139.4 6216.8 6252.3 6259.1 6268.8 6281.7 5918.2 5969.9 6033.8 6065.8 6080.6 21:57:16 INFO - PROCESS | 1655 | 21:57:16 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:75550.05 Median:19285.02 stddev:177235.75 (919.0%) stddev-sans-first:177643.21 21:57:16 INFO - PROCESS | 1655 | Values: 437.6 516.1 518.9 537.7 556.9 30469.0 40938.6 42253.0 42503.0 42513.0 35824.3 44158.6 44199.0 44264.1 44307.3 8817.0 9820.1 9990.3 10005.9 10027.0 8802.8 9032.7 9068.8 9069.6 12009.0 12022.5 12326.0 12339.5 12358.3 12383.8 12282.4 12346.9 12355.2 12359.5 12369.1 12100.6 12216.9 12220.0 12226.3 12228.3 40595.0 40925.6 40968.0 40985.6 41091.0 3312.6 3412.4 3414.9 3437.3 3488.7 30444.8 31064.8 31181.4 31228.8 31929.6 3167.4 3247.5 3255.1 3305.1 3321.9 533540.0 535152.0 535407.0 536445.0 537636.0 33498.3 33957.0 62972.7 63531.0 63650.0 35081.3 35586.1 35600.0 35646.5 35708.5 15163.2 15277.9 15281.8 15292.0 15345.1 12933.7 13026.6 13067.5 13068.2 13069.9 7187.9 7364.2 7721.6 7749.3 7857.4 2852.8 3185.5 3190.3 3228.1 3229.3 946.6 976.9 1039.0 1077.2 1102.5 25684.6 29541.4 30314.5 30370.1 30714.7 942.8 1030.5 1057.3 1085.4 1170.3 15017.9 15503.4 15582.9 15895.7 15931.3 602644.0 603823.0 606707.0 609337.0 609575.0 50128.5 50920.0 51207.0 57151.7 58253.8 1372.1 1390.2 1418.4 1420.4 1421.1 23845.0 25838.0 28861.5 30002.8 31350.5 43959.0 48754.8 49982.5 50379.0 50396.0 708980.0 710256.0 719336.0 901342.0 947746.0 26639.0 27411.3 27464.9 41856.8 42358.4 47949.8 48293.4 48309.5 48364.0 48776.6 36262.6 38536.8 38630.6 39791.8 40977.8 39192.0 39233.4 39333.8 39490.0 41082.2 37802.6 38255.0 38910.0 39002.6 39220.6 33078.0 33945.2 34595.0 34713.0 34798.8 21357.6 25588.7 25853.7 26043.2 26050.2 21:57:16 INFO - PROCESS | 1655 | 21:57:16 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:36474.25 Median:25776.66 stddev:107199.66 (415.9%) stddev-sans-first:107466.02 21:57:16 INFO - PROCESS | 1655 | Values: 322.7 360.8 379.0 382.6 405.8 14439.8 15400.0 20498.8 20888.7 21706.5 20552.7 20764.3 21363.6 21398.4 21637.5 5765.8 6089.5 6099.5 6106.9 6109.1 4182.4 4366.7 4394.0 4426.0 6014.3 6644.6 6645.1 6745.0 6763.9 6776.6 6458.5 6696.8 6710.8 6744.9 6746.1 5588.6 5848.1 5850.5 5855.1 5857.0 25323.2 25584.2 25659.1 25894.2 25955.0 1989.8 1994.5 2296.5 2497.7 3002.4 14665.8 15341.0 15535.8 15692.2 16061.3 1859.8 1948.5 1963.8 1968.7 1971.8 115075.0 119186.8 122144.0 123986.0 125386.4 8818.3 10395.9 10999.4 11041.3 11184.9 12038.6 12705.6 12723.9 13451.1 13460.3 8595.4 8607.2 8746.2 8806.6 8816.3 8804.6 8826.5 8858.0 9011.7 9038.5 5520.6 6328.4 6470.7 6623.3 6661.5 1617.8 1746.6 1758.6 1859.9 1874.3 984.7 994.6 1001.9 1041.5 1087.3 22113.8 22426.1 22546.2 22655.8 22775.9 951.4 972.8 978.4 985.0 1018.8 10923.7 12032.3 12094.0 12360.1 12537.7 636403.0 641680.0 643944.0 652541.0 653559.0 85627.0 86583.0 88592.6 142164.0 149894.0 954.2 961.5 1022.2 1026.1 1028.4 19007.5 19290.4 19763.5 19784.9 19811.2 46271.5 59492.4 59685.1 59830.1 60194.0 81777.6 84046.0 84650.2 86090.1 87714.6 8035.8 8101.9 8124.9 8332.2 8378.9 8804.7 10902.5 12791.0 12817.7 13369.3 11000.1 11035.6 11461.6 11527.7 11597.2 8448.0 10893.7 11077.6 11113.6 11482.6 11400.0 11479.7 11562.1 11781.4 11909.2 7845.6 7910.6 8331.3 8481.7 8519.9 9549.5 9961.1 10905.2 10963.3 11234.8 21:57:16 INFO - PROCESS | 1655 | 21:57:16 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5729.70 Median:5061.70 stddev:3219.15 (63.6%) stddev-sans-first:3211.07 21:57:16 INFO - PROCESS | 1655 | Values: 1313.5 1459.5 1499.6 1635.8 1813.3 8007.8 8516.7 8788.2 9020.0 9020.5 8892.2 8981.0 8981.2 8985.0 8985.1 2390.8 2419.8 2423.2 2424.3 2430.4 1958.4 2402.0 2411.7 2413.4 2425.3 2383.6 2399.5 2413.0 2421.5 2426.3 2348.2 2366.3 2373.5 2376.2 2391.9 2338.9 2370.4 2377.4 2381.5 2382.7 8346.8 8427.0 8919.2 9003.2 9017.5 5284.0 5487.0 5491.5 5509.6 5517.5 3665.9 3709.1 3720.5 3754.5 3769.7 950.7 1097.6 1111.3 1112.2 1117.7 11790.0 11836.2 11898.3 11908.3 11917.8 4505.5 4540.0 4729.6 4733.8 4737.6 9217.7 9224.1 9244.5 9246.3 9271.6 5327.6 5330.4 5331.9 5334.3 5335.5 4184.3 4441.1 4576.2 4606.7 4955.0 3845.1 3889.8 3926.9 3933.9 3946.8 1171.9 1179.0 1183.0 1189.4 1192.0 780.0 866.4 894.9 899.5 913.9 5667.7 5740.6 5787.1 5908.8 6105.6 933.7 943.6 958.9 970.3 989.1 3842.6 3869.9 3884.8 3967.5 3988.8 10717.5 10883.9 11000.2 11012.7 11091.7 10916.2 10937.7 10943.8 10953.6 10956.6 7922.6 8160.7 8162.5 8334.6 8421.4 5080.3 5802.3 5898.5 5927.8 6087.9 9830.9 10249.3 10408.4 10432.6 10441.2 7654.5 8903.5 9540.0 10178.7 10582.3 7124.1 7509.5 7658.2 7760.1 7835.0 8429.8 8443.8 8519.7 8536.8 8554.1 6945.2 7470.3 7712.7 7741.0 7772.4 7530.0 7563.3 7581.7 7598.5 7748.8 7060.4 7087.1 7101.4 7175.5 7178.4 4787.7 4976.0 5017.7 5087.7 5105.8 4976.2 5040.1 5043.1 5137.1 5144.9 21:57:16 INFO - PROCESS | 1655 | 21:57:16 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4579.78 Median:5129.33 stddev:1427.01 (27.8%) stddev-sans-first:1393.37 21:57:16 INFO - PROCESS | 1655 | Values: 241.6 304.7 314.1 317.4 318.7 5413.7 5419.5 5464.6 5471.6 5481.3 4565.7 5105.8 5231.3 5290.8 5385.6 3488.1 3990.5 4056.1 4117.8 4164.0 3442.6 4136.7 4144.9 4178.3 4195.2 3476.0 3790.5 3921.8 4119.1 4151.8 4161.6 4172.0 4180.9 4182.7 4202.9 3182.8 3190.8 3604.6 3649.5 3660.5 5005.8 5041.1 5287.2 5293.5 5345.4 4581.4 4733.3 4750.6 4751.9 4754.4 5650.7 5655.2 5701.7 5704.7 5735.3 3596.6 3678.6 3854.8 3954.5 4005.5 5115.0 5171.7 5577.0 5834.2 5916.5 3770.0 4041.0 4056.8 4059.4 4101.5 3440.0 3807.2 4120.2 4135.3 4138.5 3509.9 4364.7 4665.3 4730.3 4781.2 5738.4 5740.4 5756.5 5757.6 5758.7 1284.9 1363.5 1367.2 1381.4 1385.5 712.2 852.5 880.3 900.7 920.1 4276.5 4661.5 4793.1 4999.0 5027.0 5145.6 5802.0 5802.9 5825.7 5848.7 4732.1 5022.9 5202.7 5303.6 5332.5 2417.3 2482.5 2727.6 2847.0 3084.7 5343.3 5992.6 6013.5 6057.3 6105.8 5492.6 5907.3 5943.6 5992.6 6004.7 4654.1 5265.6 5817.8 5945.7 5978.1 5163.5 5384.7 5435.0 5463.0 5858.8 5028.4 5714.1 5727.7 5751.1 5804.2 5992.5 6023.3 6051.5 6080.0 6112.4 3438.9 3452.9 3799.4 3865.5 3945.7 4975.3 5846.4 5891.9 5920.4 5928.4 5030.8 5518.3 5833.7 5840.6 5845.2 4864.9 4979.5 5287.6 5685.6 5751.7 4655.5 5491.6 5659.7 5662.4 5666.4 5584.2 5626.2 5750.9 5751.5 5784.5 4908.8 4960.9 5143.7 5189.9 5276.9 21:57:16 INFO - PROCESS | 1655 | 21:57:16 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:25792.98 Median:13651.95 stddev:41547.28 (304.3%) stddev-sans-first:41621.26 21:57:16 INFO - PROCESS | 1655 | Values: 745.4 764.9 810.2 817.2 827.5 15481.4 16339.3 16379.7 16387.7 16388.4 12813.7 14308.2 14740.0 14910.9 15093.2 826.0 850.5 851.8 851.8 853.5 566.9 694.9 697.4 697.5 699.4 734.7 877.6 900.6 909.9 915.1 904.0 904.7 905.0 905.1 907.3 525.6 666.3 668.6 668.8 670.9 12354.9 14884.0 15221.7 15237.5 15255.3 13858.8 14132.4 14337.5 14352.3 14613.3 12335.1 12677.6 12941.5 13518.4 13575.4 4561.4 4678.2 4738.1 4799.0 4861.2 130451.7 132136.0 132619.3 133012.0 135737.0 10811.6 11299.4 11399.8 11534.0 11576.0 23056.3 23153.8 23211.5 23612.6 23727.0 7992.9 7997.8 8113.1 8162.8 8220.5 3970.8 4453.0 4463.3 4583.9 4628.1 3576.9 3688.7 3692.1 3693.3 3698.9 672.2 673.1 683.7 691.4 695.6 470.8 537.1 602.6 611.4 620.2 7411.0 8569.6 8594.5 9099.2 9117.7 497.9 580.6 589.9 621.8 649.6 3725.5 4021.7 4367.2 4384.6 4419.2 143543.0 149040.0 159714.0 162253.0 175796.0 84779.9 113960.3 114548.0 114938.0 131268.0 107199.5 115029.0 117301.0 118356.4 119818.0 9290.8 9863.0 9928.0 9990.6 10000.0 62901.0 64434.4 65063.7 65865.0 66458.3 80278.6 98400.5 99844.0 101728.0 103117.0 12431.9 12941.4 13207.5 13301.7 13600.0 13922.9 14076.6 14408.2 14463.0 15738.5 11835.3 12621.7 13368.4 13764.6 14040.4 13315.9 13750.4 13884.6 13990.8 14089.9 12932.6 12998.7 13142.7 13889.9 14007.2 11302.4 11354.3 11815.8 11916.6 12083.7 11699.6 11725.5 11912.5 11955.2 11961.6 21:57:16 INFO - PROCESS | 1655 | -------- Summary: end -------- 21:57:16 INFO - PROCESS | 1655 | 21:57:17 INFO - TEST-INFO | 1655: exit 0 21:57:17 INFO - TEST-OK | dromaeo_css | took 1118264ms 21:57:17 INFO - TEST-START | kraken 21:57:17 INFO - operating with platform_type : mac_ 21:57:17 INFO - Initialising browser for kraken test... 21:57:17 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpw5rejC/profile http://localhost:49274/getInfo.html) 21:57:19 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 21:57:19 INFO - PROCESS | 1665 | colorDepth:24 21:57:19 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 21:57:19 INFO - PROCESS | 1665 | __metrics 21:57:19 INFO - PROCESS | 1665 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:57:19 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:57:20 INFO - TEST-INFO | 1665: exit 0 21:57:20 INFO - Browser initialized. 21:57:20 INFO - Running cycle 1/1 for kraken test... 21:57:20 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpw5rejC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:57:32 INFO - PROCESS | 1666 | RSS: Main: 219316224 21:57:32 INFO - PROCESS | 1666 | 21:57:35 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 21:57:36 INFO - PROCESS | 1666 | RSS: Main: 269635584 21:57:36 INFO - PROCESS | 1666 | 21:57:38 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 21:57:39 INFO - PROCESS | 1666 | RSS: Main: 280207360 21:57:39 INFO - PROCESS | 1666 | 21:57:42 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 21:57:42 INFO - PROCESS | 1666 | RSS: Main: 379990016 21:57:42 INFO - PROCESS | 1666 | 21:57:44 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 21:57:45 INFO - PROCESS | 1666 | RSS: Main: 279064576 21:57:45 INFO - PROCESS | 1666 | 21:57:47 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:57:48 INFO - PROCESS | 1666 | RSS: Main: 280014848 21:57:48 INFO - PROCESS | 1666 | 21:57:50 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 21:57:51 INFO - PROCESS | 1666 | RSS: Main: 316956672 21:57:51 INFO - PROCESS | 1666 | 21:57:54 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 21:57:54 INFO - PROCESS | 1666 | RSS: Main: 319168512 21:57:54 INFO - PROCESS | 1666 | 21:57:57 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 21:57:58 INFO - PROCESS | 1666 | RSS: Main: 317554688 21:57:58 INFO - PROCESS | 1666 | 21:57:59 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:58:00 INFO - PROCESS | 1666 | RSS: Main: 288980992 21:58:00 INFO - PROCESS | 1666 | 21:58:02 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:58:02 INFO - PROCESS | 1666 | RSS: Main: 293445632 21:58:02 INFO - PROCESS | 1666 | 21:58:05 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:58:05 INFO - PROCESS | 1666 | RSS: Main: 304398336 21:58:05 INFO - PROCESS | 1666 | 21:58:08 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:58:09 INFO - PROCESS | 1666 | RSS: Main: 316563456 21:58:09 INFO - PROCESS | 1666 | 21:58:12 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:58:12 INFO - PROCESS | 1666 | RSS: Main: 310378496 21:58:12 INFO - PROCESS | 1666 | 21:58:14 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 21:58:14 INFO - PROCESS | 1666 | RSS: Main: 355045376 21:58:14 INFO - PROCESS | 1666 | 21:58:14 INFO - PROCESS | 1666 | __start_tp_report 21:58:14 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 21:58:14 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 21:58:14 INFO - PROCESS | 1666 | |i|pagename|runs| 21:58:14 INFO - PROCESS | 1666 | |0;ai-astar;113;112;112;113;110;112;112;111;108;112 21:58:14 INFO - PROCESS | 1666 | |1;audio-beat-detection;142;109;111;142;108;109;109;107;137;108 21:58:14 INFO - PROCESS | 1666 | |2;audio-dft;184;186;182;186;183;183;181;183;184;183 21:58:14 INFO - PROCESS | 1666 | |3;audio-fft;81;61;59;88;61;61;59;59;83;58 21:58:14 INFO - PROCESS | 1666 | |4;audio-oscillator;88;71;94;69;69;69;92;68;69;90 21:58:14 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;87;84;87;83;87;84;87;87;88;70 21:58:14 INFO - PROCESS | 1666 | |6;imaging-darkroom;95;104;95;96;95;96;97;96;96;96 21:58:14 INFO - PROCESS | 1666 | |7;imaging-desaturate;86;84;87;86;86;87;84;85;84;86 21:58:14 INFO - PROCESS | 1666 | |8;json-parse-financial;57;54;53;52;55;58;58;58;58;58 21:58:14 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;65;77;74;73;72;71;69;71;72;72 21:58:14 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;83;80;82;83;86;84;84;87;96;102 21:58:14 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;138;139;137;142;153;135;124;152;199;151 21:58:14 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;163;164;163;163;161;164;163;161;163;164 21:58:14 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;65;65;66;66;66;65;66;66;66;65 21:58:14 INFO - PROCESS | 1666 | __end_tp_report 21:58:14 INFO - PROCESS | 1666 | __start_cc_report 21:58:14 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1986 21:58:14 INFO - PROCESS | 1666 | __end_cc_report 21:58:14 INFO - PROCESS | 1666 | __startTimestamp1475643494604__endTimestamp 21:58:14 INFO - PROCESS | 1666 | 21:58:14 INFO - PROCESS | 1666 | ------- Summary: start ------- 21:58:14 INFO - PROCESS | 1666 | Number of tests: 14 21:58:14 INFO - PROCESS | 1666 | 21:58:14 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:1.51 (1.3%) stddev-sans-first:1.50 21:58:14 INFO - PROCESS | 1666 | Values: 113.0 112.0 112.0 113.0 110.0 112.0 112.0 111.0 108.0 112.0 21:58:14 INFO - PROCESS | 1666 | 21:58:14 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:118.20 Median:110.00 stddev:15.37 (14.0%) stddev-sans-first:13.68 21:58:14 INFO - PROCESS | 1666 | Values: 142.0 109.0 111.0 142.0 108.0 109.0 109.0 107.0 137.0 108.0 21:58:14 INFO - PROCESS | 1666 | 21:58:14 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:183.50 Median:183.50 stddev:1.58 (0.9%) stddev-sans-first:1.67 21:58:14 INFO - PROCESS | 1666 | Values: 184.0 186.0 182.0 186.0 183.0 183.0 181.0 183.0 184.0 183.0 21:58:14 INFO - PROCESS | 1666 | 21:58:14 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:67.00 Median:61.00 stddev:11.90 (19.5%) stddev-sans-first:11.49 21:58:14 INFO - PROCESS | 1666 | Values: 81.0 61.0 59.0 88.0 61.0 61.0 59.0 59.0 83.0 58.0 21:58:14 INFO - PROCESS | 1666 | 21:58:14 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:79.50 stddev:11.40 (14.3%) stddev-sans-first:11.49 21:58:14 INFO - PROCESS | 1666 | Values: 88.0 71.0 94.0 69.0 69.0 69.0 92.0 68.0 69.0 90.0 21:58:14 INFO - PROCESS | 1666 | 21:58:14 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:84.40 Median:87.00 stddev:5.34 (6.1%) stddev-sans-first:5.58 21:58:14 INFO - PROCESS | 1666 | Values: 87.0 84.0 87.0 83.0 87.0 84.0 87.0 87.0 88.0 70.0 21:58:14 INFO - PROCESS | 1666 | 21:58:14 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:96.60 Median:96.00 stddev:2.67 (2.8%) stddev-sans-first:2.77 21:58:14 INFO - PROCESS | 1666 | Values: 95.0 104.0 95.0 96.0 95.0 96.0 97.0 96.0 96.0 96.0 21:58:14 INFO - PROCESS | 1666 | 21:58:14 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:86.00 stddev:1.18 (1.4%) stddev-sans-first:1.24 21:58:14 INFO - PROCESS | 1666 | Values: 86.0 84.0 87.0 86.0 86.0 87.0 84.0 85.0 84.0 86.0 21:58:14 INFO - PROCESS | 1666 | 21:58:14 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:58.00 stddev:2.38 (4.1%) stddev-sans-first:2.50 21:58:14 INFO - PROCESS | 1666 | Values: 57.0 54.0 53.0 52.0 55.0 58.0 58.0 58.0 58.0 58.0 21:58:14 INFO - PROCESS | 1666 | 21:58:14 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:72.00 stddev:3.13 (4.4%) stddev-sans-first:2.24 21:58:14 INFO - PROCESS | 1666 | Values: 65.0 77.0 74.0 73.0 72.0 71.0 69.0 71.0 72.0 72.0 21:58:14 INFO - PROCESS | 1666 | 21:58:14 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:84.00 stddev:6.91 (8.2%) stddev-sans-first:7.20 21:58:14 INFO - PROCESS | 1666 | Values: 83.0 80.0 82.0 83.0 86.0 84.0 84.0 87.0 96.0 102.0 21:58:14 INFO - PROCESS | 1666 | 21:58:14 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:147.00 Median:146.50 stddev:20.34 (13.9%) stddev-sans-first:21.31 21:58:14 INFO - PROCESS | 1666 | Values: 138.0 139.0 137.0 142.0 153.0 135.0 124.0 152.0 199.0 151.0 21:58:14 INFO - PROCESS | 1666 | 21:58:14 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.90 Median:163.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 21:58:14 INFO - PROCESS | 1666 | Values: 163.0 164.0 163.0 163.0 161.0 164.0 163.0 161.0 163.0 164.0 21:58:14 INFO - PROCESS | 1666 | 21:58:14 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 21:58:14 INFO - PROCESS | 1666 | Values: 65.0 65.0 66.0 66.0 66.0 65.0 66.0 66.0 66.0 65.0 21:58:14 INFO - PROCESS | 1666 | -------- Summary: end -------- 21:58:14 INFO - PROCESS | 1666 | 21:58:15 INFO - TEST-INFO | 1666: exit 0 21:58:15 INFO - TEST-OK | kraken | took 58187ms 21:58:15 INFO - SUITE-END | took 1176s 21:58:15 INFO - Completed test suite (00:19:36) 21:58:15 INFO - javascript benchmark 21:58:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3387.491876218567, 3414.880479183228, 3422.965770342297, 3443.5006923996007, 3459.688628023479, 5828.621139625921, 5919.644821310724, 5921.940780592204, 5927.792527261547, 5942.494887934531, 5839.32847722511, 5922.378150294222, 5931.288245410546, 5935.673537955411, 5948.910766338508, 5315.707636080024, 5324.094903866352, 5336.599755018389, 5390.676559406448, 5428.61999660024, 5307.203919412081, 5309.601779866506, 5340.985212809574, 5442.510174084332, 5456.836294911159, 5418.485243901823, 5426.2674538937135, 5428.945710542884, 5439.3200849893565, 5442.510174084332, 5418.972905135469, 5418.972905135489, 5423.457654234585, 5426.945730542683, 5438.320209973754, 5265.578753699695, 5361.276227709248, 5374.27447294618, 5384.380796208447, 5388.084025715638, 5978.40215978403, 5985.610935289193, 6024.397560243984, 6026.427489388501, 6038.698065096772, 6184.5052395808225, 6191.59754615953, 6237.282712488077, 6247.781327653511, 6266.404691554295, 6230.532710046765, 6233.407826256498, 6293.874122517524, 6298.401651843067, 6302.653354065525, 5464.9453505464835, 5812.738426770806, 5942.64344139353, 5983.042713165916, 6019.969900150471, 6231.065340198916, 6286.968565157145, 6289.433950944437, 6325.810225693236, 6333.176687030748, 6224.346443623445, 6230.221222347207, 6251.343608921089, 6255.906161407583, 6270.655113968775, 6293.433590976834, 6321.209848768904, 6330.955392360209, 6342.4926005919415, 6343.682815859189, 6135.845176233341, 6148.385161483816, 6203.348648391944, 6229.470495007885, 6257.78097766576, 6273.843153921189, 6290.748370065237, 6312.053192021233, 6330.525210609223, 6330.588511746721, 5000.474950130184, 5013.147764879979, 5019.949800502021, 5024.547790698854, 5048.621353398436, 4335.588119128678, 4339.175556644227, 4377.277749171415, 4440.622547083534, 4514.525974772667, 5059.645824792303, 5836.824895253149, 5912.05407134865, 5924.496417804535, 5933.139694744238, 6140.0, 6290.119383286344, 6301.243850737941, 6318.462930650854, 6330.366963303725, 5713.285839270091, 5758.7696492140685, 5782.971085144632, 5895.587308888423, 5920.585559010828, 5389.272448219519, 5459.989901868167, 5488.588355873326, 5489.890202196014, 5490.725463726798, 6489.545731798728, 6513.869722605426, 6517.9348206517325, 6521.34786521363, 6526.477881769352, 6183.0, 6285.779997700241, 6293.244810622755, 6305.369463053658, 6313.96843015782, 6234.251889773256, 6305.747770089145, 6380.808575742735, 6468.967655161882, 6477.093206950936, 5050.9747451263975, 6207.81376558704, 6314.968425157845, 6327.367263273636, 6342.2389313280855, 4794.400699912511, 4977.875553111201, 6259.937400625936, 6268.122462855295, 6289.685515724287, 6060.6969651516365, 6222.968885155546, 6239.625622462667, 6244.469220116341, 6264.185655864709, 6118.741008805671, 6120.569035656853, 6137.131844484855, 6182.1345011697495, 6269.655168965751, 6125.84685382869, 6130.47890929276, 6132.049532322497, 6133.417325354084, 6139.416755408229, 6216.844578885564, 6252.280987686474, 6259.123722678738, 6268.811935641938, 6281.654509002049, 5918.171455996078, 5969.91045134332, 6033.818985430444, 6065.848353791191, 6080.635161890301], "value": 5787.989033230899, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [437.63894786800876, 516.0813751522292, 518.9429162792093, 537.6720200677586, 556.9331680198376, 30469.0, 40938.59061409385, 42253.0, 42503.0, 42513.0, 35824.2835143297, 44158.55841441585, 44199.0, 44264.11471770563, 44307.3353899691, 8816.955915220415, 9820.06709362613, 9990.250731195154, 10005.949970250138, 10026.997300269988, 8802.779930501725, 9032.68385606504, 9068.77328066797, 9069.637214511411, 12009.0, 12022.51909923602, 12326.013918886467, 12339.506419743244, 12358.258504489759, 12383.752324953495, 12282.38588070593, 12346.938265308616, 12355.196912200678, 12359.505619775198, 12369.072319576067, 12100.576479823252, 12216.900478956848, 12219.96130328923, 12226.266424014588, 12228.327441990687, 40595.0, 40925.59074409248, 40968.0, 40985.590144098474, 41091.0, 3312.569365982431, 3412.436947903593, 3414.931701365984, 3437.3112498814503, 3488.7383446241633, 30444.84777576098, 31064.8446757767, 31181.37637247265, 31228.843855780804, 31929.56316965742, 3167.4456970030383, 3247.4966380211104, 3255.0723043932367, 3305.140663427502, 3321.8671253149846, 533540.0, 535152.0, 535407.0, 536445.0, 537636.0, 33498.330033399194, 33957.0, 62972.68513657402, 63531.0, 63650.0, 35081.298374032885, 35586.11034724101, 35600.0, 35646.46530302048, 35708.464373034425, 15163.241837908061, 15277.923610381877, 15281.847181528265, 15292.0, 15345.079295242098, 12933.676658083436, 13026.609201723963, 13067.542636007884, 13068.215907045418, 13069.934650326688, 7187.856242875113, 7364.22675619063, 7721.575313357707, 7749.263819937097, 7857.449978501564, 2852.83033956077, 3185.5221716742676, 3190.2662387650507, 3228.1445416964525, 3229.257270827723, 946.6213514594217, 976.912077912977, 1038.9896101038894, 1077.2405454154803, 1102.47081400928, 25684.614730779052, 29541.40917181644, 30314.54528182079, 30370.088897332673, 30714.692853071185, 942.797932635881, 1030.4796077980573, 1057.318029870729, 1085.4355735017746, 1170.268582136165, 15017.924910375377, 15503.379864805507, 15582.9220853895, 15895.682086358209, 15931.283092260875, 602644.0, 603823.0, 606707.0, 609337.0, 609575.0, 50128.49871501311, 50920.0, 51206.975860483326, 57151.714241428526, 58253.8349233013, 1372.0944176843236, 1390.242317936727, 1418.3688258724974, 1420.4318272691007, 1421.0976030220884, 23845.0, 25838.0, 28861.54676852491, 30002.79988800511, 31350.529742054343, 43959.0, 48754.75622621864, 49982.50017499778, 50378.99242015213, 50396.0, 708980.0, 710256.0, 719336.0, 901342.0, 947746.0, 26639.0, 27411.31471713223, 27464.94012948997, 41856.79071604623, 42358.36462453127, 47949.760251198524, 48293.36730899832, 48309.51690483191, 48364.0, 48776.56117194055, 36262.63737362698, 38536.80731596436, 38630.61369386382, 39791.80104099461, 40977.79511102426, 39192.0, 39233.411498828114, 39333.80333098431, 39490.01274968149, 41082.1783564333, 37802.62197377991, 38255.0, 38910.02724931899, 39002.6099738999, 39220.607793922834, 33078.0, 33945.151371215914, 34595.0, 34713.0, 34798.82600586981, 21357.572848543252, 25588.744112558637, 25853.741462585134, 26043.218703438928, 26050.218493445227], "value": 19323.437832665455, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.7079493058781, 360.7889384709945, 378.9545254569452, 382.6364953294369, 405.7849339849881, 14439.783403248946, 15400.0, 20498.795012049857, 20888.686669699928, 21706.457338566543, 20552.69170962433, 20764.27325043624, 21363.57272854546, 21398.358049258546, 21637.45906352342, 5765.769369225236, 6089.512838972893, 6099.451049405553, 6106.938930610704, 6109.144719739218, 4182.393552934823, 4366.650667946573, 4393.978030109845, 4426.0, 6014.338422773491, 6644.601323920556, 6645.102911106987, 6745.0, 6763.932360676404, 6776.627285499296, 6458.5479016468635, 6696.799096027127, 6710.798676039727, 6744.898826517606, 6746.123004009496, 5588.55291576677, 5848.064309710426, 5850.531957443394, 5855.092460668603, 5857.0, 25323.24030279076, 25584.23247302584, 25659.10193143231, 25894.223173304832, 25954.961801527916, 1989.8408127349778, 1994.5412555112405, 2296.517731276434, 2497.6628155198996, 3002.3995200959675, 14665.780013299809, 15341.0, 15535.766963495444, 15692.215389230607, 16061.277242524115, 1859.7582314299054, 1948.4641723526001, 1963.7741659709172, 1968.7440632717799, 1971.7929617390112, 115075.0, 119186.80813191844, 122144.0, 123986.0, 125386.37306813498, 8818.33862460318, 10395.94802025985, 10999.395033273087, 11041.282316649393, 11184.944075279735, 12038.578649747216, 12705.618831435071, 12723.872761272269, 13451.058425910092, 13460.326983650779, 8595.398322117517, 8607.22534971843, 8746.212840844228, 8806.559672016374, 8816.250618697355, 8804.647814087364, 8826.470411775314, 8857.955710221408, 9011.729648110568, 9038.502882341534, 5520.558355331564, 6328.430441260217, 6470.741170353227, 6623.30455302196, 6661.533692641566, 1617.8270753703705, 1746.5678143922116, 1758.6218962923033, 1859.9256029758928, 1874.3065065925696, 984.675057231112, 994.5773046455372, 1001.9248556358157, 1041.520900385831, 1087.2660953856116, 22113.778862211173, 22426.05021128511, 22546.21088261903, 22655.773442265367, 22775.886120569292, 951.4338968313842, 972.8492083727034, 978.4325091446943, 984.9901500985042, 1018.791147814711, 10923.672289831318, 12032.27806331623, 12093.972012379047, 12360.072994525446, 12537.749245015231, 636403.0, 641680.0, 643944.0, 652541.0, 653559.0, 85627.0, 86583.0, 88592.5570372144, 142164.0, 149894.0, 954.2175416158683, 961.4904100826573, 1022.1822541966545, 1026.071405378134, 1028.4086650176177, 19007.524811879815, 19290.4212873614, 19763.50591235173, 19784.90107549453, 19811.20755169777, 46271.537284628066, 59492.405075948685, 59685.10472342832, 59830.102548460934, 60194.0, 81777.59111204406, 84046.0, 84650.1534984667, 86090.13909860821, 87714.56142719246, 8035.758927232192, 8101.878471823045, 8124.8781268279845, 8332.16678332162, 8378.874316885374, 8804.735857924272, 10902.509387077442, 12791.0, 12817.679558011125, 13369.331533423485, 11000.119990400588, 11035.558577657124, 11461.598844040418, 11527.654170374903, 11597.18819682614, 8447.957760211406, 10893.727656808644, 11077.612283570037, 11113.611023614458, 11482.598109066143, 11400.030997365317, 11479.713007174887, 11562.132840036862, 11781.410929453665, 11909.166358354832, 7845.605202433341, 7910.5649189295145, 8331.250187483156, 8481.703140390056, 8519.872201916853, 9549.52252387364, 9961.107389595954, 10905.236633435901, 10963.342199468058, 11234.83147752768], "value": 9853.43442390348, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1313.474610155938, 1459.525654162397, 1499.5951093204835, 1635.8200597934226, 1813.320004998125, 8007.839843203133, 8516.659333626656, 8788.165124313196, 9019.95490022549, 9020.54897255138, 8892.155245251706, 8980.955095224532, 8981.236594889442, 8985.0, 8985.056569060236, 2390.808735301176, 2419.8185136114776, 2423.164008417093, 2424.3333083402117, 2430.4045508850268, 1958.4026871804094, 2401.987990060047, 2411.722651895037, 2413.384586930339, 2425.2724182745196, 2383.6305372667266, 2399.4961058177805, 2412.9879350603223, 2421.4793819328843, 2426.3085020769086, 2348.1781376518084, 2366.325597204797, 2373.477834876333, 2376.215848769919, 2391.8564886106715, 2338.941526461835, 2370.3837002379505, 2377.4413012941945, 2381.535600557892, 2382.6783384243076, 8346.83306333876, 8427.030891447439, 8919.152680495408, 9003.234725048378, 9017.504037277948, 5284.048871203182, 5487.0, 5491.478309560585, 5509.586780991402, 5517.503424691757, 3665.9450108248398, 3709.109813644706, 3720.4605332226674, 3754.4931434256573, 3769.6984241260634, 950.6577632052456, 1097.6158344579412, 1111.2776695148139, 1112.1769890281214, 1117.7261570915095, 11789.997850182745, 11836.171467997243, 11898.286102833858, 11908.285502869856, 11917.761644767143, 4505.48186958504, 4539.977300113478, 4729.62163026957, 4733.83431579893, 4737.620990320835, 9217.723468295962, 9224.123708247706, 9244.491552964651, 9246.306527010502, 9271.582778774837, 5327.573794096463, 5330.360356757136, 5331.866703332447, 5334.253204551366, 5335.466453354711, 4184.267753143188, 4441.111777644484, 4576.176288268077, 4606.700564463299, 4954.975225123923, 3845.115623406576, 3889.8055097245024, 3926.9410958835642, 3933.9016524587114, 3946.8421263149726, 1171.94140292985, 1178.9941050294694, 1182.9645110646695, 1189.3696340939316, 1191.976160476803, 779.9961000194962, 866.3502373220085, 894.9239314658327, 899.5322432335149, 913.853783394667, 5667.744951477111, 5740.598158128891, 5787.131930210502, 5908.793192238251, 6105.603135796159, 933.705882646964, 943.6414162618298, 958.8609651600478, 970.2626004236831, 989.1295659819313, 3842.558105817811, 3869.9226015479535, 3884.8251828667776, 3967.484227050465, 3988.7606743594897, 10717.517711702993, 10883.945580272048, 11000.174986876016, 11012.669619911416, 11091.667249982513, 10916.181286403551, 10937.726556835984, 10943.83584246237, 10953.616623418142, 10956.561737530568, 7922.564258965697, 8160.673573057011, 8162.510249384937, 8334.583270836434, 8421.410501264974, 5080.298100136496, 5802.303723553201, 5898.469137777621, 5927.792527261525, 6087.878242435215, 9830.852537211804, 10249.33379330341, 10408.427536485566, 10432.634857779942, 10441.164706823587, 7654.540727556365, 8903.510306933182, 9540.045995400682, 10178.694639160542, 10582.312149710244, 7124.109486314211, 7509.51188172767, 7658.157602663814, 7760.068791745027, 7835.0, 8429.831403372022, 8443.788905277417, 8519.659213631385, 8536.786580335542, 8554.059053503985, 6945.236024037453, 7470.252974702486, 7712.730054448068, 7741.032370953631, 7772.417068719756, 7529.962350188433, 7563.319301262913, 7581.696732130653, 7598.544087354777, 7748.806279843049, 7060.399866011241, 7087.114110736158, 7101.360877520841, 7175.461840362098, 7178.389836863925, 4787.712737235777, 4975.950240497694, 5017.749112544431, 5087.745612719275, 5105.846824595268, 4976.154053810933, 5040.143175660073, 5043.092243396224, 5137.101007323628, 5144.871378215575], "value": 4594.444759006995, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [241.56759400672797, 304.7029146582083, 314.10480131624865, 317.4112022198821, 318.7450039968025, 5413.675179489229, 5419.539339156171, 5464.617476776617, 5471.5896307776875, 5481.314835645544, 4565.7444202844235, 5105.846824595259, 5231.346081739783, 5290.814821481249, 5385.5801566005575, 3488.1454043759313, 3990.5211374635082, 4056.0530945146274, 4117.794110294488, 4163.958360416403, 3442.6041005284337, 4136.710430269883, 4144.8963775905695, 4178.289690752579, 4195.160967806436, 3476.0, 3790.4503846942175, 3921.8430562983845, 4119.134981653841, 4151.83392664293, 4161.583841615845, 4171.97914010431, 4180.853670121562, 4182.665386769082, 4202.873913782591, 3182.7612929030183, 3190.8245046522434, 3604.6034936157002, 3649.4708267301357, 3660.5058317127114, 5005.824796132154, 5041.143005689005, 5287.154055351164, 5293.4971177738435, 5345.4387289334445, 4581.427321584802, 4733.290006499018, 4750.572448479619, 4751.857444276678, 4754.405699287589, 5650.70033892203, 5655.236543066674, 5701.657900525982, 5704.71476426177, 5735.254416925773, 3596.5504311961004, 3678.6137455567314, 3854.8458061677497, 3954.485916830822, 4005.539362973237, 5114.974425127851, 5171.741412929338, 5576.972115139439, 5834.183214349994, 5916.497097746696, 3770.0, 4040.959590404117, 4056.7971601419813, 4059.3910913362643, 4101.487314085739, 3439.9828000859834, 3807.162424266657, 4120.17596480705, 4135.255653982312, 4138.544760076389, 3509.9122521936647, 4364.716293440916, 4665.323528088408, 4730.2668086445965, 4781.187198176319, 5738.397468265855, 5740.368559458456, 5756.481916627524, 5757.568182386338, 5758.675504633958, 1284.8715128487077, 1363.4955066625214, 1367.1748216131377, 1381.3714759784475, 1385.515069725588, 712.1738783011785, 852.5311078906576, 880.2913654508054, 900.7477906186278, 920.1275404551706, 4276.465441819772, 4661.533846615379, 4793.089313030513, 4999.0, 5027.0, 5145.562627176657, 5802.013657678205, 5802.881948088917, 5825.650460972355, 5848.678322692293, 4732.148213321566, 5022.874428139326, 5202.66182698131, 5303.628745987821, 5332.520073193431, 2417.335232810956, 2482.51590939765, 2727.6454060971946, 2847.0177788662877, 3084.6915308468974, 5343.278657381282, 5992.610480318765, 6013.488853447506, 6057.273127224761, 6105.778844231171, 5492.5605951524585, 5907.291125064934, 5943.554233432424, 5992.610480318765, 6004.6697431640805, 4654.069186162781, 5265.631405801634, 5817.767289308549, 5945.702714864239, 5978.100621198715, 5163.483651634807, 5384.730763461889, 5435.0, 5463.0060028088665, 5858.8242352729485, 5028.396592408934, 5714.142878568082, 5727.68497732612, 5751.079827227623, 5804.245448091721, 5992.49063829562, 6023.3374328824675, 6051.485623722033, 6080.0, 6112.415688233825, 3438.948415773715, 3452.9482057769656, 3799.4490798834568, 3865.4781604483037, 3945.6843452524304, 4975.303457515878, 5846.41535846429, 5891.852703682443, 5920.37836027211, 5928.436798504135, 5030.792609773554, 5518.255035570307, 5833.67914764692, 5840.591158618856, 5845.240118784531, 4864.902701945871, 4979.502049794992, 5287.576993840406, 5685.573581981285, 5751.699320271758, 4655.464621568563, 5491.615586908878, 5659.660800127945, 5662.433756624305, 5666.376698563073, 5584.162375643686, 5626.240457538343, 5750.913736293875, 5751.5398768099285, 5784.50831679312, 4908.803647854046, 4960.875978100432, 5143.691378517301, 5189.910118874927, 5276.947230527646], "value": 4118.175655119607, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.3999530378045, 764.904386951631, 810.16552950461, 817.1705718695529, 827.536579515471, 15481.38074477021, 16339.34642614294, 16379.672406551877, 16387.672246555063, 16388.426405075825, 12813.679658008554, 14308.21304828234, 14740.04189727667, 14910.850891491082, 15093.245337733124, 825.9628316725762, 850.4684572142411, 851.7700220940343, 851.7913111287743, 853.4580541356253, 566.9234653321811, 694.9339812717809, 697.3828162076574, 697.490831692862, 699.3915293694492, 734.6547122852278, 877.6226222724226, 900.6487469886749, 909.9454032758023, 915.1260546178383, 904.0, 904.6969265296134, 905.0225756183339, 905.1129892705153, 907.3195103672246, 525.5769105869773, 666.2637785247281, 668.5988406955836, 668.7559040950067, 670.9496787740939, 12354.938225308906, 14884.0, 15221.695566088616, 15237.466688665843, 15255.313510892036, 13858.792118118236, 14132.364043618061, 14337.49818756349, 14352.282385880768, 14613.342399592044, 12335.074869384742, 12677.619671409873, 12941.48234070636, 13518.391672374766, 13575.389107490186, 4561.384213131218, 4678.157931572316, 4738.147133515966, 4798.952010479886, 4861.246506791453, 130451.69548304491, 132136.0, 132619.33690331582, 133012.0, 135736.96394554188, 10811.567537298577, 11299.435028248554, 11399.829002564968, 11534.0, 11576.0, 23056.308310750705, 23153.842307884875, 23211.53576928452, 23612.64581031286, 23727.0, 7992.880106798402, 7997.7600671979935, 8113.148119447373, 8162.795930101676, 8220.465669731448, 3970.82131304092, 4452.9554704453185, 4463.308187230984, 4583.854036490878, 4628.097520983376, 3576.8926932192076, 3688.7233457490797, 3692.0585250760882, 3693.316736403774, 3698.9075273118387, 672.1530871102447, 673.1148539670415, 683.7025893736142, 691.3570379547069, 695.5756988237172, 470.76276424774386, 537.0830050884161, 602.5661523702927, 611.4435863364317, 620.1906512001791, 7410.96294518524, 8569.614367353484, 8594.484330940164, 9099.181073703267, 9117.680881169259, 497.8929530151035, 580.5558747558122, 589.8613825750945, 621.8072397556772, 649.5647915896361, 3725.4970578972034, 4021.678265738734, 4367.192069467159, 4384.64629626877, 4419.204543182258, 143543.0, 149040.0, 159714.0, 162253.0, 175796.0, 84779.88050298791, 113960.29059564113, 114548.0, 114938.0, 131268.0, 107199.46400268105, 115029.0, 117301.0, 118356.40821795836, 119818.0, 9290.814183716153, 9863.0, 9928.0, 9990.600375984879, 9999.950000249952, 62901.0, 64434.355656442836, 65063.67468162629, 65865.0, 66458.33541664522, 80278.59860700658, 98400.50799745956, 99844.0, 101728.0, 103116.96883031074, 12431.937840311102, 12941.352932353533, 13207.537736179187, 13301.736335048156, 13600.0, 13922.860771392561, 14076.577702668936, 14408.207548584509, 14463.0, 15738.527844164693, 11835.28988260707, 12621.74756504883, 13368.398422071225, 13764.587062388144, 14040.438382464587, 13315.933420332836, 13750.381232844346, 13884.583462495737, 13990.790138148139, 14089.859101408854, 12932.60746761852, 12998.740025199631, 13142.671433214246, 13889.861101388857, 14007.159570425807, 11302.43487825589, 11354.26197297173, 11815.76368472643, 11916.582919597773, 12083.697907552381, 11699.649010529698, 11725.472353743931, 11912.463939122934, 11955.222910510789, 11961.64115076549], "value": 7900.859234473204, "unit": "score"}], "name": "dromaeo_css", "value": 7404.1650322287915, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 112.0, 113.0, 110.0, 112.0, 112.0, 111.0, 108.0, 112.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 111.0, 142.0, 108.0, 109.0, 109.0, 107.0, 137.0, 108.0], "value": 118.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 186.0, 182.0, 186.0, 183.0, 183.0, 181.0, 183.0, 184.0, 183.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 61.0, 59.0, 88.0, 61.0, 61.0, 59.0, 59.0, 83.0, 58.0], "value": 67.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 94.0, 69.0, 69.0, 69.0, 92.0, 68.0, 69.0, 90.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 83.0, 87.0, 84.0, 87.0, 87.0, 88.0, 70.0], "value": 84.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 104.0, 95.0, 96.0, 95.0, 96.0, 97.0, 96.0, 96.0, 96.0], "value": 96.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 87.0, 86.0, 86.0, 87.0, 84.0, 85.0, 84.0, 86.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 53.0, 52.0, 55.0, 58.0, 58.0, 58.0, 58.0, 58.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 77.0, 74.0, 73.0, 72.0, 71.0, 69.0, 71.0, 72.0, 72.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 82.0, 83.0, 86.0, 84.0, 84.0, 87.0, 96.0, 102.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 139.0, 137.0, 142.0, 153.0, 135.0, 124.0, 152.0, 199.0, 151.0], "value": 147.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 163.0, 161.0, 164.0, 163.0, 161.0, 163.0, 164.0], "value": 162.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 65.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1414.5, "alertThreshold": 2.0}]} 21:58:15 INFO - Return code: 0 21:58:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:58:15 INFO - # TBPL SUCCESS # 21:58:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:58:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:58:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:58:15 INFO - 2016-10-04 21:58:15.934 screenresolution[1670:10283] starting screenresolution argv=screenresolution get 21:58:15 INFO - 2016-10-04 21:58:15.937 screenresolution[1670:10283] Display 0: 1600x1200x32@60 21:58:15 INFO - 2016-10-04 21:58:15.943 screenresolution[1671:10286] starting screenresolution argv=screenresolution list 21:58:15 INFO - Available Modes on Display 0 21:58:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:58:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:58:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:58:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:58:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:58:16 INFO - Intel Iris: 21:58:16 INFO - Chipset Model: Intel Iris 21:58:16 INFO - Type: GPU 21:58:16 INFO - Bus: Built-In 21:58:16 INFO - VRAM (Dynamic, Max): 1536 MB 21:58:16 INFO - Vendor: Intel (0x8086) 21:58:16 INFO - Device ID: 0x0a2e 21:58:16 INFO - Revision ID: 0x0009 21:58:16 INFO - Displays: 21:58:16 INFO - Display: 21:58:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:58:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:58:16 INFO - Display Serial Number: 1600x1200 60 21:58:16 INFO - Main Display: Yes 21:58:16 INFO - Mirror: Off 21:58:16 INFO - Online: Yes 21:58:16 INFO - Rotation: Supported 21:58:16 INFO - Return code: 0 21:58:16 INFO - Running post-action listener: _resource_record_post_action 21:58:16 INFO - [mozharness: 2016-10-05 04:58:16.178428Z] Finished run-tests step (success) 21:58:16 INFO - Running post-run listener: _resource_record_post_run 21:58:16 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 38523904; Write bytes: 663526400; Read time: 377; Write time: 1954 21:58:16 INFO - TinderboxPrint: CPU usage
53.4% 21:58:16 INFO - TinderboxPrint: I/O read bytes / time
38,523,904 / 377 21:58:16 INFO - TinderboxPrint: I/O write bytes / time
663,526,400 / 1,954 21:58:16 INFO - TinderboxPrint: CPU idle
2,256.0 (46.6%) 21:58:16 INFO - TinderboxPrint: CPU system
966.0 (20.0%) 21:58:16 INFO - TinderboxPrint: CPU user
1,615.7 (33.4%) 21:58:16 INFO - TinderboxPrint: Swap in / out
401,776,640 / 0 21:58:16 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 358212096; Write bytes: 356521984; Read time: 27424; Write time: 785 21:58:16 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 36533248; Write bytes: 295957504; Read time: 355; Write time: 1133 21:58:16 INFO - Running post-run listener: _upload_blobber_files 21:58:16 INFO - Blob upload gear active. 21:58:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:58: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 21:58: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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:58: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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:58:17 INFO - (blobuploader) - INFO - Open directory for files ... 21:58:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:58:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:58:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:58:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:58:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:58:17 INFO - (blobuploader) - INFO - Done attempting. 21:58:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:58:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:58:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:58:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:58:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:58:18 INFO - (blobuploader) - INFO - Done attempting. 21:58:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:58:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:58:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:58:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:58:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:58:22 INFO - (blobuploader) - INFO - Done attempting. 21:58:22 INFO - (blobuploader) - INFO - Iteration through files over. 21:58:22 INFO - Return code: 0 21:58:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:58:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:58:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f33a47b8bbd5ee3972284b1267978dd36d24d42aee189ddec36246a6dc9d091910811d10ec4ce3e1ea814d79feae5648ac6c387733b9301833a5cfd28037f42f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48288ff4b911d7546c5ab4bfbd45bb43d92577d1878009a790f0f103e28b363853243f580b9786834fda35a04796cf36b06e26b01dfafba97db64487885278ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e83fc5cf1eb4d6cd3a913a009b9a3a4293d3eec97574c960617765960030bb1a9c7c77826383bb34a8f07abdb7b4efbbaa295283cb4cf9d39a9f5f98fe5173c"} 21:58:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:58:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:58:22 INFO - Contents: 21:58:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f33a47b8bbd5ee3972284b1267978dd36d24d42aee189ddec36246a6dc9d091910811d10ec4ce3e1ea814d79feae5648ac6c387733b9301833a5cfd28037f42f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48288ff4b911d7546c5ab4bfbd45bb43d92577d1878009a790f0f103e28b363853243f580b9786834fda35a04796cf36b06e26b01dfafba97db64487885278ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e83fc5cf1eb4d6cd3a913a009b9a3a4293d3eec97574c960617765960030bb1a9c7c77826383bb34a8f07abdb7b4efbbaa295283cb4cf9d39a9f5f98fe5173c"} 21:58:22 INFO - Running post-run listener: copy_logs_to_upload_dir 21:58:22 INFO - Copying logs to upload dir... 21:58:22 INFO - mkdir: /builds/slave/test/build/upload/logs 21:58:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.772985 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-04 21:58:22.164715) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 21:58:22.170821) ========= 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.pwSkaI98x9/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.UJGGrQIK3c/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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/Mozilla-Aurora/sha512/f33a47b8bbd5ee3972284b1267978dd36d24d42aee189ddec36246a6dc9d091910811d10ec4ce3e1ea814d79feae5648ac6c387733b9301833a5cfd28037f42f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48288ff4b911d7546c5ab4bfbd45bb43d92577d1878009a790f0f103e28b363853243f580b9786834fda35a04796cf36b06e26b01dfafba97db64487885278ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e83fc5cf1eb4d6cd3a913a009b9a3a4293d3eec97574c960617765960030bb1a9c7c77826383bb34a8f07abdb7b4efbbaa295283cb4cf9d39a9f5f98fe5173c"} build_url:https://queue.taskcluster.net/v1/task/N50Imj_0QLeZ3wI-dThumg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011032 build_url: 'https://queue.taskcluster.net/v1/task/N50Imj_0QLeZ3wI-dThumg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f33a47b8bbd5ee3972284b1267978dd36d24d42aee189ddec36246a6dc9d091910811d10ec4ce3e1ea814d79feae5648ac6c387733b9301833a5cfd28037f42f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48288ff4b911d7546c5ab4bfbd45bb43d92577d1878009a790f0f103e28b363853243f580b9786834fda35a04796cf36b06e26b01dfafba97db64487885278ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e83fc5cf1eb4d6cd3a913a009b9a3a4293d3eec97574c960617765960030bb1a9c7c77826383bb34a8f07abdb7b4efbbaa295283cb4cf9d39a9f5f98fe5173c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 21:58:22.204348) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 21:58:22.204744) ========= 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.pwSkaI98x9/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.UJGGrQIK3c/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.005097 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 21:58:22.254664) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 21:58:22.255067) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 21:58:22.255468) ========= ========= Total master_lag: 0.18 =========