builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0293 starttime: 1490365848.86 results: success (0) buildid: 20170324062518 builduid: f58ec5f5bbb749ef896388ad2b7dd665 revision: 9625d35372f07eb34af3b60dbf886c3a8b0a99dc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 07:30:48.857867) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 07:30:48.867831) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 07:30:48.868155) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 07:30:48.896675) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 07:30:48.897090) ========= 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.BsqbIx62FF/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.PwKOZY4gku/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-24 07:30:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.9M=0.001s 2017-03-24 07:30:49 (18.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.182890 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 07:30:49.105102) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 07:30:49.105577) ========= 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.BsqbIx62FF/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.PwKOZY4gku/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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.026329 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 07:30:49.154094) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 07:30:49.154483) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9625d35372f07eb34af3b60dbf886c3a8b0a99dc --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-beta --rev 9625d35372f07eb34af3b60dbf886c3a8b0a99dc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BsqbIx62FF/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.PwKOZY4gku/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-24 07:30:49,264 truncating revision to first 12 chars 2017-03-24 07:30:49,264 Setting DEBUG logging. 2017-03-24 07:30:49,264 attempt 1/10 2017-03-24 07:30:49,264 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/9625d35372f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-24 07:30:49,743 unpacking tar archive at: mozilla-beta-9625d35372f0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.755924 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 07:30:49.934841) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 07:30:49.935242) ========= script_repo_revision: 9625d35372f07eb34af3b60dbf886c3a8b0a99dc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 07:30:49.935804) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 07:30:49.936100) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 07:30:49.956571) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-03-24 07:30:49.957023) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BsqbIx62FF/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.PwKOZY4gku/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 07:30:50 INFO - MultiFileLogger online at 20170324 07:30:50 in /builds/slave/test 07:30:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 07:30:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:30:50 INFO - {'append_to_log': False, 07:30:50 INFO - 'base_work_dir': '/builds/slave/test', 07:30:50 INFO - 'blob_upload_branch': 'Mozilla-Beta', 07:30:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:30:50 INFO - 'branch': 'Mozilla-Beta', 07:30:50 INFO - 'buildbot_json_path': 'buildprops.json', 07:30:50 INFO - 'config_files': ('talos/mac_config.py',), 07:30:50 INFO - 'default_actions': ('clobber', 07:30:50 INFO - 'read-buildbot-config', 07:30:50 INFO - 'download-and-extract', 07:30:50 INFO - 'populate-webroot', 07:30:50 INFO - 'create-virtualenv', 07:30:50 INFO - 'install', 07:30:50 INFO - 'run-tests'), 07:30:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:30:50 INFO - 'download_minidump_stackwalk': True, 07:30:50 INFO - 'download_symbols': 'ondemand', 07:30:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:30:50 INFO - 'tooltool.py': '/tools/tooltool.py', 07:30:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:30:50 INFO - '/tools/misc-python/virtualenv.py')}, 07:30:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:30:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:30:50 INFO - 'installer_path': 'installer.exe', 07:30:50 INFO - 'log_level': 'info', 07:30:50 INFO - 'log_name': 'talos', 07:30:50 INFO - 'log_to_console': True, 07:30:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:30:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:30:50 INFO - 'opt_config_files': (), 07:30:50 INFO - 'pip_index': False, 07:30:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:30:50 INFO - 'cmd': ('bash', 07:30:50 INFO - '-c', 07:30:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:30:50 INFO - 'enabled': True, 07:30:50 INFO - 'halt_on_failure': False, 07:30:50 INFO - 'name': 'check_screen_resolution'},), 07:30:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:30:50 INFO - 'cmd': ('bash', 07:30:50 INFO - '-c', 07:30:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:30:50 INFO - 'enabled': True, 07:30:50 INFO - 'halt_on_failure': False, 07:30:50 INFO - 'name': 'check_screen_resolution'},), 07:30:50 INFO - 'run_cmd_checks_enabled': True, 07:30:50 INFO - 'sps_profile': False, 07:30:50 INFO - 'sps_profile_interval': 0, 07:30:50 INFO - 'suite': 'dromaeojs', 07:30:50 INFO - 'system_bits': '32', 07:30:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:30:50 INFO - 'title': 't-yosemite-r7-0293', 07:30:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:30:50 INFO - 'use_talos_json': True, 07:30:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:30:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:30:50 INFO - 'work_dir': 'build'} 07:30:50 INFO - [mozharness: 2017-03-24 14:30:50.172074Z] Running clobber step. 07:30:50 INFO - Running pre-action listener: _resource_record_pre_action 07:30:50 INFO - Running main action method: clobber 07:30:50 INFO - rmtree: /builds/slave/test/build 07:30:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:30:52 INFO - Running post-action listener: _resource_record_post_action 07:30:52 INFO - [mozharness: 2017-03-24 14:30:52.563787Z] Finished clobber step (success) 07:30:52 INFO - [mozharness: 2017-03-24 14:30:52.563971Z] Running read-buildbot-config step. 07:30:52 INFO - Running pre-action listener: _resource_record_pre_action 07:30:52 INFO - Running main action method: read_buildbot_config 07:30:52 INFO - Using buildbot properties: 07:30:52 INFO - { 07:30:52 INFO - "project": "", 07:30:52 INFO - "product": "firefox", 07:30:52 INFO - "script_repo_revision": "production", 07:30:52 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 07:30:52 INFO - "repository": "", 07:30:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 07:30:52 INFO - "buildid": "20170324062518", 07:30:52 INFO - "pgo_build": "False", 07:30:52 INFO - "basedir": "/builds/slave/test", 07:30:52 INFO - "buildnumber": 16, 07:30:52 INFO - "slavename": "t-yosemite-r7-0293", 07:30:52 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 07:30:52 INFO - "platform": "yosemite_r7", 07:30:52 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 07:30:52 INFO - "branch": "mozilla-beta", 07:30:52 INFO - "repo_path": "releases/mozilla-beta", 07:30:52 INFO - "revision": "9625d35372f07eb34af3b60dbf886c3a8b0a99dc", 07:30:52 INFO - "stage_platform": "macosx64", 07:30:52 INFO - "builduid": "f58ec5f5bbb749ef896388ad2b7dd665", 07:30:52 INFO - "slavebuilddir": "test" 07:30:52 INFO - } 07:30:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/N79vKfzCS-u1AIE6IgULbA/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 07:30:52 INFO - Running post-action listener: _resource_record_post_action 07:30:52 INFO - [mozharness: 2017-03-24 14:30:52.567355Z] Finished read-buildbot-config step (success) 07:30:52 INFO - [mozharness: 2017-03-24 14:30:52.567438Z] Running download-and-extract step. 07:30:52 INFO - Running pre-action listener: _resource_record_pre_action 07:30:52 INFO - Running main action method: download_and_extract 07:30:52 INFO - mkdir: /builds/slave/test/build/tests 07:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:52 INFO - trying https://queue.taskcluster.net/v1/task/N79vKfzCS-u1AIE6IgULbA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 07:30:52 INFO - Downloading https://queue.taskcluster.net/v1/task/N79vKfzCS-u1AIE6IgULbA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 07:30:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N79vKfzCS-u1AIE6IgULbA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 07:30:54 INFO - Downloaded 1165 bytes. 07:30:54 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 07:30:54 INFO - Using the following test package requirements: 07:30:54 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 07:30:54 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 07:30:54 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 07:30:54 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 07:30:54 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 07:30:54 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 07:30:54 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 07:30:54 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 07:30:54 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 07:30:54 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 07:30:54 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 07:30:54 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 07:30:54 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 07:30:54 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 07:30:54 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 07:30:54 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 07:30:54 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 07:30:54 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 07:30:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N79vKfzCS-u1AIE6IgULbA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 07:30:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N79vKfzCS-u1AIE6IgULbA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 07:30:54 INFO - Fetch https://queue.taskcluster.net/v1/task/N79vKfzCS-u1AIE6IgULbA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 07:30:55 INFO - Expected file size: 16108231 07:30:55 INFO - Obtained file size: 16108231 07:31:02 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 07:31:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N79vKfzCS-u1AIE6IgULbA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 07:31:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N79vKfzCS-u1AIE6IgULbA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 07:31:02 INFO - Fetch https://queue.taskcluster.net/v1/task/N79vKfzCS-u1AIE6IgULbA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 07:31:03 INFO - Expected file size: 16108231 07:31:03 INFO - Obtained file size: 16108231 07:31:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N79vKfzCS-u1AIE6IgULbA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 07:31:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N79vKfzCS-u1AIE6IgULbA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 07:31:09 INFO - Fetch https://queue.taskcluster.net/v1/task/N79vKfzCS-u1AIE6IgULbA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 07:31:11 INFO - Expected file size: 14403663 07:31:11 INFO - Obtained file size: 14403663 07:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:12 INFO - trying https://queue.taskcluster.net/v1/task/N79vKfzCS-u1AIE6IgULbA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 07:31:12 INFO - Downloading https://queue.taskcluster.net/v1/task/N79vKfzCS-u1AIE6IgULbA/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 07:31:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N79vKfzCS-u1AIE6IgULbA/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 07:31:13 INFO - Downloaded 58731225 bytes. 07:31:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N79vKfzCS-u1AIE6IgULbA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 07:31:13 INFO - mkdir: /builds/slave/test/properties 07:31:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:31:13 INFO - Writing to file /builds/slave/test/properties/build_url 07:31:13 INFO - Contents: 07:31:13 INFO - build_url:https://queue.taskcluster.net/v1/task/N79vKfzCS-u1AIE6IgULbA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 07:31:14 INFO - Running post-action listener: _resource_record_post_action 07:31:14 INFO - Running post-action listener: set_extra_try_arguments 07:31:14 INFO - [mozharness: 2017-03-24 14:31:14.750560Z] Finished download-and-extract step (success) 07:31:14 INFO - [mozharness: 2017-03-24 14:31:14.750707Z] Running populate-webroot step. 07:31:14 INFO - Running pre-action listener: _resource_record_pre_action 07:31:14 INFO - Running main action method: populate_webroot 07:31:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:31:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:31:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:31:14 INFO - '--tppagecycles', 07:31:14 INFO - '7'], 07:31:14 INFO - 'tests': ['tsvgm']}}, 07:31:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:31:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:31:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:31:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:31:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:31:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:31:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:31:14 INFO - 'talos_options': ['--disable-e10s'], 07:31:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:31:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:31:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:31:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:31:14 INFO - 'talos_options': ['--disable-e10s'], 07:31:14 INFO - 'tests': ['damp', 'tps']}, 07:31:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:31:14 INFO - 'tests': ['damp', 'tps']}, 07:31:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:31:14 INFO - 'tests': ['dromaeo_dom']}, 07:31:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:31:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:31:14 INFO - 'tests': ['basic_compositor_video']}, 07:31:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:31:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:31:14 INFO - 'tests': ['a11yr', 07:31:14 INFO - 'ts_paint', 07:31:14 INFO - 'tpaint', 07:31:14 INFO - 'sessionrestore', 07:31:14 INFO - 'sessionrestore_no_auto_restore', 07:31:14 INFO - 'tabpaint']}, 07:31:14 INFO - 'other-e10s': {'tests': ['a11yr', 07:31:14 INFO - 'ts_paint', 07:31:14 INFO - 'tpaint', 07:31:14 INFO - 'sessionrestore', 07:31:14 INFO - 'sessionrestore_no_auto_restore', 07:31:14 INFO - 'tabpaint']}, 07:31:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:31:14 INFO - 'ts_paint', 07:31:14 INFO - 'tpaint', 07:31:14 INFO - 'sessionrestore', 07:31:14 INFO - 'sessionrestore_no_auto_restore', 07:31:14 INFO - 'tabpaint']}, 07:31:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:31:14 INFO - 'ts_paint', 07:31:14 INFO - 'tpaint', 07:31:14 INFO - 'sessionrestore', 07:31:14 INFO - 'sessionrestore_no_auto_restore', 07:31:14 INFO - 'tabpaint']}, 07:31:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:31:14 INFO - 'tests': ['a11yr', 07:31:14 INFO - 'ts_paint', 07:31:14 INFO - 'tpaint', 07:31:14 INFO - 'sessionrestore', 07:31:14 INFO - 'sessionrestore_no_auto_restore', 07:31:14 INFO - 'tabpaint']}, 07:31:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:31:14 INFO - 'tests': ['a11yr', 07:31:14 INFO - 'ts_paint', 07:31:14 INFO - 'tpaint', 07:31:14 INFO - 'sessionrestore', 07:31:14 INFO - 'sessionrestore_no_auto_restore', 07:31:14 INFO - 'tabpaint']}, 07:31:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:31:14 INFO - 'tests': ['tsvgx', 07:31:14 INFO - 'tsvgr_opacity', 07:31:14 INFO - 'tart', 07:31:14 INFO - 'tscrollx', 07:31:14 INFO - 'cart', 07:31:14 INFO - 'tsvg_static']}, 07:31:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:31:14 INFO - 'tsvgr_opacity', 07:31:14 INFO - 'tart', 07:31:14 INFO - 'tscrollx', 07:31:14 INFO - 'cart', 07:31:14 INFO - 'tsvg_static']}, 07:31:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:31:14 INFO - 'talos_options': ['--disable-e10s'], 07:31:14 INFO - 'tests': ['tp5o']}, 07:31:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:31:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:31:14 INFO - 'talos_options': ['--disable-e10s', 07:31:14 INFO - '--xperf_path', 07:31:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:31:14 INFO - 'tests': ['tp5n']}, 07:31:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:31:14 INFO - 'talos_options': ['--xperf_path', 07:31:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:31:14 INFO - 'tests': ['tp5n']}}, 07:31:14 INFO - 'talos.zip': {'path': '', 07:31:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:31:14 INFO - Running post-action listener: _resource_record_post_action 07:31:14 INFO - [mozharness: 2017-03-24 14:31:14.768645Z] Finished populate-webroot step (success) 07:31:14 INFO - [mozharness: 2017-03-24 14:31:14.768785Z] Running create-virtualenv step. 07:31:14 INFO - Running pre-action listener: _resource_record_pre_action 07:31:14 INFO - Running main action method: create_virtualenv 07:31:14 INFO - Creating virtualenv /builds/slave/test/build/venv 07:31:14 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 07:31:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:31:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:31:14 INFO - Using real prefix '/tools/python27' 07:31:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:31:15 INFO - Installing distribute.............................................................................................................................................................................................done. 07:31:18 INFO - Installing pip.................done. 07:31:18 INFO - Return code: 0 07:31:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:31:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:31:18 INFO - Reading from file tmpfile_stdout 07:31:18 INFO - Output received: 07:31:18 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:31:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:31:18 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')]} 07:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:19 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 0x105601b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105604768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6724d9ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053dfd30>, '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 0x105306db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d4be8>, '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.BsqbIx62FF/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.PwKOZY4gku/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 07:31:19 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 07:31:19 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 07:31:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BsqbIx62FF/Render', 07:31:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:19 INFO - 'HOME': '/Users/cltbld', 07:31:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:19 INFO - 'LOGNAME': 'cltbld', 07:31:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:19 INFO - 'MOZ_NO_REMOTE': '1', 07:31:19 INFO - 'NO_EM_RESTART': '1', 07:31:19 INFO - 'PAGER': '/bin/cat', 07:31:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:19 INFO - 'PWD': '/builds/slave/test', 07:31:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:19 INFO - 'SHELL': '/bin/bash', 07:31:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PwKOZY4gku/Listeners', 07:31:19 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 07:31:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:19 INFO - 'USER': 'cltbld', 07:31:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:19 INFO - 'XPC_FLAGS': '0x0', 07:31:19 INFO - 'XPC_SERVICE_NAME': '0', 07:31:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:19 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 07:31:19 INFO - Cleaning up... 07:31:19 INFO - Return code: 0 07:31:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105601b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105604768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6724d9ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053dfd30>, '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 0x105306db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d4be8>, '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.BsqbIx62FF/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.PwKOZY4gku/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 07:31:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:31:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:31:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BsqbIx62FF/Render', 07:31:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:20 INFO - 'HOME': '/Users/cltbld', 07:31:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:20 INFO - 'LOGNAME': 'cltbld', 07:31:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:20 INFO - 'MOZ_NO_REMOTE': '1', 07:31:20 INFO - 'NO_EM_RESTART': '1', 07:31:20 INFO - 'PAGER': '/bin/cat', 07:31:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:20 INFO - 'PWD': '/builds/slave/test', 07:31:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:20 INFO - 'SHELL': '/bin/bash', 07:31:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PwKOZY4gku/Listeners', 07:31:20 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 07:31:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:20 INFO - 'USER': 'cltbld', 07:31:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:20 INFO - 'XPC_FLAGS': '0x0', 07:31:20 INFO - 'XPC_SERVICE_NAME': '0', 07:31:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:20 INFO - Downloading/unpacking psutil>=3.1.1 07:31:20 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 07:31:20 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 07:31:20 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 07:31:20 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 07:31:20 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 07:31:20 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 07:31:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:31:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:31:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:31:23 INFO - Installing collected packages: psutil 07:31:23 INFO - Running setup.py install for psutil 07:31:23 INFO - building 'psutil._psutil_osx' extension 07:31:23 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 07:31:24 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 07:31:24 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 07:31:24 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 07:31:24 INFO - building 'psutil._psutil_posix' extension 07:31:24 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 07:31:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:31:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:31:24 INFO - ^ 07:31:24 INFO - 1 warning generated. 07:31:24 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 07:31:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:31:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:31:24 INFO - Successfully installed psutil 07:31:24 INFO - Cleaning up... 07:31:24 INFO - Return code: 0 07:31:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:31:24 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')]} 07:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:24 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')]} 07:31:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:24 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 0x105601b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105604768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6724d9ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053dfd30>, '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 0x105306db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d4be8>, '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.BsqbIx62FF/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.PwKOZY4gku/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 07:31:24 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 07:31:24 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 07:31:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BsqbIx62FF/Render', 07:31:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:24 INFO - 'HOME': '/Users/cltbld', 07:31:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:24 INFO - 'LOGNAME': 'cltbld', 07:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:24 INFO - 'MOZ_NO_REMOTE': '1', 07:31:24 INFO - 'NO_EM_RESTART': '1', 07:31:24 INFO - 'PAGER': '/bin/cat', 07:31:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:24 INFO - 'PWD': '/builds/slave/test', 07:31:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:24 INFO - 'SHELL': '/bin/bash', 07:31:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PwKOZY4gku/Listeners', 07:31:24 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 07:31:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:24 INFO - 'USER': 'cltbld', 07:31:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:24 INFO - 'XPC_FLAGS': '0x0', 07:31:24 INFO - 'XPC_SERVICE_NAME': '0', 07:31:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:31:25 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 07:31:25 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 07:31:25 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 07:31:25 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 07:31:25 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 07:31:25 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 07:31:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:31:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:31:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:31:27 INFO - Installing collected packages: mozsystemmonitor 07:31:27 INFO - Running setup.py install for mozsystemmonitor 07:31:28 INFO - Successfully installed mozsystemmonitor 07:31:28 INFO - Cleaning up... 07:31:28 INFO - Return code: 0 07:31:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:31:28 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')]} 07:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:28 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')]} 07:31:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:28 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 0x105601b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105604768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6724d9ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053dfd30>, '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 0x105306db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d4be8>, '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.BsqbIx62FF/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.PwKOZY4gku/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 07:31:28 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 07:31:28 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 07:31:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BsqbIx62FF/Render', 07:31:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:28 INFO - 'HOME': '/Users/cltbld', 07:31:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:28 INFO - 'LOGNAME': 'cltbld', 07:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:28 INFO - 'MOZ_NO_REMOTE': '1', 07:31:28 INFO - 'NO_EM_RESTART': '1', 07:31:28 INFO - 'PAGER': '/bin/cat', 07:31:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:28 INFO - 'PWD': '/builds/slave/test', 07:31:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:28 INFO - 'SHELL': '/bin/bash', 07:31:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PwKOZY4gku/Listeners', 07:31:28 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 07:31:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:28 INFO - 'USER': 'cltbld', 07:31:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:28 INFO - 'XPC_FLAGS': '0x0', 07:31:28 INFO - 'XPC_SERVICE_NAME': '0', 07:31:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:28 INFO - Downloading/unpacking jsonschema==2.5.1 07:31:28 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 07:31:28 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 07:31:28 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 07:31:28 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 07:31:28 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 07:31:28 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 07:31:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:31:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:31 INFO - Downloading functools32-3.2.3-2.tar.gz 07:31:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:31:31 INFO - warning: no files found matching '*.txt' 07:31:31 INFO - no previously-included directories found matching 'build' 07:31:31 INFO - no previously-included directories found matching 'dist' 07:31:31 INFO - no previously-included directories found matching '.git*' 07:31:31 INFO - Installing collected packages: jsonschema, functools32 07:31:31 INFO - Running setup.py install for functools32 07:31:31 INFO - warning: no files found matching '*.txt' 07:31:31 INFO - no previously-included directories found matching 'build' 07:31:31 INFO - no previously-included directories found matching 'dist' 07:31:31 INFO - no previously-included directories found matching '.git*' 07:31:31 INFO - Successfully installed jsonschema functools32 07:31:31 INFO - Cleaning up... 07:31:31 INFO - Return code: 0 07:31:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:31: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')]} 07:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31: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')]} 07:31:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105601b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105604768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6724d9ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053dfd30>, '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 0x105306db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d4be8>, '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.BsqbIx62FF/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.PwKOZY4gku/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 07:31:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:31:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:31:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BsqbIx62FF/Render', 07:31:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:31 INFO - 'HOME': '/Users/cltbld', 07:31:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:31 INFO - 'LOGNAME': 'cltbld', 07:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:31 INFO - 'MOZ_NO_REMOTE': '1', 07:31:31 INFO - 'NO_EM_RESTART': '1', 07:31:31 INFO - 'PAGER': '/bin/cat', 07:31:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:31 INFO - 'PWD': '/builds/slave/test', 07:31:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:31 INFO - 'SHELL': '/bin/bash', 07:31:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PwKOZY4gku/Listeners', 07:31:31 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 07:31:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:31 INFO - 'USER': 'cltbld', 07:31:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:31 INFO - 'XPC_FLAGS': '0x0', 07:31:31 INFO - 'XPC_SERVICE_NAME': '0', 07:31:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:31:32 INFO - Cleaning up... 07:31:32 INFO - Return code: 0 07:31:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:31:32 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')]} 07:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:32 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')]} 07:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:32 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 0x105601b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105604768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6724d9ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053dfd30>, '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 0x105306db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d4be8>, '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.BsqbIx62FF/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.PwKOZY4gku/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 07:31:32 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 07:31:32 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 07:31:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BsqbIx62FF/Render', 07:31:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:32 INFO - 'HOME': '/Users/cltbld', 07:31:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:32 INFO - 'LOGNAME': 'cltbld', 07:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:32 INFO - 'MOZ_NO_REMOTE': '1', 07:31:32 INFO - 'NO_EM_RESTART': '1', 07:31:32 INFO - 'PAGER': '/bin/cat', 07:31:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:32 INFO - 'PWD': '/builds/slave/test', 07:31:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:32 INFO - 'SHELL': '/bin/bash', 07:31:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PwKOZY4gku/Listeners', 07:31:32 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 07:31:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:32 INFO - 'USER': 'cltbld', 07:31:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:32 INFO - 'XPC_FLAGS': '0x0', 07:31:32 INFO - 'XPC_SERVICE_NAME': '0', 07:31:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:32 INFO - Downloading/unpacking blobuploader==1.2.4 07:31:32 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 07:31:32 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 07:31:32 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 07:31:32 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 07:31:32 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 07:31:32 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 07:31:35 INFO - Downloading blobuploader-1.2.4.tar.gz 07:31:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:31:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:31:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:36 INFO - Downloading docopt-0.6.1.tar.gz 07:31:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:31:36 INFO - Installing collected packages: blobuploader, requests, docopt 07:31:36 INFO - Running setup.py install for blobuploader 07:31:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:31:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:31:36 INFO - Running setup.py install for requests 07:31:37 INFO - Running setup.py install for docopt 07:31:37 INFO - Successfully installed blobuploader requests docopt 07:31:37 INFO - Cleaning up... 07:31:37 INFO - Return code: 0 07:31:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:31:37 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')]} 07:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:37 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')]} 07:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:37 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 0x105601b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105604768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6724d9ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053dfd30>, '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 0x105306db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d4be8>, '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.BsqbIx62FF/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.PwKOZY4gku/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 07:31:37 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 07:31:37 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 07:31:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BsqbIx62FF/Render', 07:31:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:37 INFO - 'HOME': '/Users/cltbld', 07:31:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:37 INFO - 'LOGNAME': 'cltbld', 07:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:37 INFO - 'MOZ_NO_REMOTE': '1', 07:31:37 INFO - 'NO_EM_RESTART': '1', 07:31:37 INFO - 'PAGER': '/bin/cat', 07:31:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:37 INFO - 'PWD': '/builds/slave/test', 07:31:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:37 INFO - 'SHELL': '/bin/bash', 07:31:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PwKOZY4gku/Listeners', 07:31:37 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 07:31:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:37 INFO - 'USER': 'cltbld', 07:31:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:37 INFO - 'XPC_FLAGS': '0x0', 07:31:37 INFO - 'XPC_SERVICE_NAME': '0', 07:31:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:31:37 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-LZgh72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:31:37 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-FCkObg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:31:37 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-QZkyGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:31:37 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-DQ9S9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:31:37 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-OliDlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:31:38 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-qr_rj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:31:38 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-l59eaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:31:38 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-SOqIbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:31:38 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-N11A2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:31:38 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-ahjEri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:31:38 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-U8E2qF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:31:38 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-GJ0hHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:31:38 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-s1XuGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:31:38 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-8GK6Q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:31:39 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-z1Wh2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:31:39 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-j2goIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:31:39 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-atu2zf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:31:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:31:39 INFO - Running setup.py install for manifestparser 07:31:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:31:39 INFO - Running setup.py install for mozcrash 07:31:39 INFO - Running setup.py install for mozdebug 07:31:39 INFO - Running setup.py install for mozdevice 07:31:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:31:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:31:39 INFO - Running setup.py install for mozfile 07:31:40 INFO - Running setup.py install for mozhttpd 07:31:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:31:40 INFO - Running setup.py install for mozinfo 07:31:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:31:40 INFO - Running setup.py install for mozInstall 07:31:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:31:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:31:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:31:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:31:40 INFO - Running setup.py install for mozleak 07:31:40 INFO - Running setup.py install for mozlog 07:31:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:31:40 INFO - Running setup.py install for moznetwork 07:31:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:31:40 INFO - Running setup.py install for mozprocess 07:31:41 INFO - Running setup.py install for mozprofile 07:31:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:31:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:31:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:31:41 INFO - Running setup.py install for mozrunner 07:31:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:31:41 INFO - Running setup.py install for mozscreenshot 07:31:41 INFO - Running setup.py install for moztest 07:31:41 INFO - Running setup.py install for mozversion 07:31:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:31:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:31:41 INFO - Cleaning up... 07:31:41 INFO - Return code: 0 07:31:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:41 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 0x105601b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105604768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6724d9ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053dfd30>, '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 0x105306db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d4be8>, '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.BsqbIx62FF/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.PwKOZY4gku/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 07:31:41 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 07:31:41 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 07:31:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BsqbIx62FF/Render', 07:31:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:41 INFO - 'HOME': '/Users/cltbld', 07:31:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:41 INFO - 'LOGNAME': 'cltbld', 07:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:41 INFO - 'MOZ_NO_REMOTE': '1', 07:31:41 INFO - 'NO_EM_RESTART': '1', 07:31:41 INFO - 'PAGER': '/bin/cat', 07:31:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:41 INFO - 'PWD': '/builds/slave/test', 07:31:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:41 INFO - 'SHELL': '/bin/bash', 07:31:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PwKOZY4gku/Listeners', 07:31:41 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 07:31:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:41 INFO - 'USER': 'cltbld', 07:31:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:41 INFO - 'XPC_FLAGS': '0x0', 07:31:41 INFO - 'XPC_SERVICE_NAME': '0', 07:31:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:31:42 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-fTkfTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:31:42 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)) 07:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:31:42 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-8MghNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:31:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:31:42 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-h4IMTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:31:42 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)) 07:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:31:42 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-3PfEo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:31:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:31:42 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-Bdkbxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:31:42 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)) 07:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:31:42 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-e5ej3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:31:42 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)) 07:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:31:42 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-B5CFBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:31:42 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)) 07:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:31:42 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-R2GYnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:31:43 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)) 07:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:31:43 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-CUWfFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:31:43 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)) 07:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:31:43 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-4E36NP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:31:43 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)) 07:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:31:43 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-oTdBq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:31:43 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)) 07:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:31:43 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-6t16L6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:31:43 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-5fGOuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:31:43 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)) 07:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:31:43 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-DhJcLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:31:43 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-vj682a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:31:43 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)) 07:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:31:43 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-XczFA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:31:43 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-j9etxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:31:44 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)) 07:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:31:44 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)) 07:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:31:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:46 INFO - Downloading blessings-1.6.tar.gz 07:31:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:31:46 INFO - Installing collected packages: blessings 07:31:46 INFO - Running setup.py install for blessings 07:31:46 INFO - Successfully installed blessings 07:31:46 INFO - Cleaning up... 07:31:47 INFO - Return code: 0 07:31:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:31:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:31:47 INFO - Reading from file tmpfile_stdout 07:31:47 INFO - Current package versions: 07:31:47 INFO - blessings == 1.6 07:31:47 INFO - blobuploader == 1.2.4 07:31:47 INFO - docopt == 0.6.1 07:31:47 INFO - functools32 == 3.2.3-2 07:31:47 INFO - jsonschema == 2.5.1 07:31:47 INFO - manifestparser == 1.1 07:31:47 INFO - mozInstall == 1.12 07:31:47 INFO - mozcrash == 1.0 07:31:47 INFO - mozdebug == 0.1 07:31:47 INFO - mozdevice == 0.49 07:31:47 INFO - mozfile == 1.2 07:31:47 INFO - mozhttpd == 0.7 07:31:47 INFO - mozinfo == 0.9 07:31:47 INFO - mozleak == 0.1 07:31:47 INFO - mozlog == 3.4 07:31:47 INFO - moznetwork == 0.27 07:31:47 INFO - mozprocess == 0.24 07:31:47 INFO - mozprofile == 0.28 07:31:47 INFO - mozrunner == 6.13 07:31:47 INFO - mozscreenshot == 0.1 07:31:47 INFO - mozsystemmonitor == 0.3 07:31:47 INFO - moztest == 0.8 07:31:47 INFO - mozversion == 1.4 07:31:47 INFO - psutil == 3.1.1 07:31:47 INFO - requests == 1.2.3 07:31:47 INFO - wsgiref == 0.1.2 07:31:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:31:47 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')]} 07:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:47 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')]} 07:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:47 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 0x105601b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105604768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6724d9ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053dfd30>, '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 0x105306db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d4be8>, '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.BsqbIx62FF/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.PwKOZY4gku/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 07:31:47 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 07:31:47 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 07:31:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BsqbIx62FF/Render', 07:31:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:47 INFO - 'HOME': '/Users/cltbld', 07:31:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:47 INFO - 'LOGNAME': 'cltbld', 07:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:47 INFO - 'MOZ_NO_REMOTE': '1', 07:31:47 INFO - 'NO_EM_RESTART': '1', 07:31:47 INFO - 'PAGER': '/bin/cat', 07:31:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:47 INFO - 'PWD': '/builds/slave/test', 07:31:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:47 INFO - 'SHELL': '/bin/bash', 07:31:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PwKOZY4gku/Listeners', 07:31:47 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 07:31:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:47 INFO - 'USER': 'cltbld', 07:31:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:47 INFO - 'XPC_FLAGS': '0x0', 07:31:47 INFO - 'XPC_SERVICE_NAME': '0', 07:31:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:47 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)) 07:31:47 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)) 07:31:47 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)) 07:31:47 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)) 07:31:47 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)) 07:31:47 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)) 07:31:47 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)) 07:31:47 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)) 07:31:47 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)) 07:31:47 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)) 07:31:47 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)) 07:31:47 INFO - Cleaning up... 07:31:47 INFO - Return code: 0 07:31:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:31:47 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')]} 07:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:47 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')]} 07:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:47 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 0x105601b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105604768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6724d9ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053dfd30>, '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 0x105306db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d4be8>, '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.BsqbIx62FF/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.PwKOZY4gku/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 07:31:47 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 07:31:47 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 07:31:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BsqbIx62FF/Render', 07:31:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:47 INFO - 'HOME': '/Users/cltbld', 07:31:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:47 INFO - 'LOGNAME': 'cltbld', 07:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:47 INFO - 'MOZ_NO_REMOTE': '1', 07:31:47 INFO - 'NO_EM_RESTART': '1', 07:31:47 INFO - 'PAGER': '/bin/cat', 07:31:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:47 INFO - 'PWD': '/builds/slave/test', 07:31:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:47 INFO - 'SHELL': '/bin/bash', 07:31:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PwKOZY4gku/Listeners', 07:31:47 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 07:31:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:47 INFO - 'USER': 'cltbld', 07:31:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:47 INFO - 'XPC_FLAGS': '0x0', 07:31:47 INFO - 'XPC_SERVICE_NAME': '0', 07:31:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:31:47 INFO - Cleaning up... 07:31:47 INFO - Return code: 0 07:31:47 INFO - Running post-action listener: _resource_record_post_action 07:31:47 INFO - Running post-action listener: _start_resource_monitoring 07:31:47 INFO - Starting resource monitoring. 07:31:47 INFO - [mozharness: 2017-03-24 14:31:47.961731Z] Finished create-virtualenv step (success) 07:31:47 INFO - [mozharness: 2017-03-24 14:31:47.962716Z] Running install step. 07:31:47 INFO - Running pre-action listener: _resource_record_pre_action 07:31:47 INFO - Running main action method: install 07:31:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:31:48 INFO - Reading from file tmpfile_stdout 07:31:48 INFO - Detecting whether we're running mozinstall >=1.0... 07:31:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:31:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:31:48 INFO - Reading from file tmpfile_stdout 07:31:48 INFO - Output received: 07:31:48 INFO - Usage: mozinstall [options] installer 07:31:48 INFO - Options: 07:31:48 INFO - -h, --help show this help message and exit 07:31:48 INFO - -d DEST, --destination=DEST 07:31:48 INFO - Directory to install application into. [default: 07:31:48 INFO - "/builds/slave/test"] 07:31:48 INFO - --app=APP Application being installed. [default: firefox] 07:31:48 INFO - mkdir: /builds/slave/test/build/application 07:31:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:31:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 07:32:02 INFO - Reading from file tmpfile_stdout 07:32:02 INFO - Output received: 07:32:02 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 07:32:02 INFO - Running post-action listener: _resource_record_post_action 07:32:02 INFO - [mozharness: 2017-03-24 14:32:02.837533Z] Finished install step (success) 07:32:02 INFO - [mozharness: 2017-03-24 14:32:02.837676Z] Running run-tests step. 07:32:02 INFO - Running pre-action listener: _resource_record_pre_action 07:32:02 INFO - Running main action method: run_tests 07:32:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:32:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:32:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:32:02 INFO - 2017-03-24 07:32:02.852 screenresolution[1628:7408] starting screenresolution argv=screenresolution get 07:32:02 INFO - 2017-03-24 07:32:02.855 screenresolution[1628:7408] Display 0: 1600x1200x32@60 07:32:02 INFO - 2017-03-24 07:32:02.861 screenresolution[1629:7410] starting screenresolution argv=screenresolution list 07:32:02 INFO - Available Modes on Display 0 07:32:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:32:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:32:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:32:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:32:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:32:03 INFO - Intel Iris: 07:32:03 INFO - Chipset Model: Intel Iris 07:32:03 INFO - Type: GPU 07:32:03 INFO - Bus: Built-In 07:32:03 INFO - VRAM (Dynamic, Max): 1536 MB 07:32:03 INFO - Vendor: Intel (0x8086) 07:32:03 INFO - Device ID: 0x0a2e 07:32:03 INFO - Revision ID: 0x0009 07:32:03 INFO - Displays: 07:32:03 INFO - Display: 07:32:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:32:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:32:03 INFO - Display Serial Number: 1600x1200 60 07:32:03 INFO - Main Display: Yes 07:32:03 INFO - Mirror: Off 07:32:03 INFO - Online: Yes 07:32:03 INFO - Rotation: Supported 07:32:03 INFO - Return code: 0 07:32:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:32:03 INFO - Python 2.7.3 07:32:03 INFO - Return code: 0 07:32:03 INFO - grabbing minidump binary from tooltool 07:32:03 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')]} 07:32:03 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 0x1053dfd30>, '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 0x105306db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d4be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:32:03 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 07:32:03 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 07:32:03 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 07:32:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:32:03 INFO - Return code: 0 07:32:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:32:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:32:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:32:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:32:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:32:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N79vKfzCS-u1AIE6IgULbA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0293', '--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 07:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N79vKfzCS-u1AIE6IgULbA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0293 --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 07:32:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BsqbIx62FF/Render', 07:32:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:03 INFO - 'HOME': '/Users/cltbld', 07:32:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:03 INFO - 'LOGNAME': 'cltbld', 07:32:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:32:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:03 INFO - 'MOZ_NO_REMOTE': '1', 07:32:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:32:03 INFO - 'NO_EM_RESTART': '1', 07:32:03 INFO - 'PAGER': '/bin/cat', 07:32:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:03 INFO - 'PWD': '/builds/slave/test', 07:32:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:32:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:03 INFO - 'SHELL': '/bin/bash', 07:32:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PwKOZY4gku/Listeners', 07:32:03 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 07:32:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:03 INFO - 'USER': 'cltbld', 07:32:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:03 INFO - 'XPC_FLAGS': '0x0', 07:32:03 INFO - 'XPC_SERVICE_NAME': '0', 07:32:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N79vKfzCS-u1AIE6IgULbA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0293', '--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 07:32:03 INFO - mozversion application_buildid: 20170324062518 07:32:03 INFO - mozversion application_changeset: 9625d35372f07eb34af3b60dbf886c3a8b0a99dc 07:32:03 INFO - mozversion application_display_name: Firefox 07:32:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:32:03 INFO - mozversion application_name: Firefox 07:32:03 INFO - mozversion application_remotingname: firefox 07:32:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:32:03 INFO - mozversion application_vendor: Mozilla 07:32:03 INFO - mozversion application_version: 53.0 07:32:03 INFO - mozversion platform_buildid: 20170324062518 07:32:03 INFO - mozversion platform_changeset: 9625d35372f07eb34af3b60dbf886c3a8b0a99dc 07:32:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:32:03 INFO - mozversion platform_version: 53.0 07:32:03 INFO - using testdate: 1490365923 07:32:03 INFO - actual date: 1490365923 07:32:03 INFO - starting webserver on 'localhost:49243' 07:32:03 INFO - SUITE-START | Running 2 tests 07:32:03 INFO - TEST-START | dromaeo_css 07:32:03 INFO - operating with platform_type : mac_ 07:32:03 INFO - Initialising browser for dromaeo_css test... 07:32:03 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/tmparlxnS/profile http://localhost:49243/getInfo.html) 07:32:05 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 07:32:05 INFO - PROCESS | 1639 | colorDepth:24 07:32:05 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 07:32:05 INFO - PROCESS | 1639 | __metrics 07:32:06 INFO - PROCESS | 1639 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:32:06 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:32:06 INFO - TEST-INFO | 1639: exit 0 07:32:06 INFO - Browser initialized. 07:32:06 INFO - Running cycle 1/1 for dromaeo_css test... 07:32:06 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/tmparlxnS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:32:18 INFO - PROCESS | 1642 | RSS: Main: 163418112 07:32:18 INFO - PROCESS | 1642 | 07:35:21 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 07:35:23 INFO - PROCESS | 1642 | RSS: Main: 335880192 07:35:23 INFO - PROCESS | 1642 | 07:38:26 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 07:38:27 INFO - PROCESS | 1642 | RSS: Main: 308985856 07:38:27 INFO - PROCESS | 1642 | 07:41:29 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 07:41:30 INFO - PROCESS | 1642 | RSS: Main: 285437952 07:41:30 INFO - PROCESS | 1642 | 07:44:32 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 07:44:33 INFO - PROCESS | 1642 | RSS: Main: 290471936 07:44:33 INFO - PROCESS | 1642 | 07:47:36 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 07:47:37 INFO - PROCESS | 1642 | RSS: Main: 275472384 07:47:37 INFO - PROCESS | 1642 | 07:50:40 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 07:50:40 INFO - PROCESS | 1642 | RSS: Main: 384630784 07:50:40 INFO - PROCESS | 1642 | 07:50:40 INFO - PROCESS | 1642 | __start_tp_report 07:50:40 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 07:50:40 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 07:50:40 INFO - PROCESS | 1642 | |i|pagename|runs| 07:50:40 INFO - PROCESS | 1642 | |0;dojo.html;3498.6676265754745;3508.5088087667723;3514.2620049789543;3536.487209354645;3560.697340726038;6011.458968692817;6013.188219590354;6014.789482368118;6031.0953356996415;6037.245344331958;5942.554308426864;6000.129981152731;6011.969940150293;6012.60918040327;6016.067509536029;5318.867028324294;5331.2269720890645;5352.304200453936;5362.008028514718;5467.480589344026;5362.570994320465;5374.274472946161;5383.784648614051;5416.133418653017;5493.093639549469;5363.222332761748;5393.298871146745;5462.481064298885;5474.753636086366;5481.616286859921;5434.864128396782;5448;5451.454854514556;5466.644668096601;5472.097103977839;5289.709066001368;5392.91910621341;5410.729463526808;5422.078246698071;5498.3127109111365;5928.703564821785;5946.256717910262;5954.434328738763;5958.642481451084;5989.64062156272;6335.651539165344;6338.429541341256;6355.428011478989;6358.650274234915;6361.936380636181;6411.1024456576115;6448.93551064488;6458.418742313214;6464.709088091;6466.159399278064;6006.069059295816;6006.699665016776;6145.324014358417;6164.445199931983;6167.599106058092;6433.131527243762;6480.708368123445;6505.284418713938;6537.248216455168;6558.475321974231;6269.216347956505;6288.465480434214;6296.937030629727;6306.779262725874;6318.988961766096;6357.618542887441;6436.774712885027;6457.3865482779065;6467.51493637979;6473.28793832678;6193.040078787705;6212.627242365473;6233.594816336924;6249.437550620466;6315.36846315374;6316.399942005502;6329.208848893888;6345.777897773648;6351.936480635227;6371.585846919936;4426.75652839097;5186.507281808223;5189.974050129801;5192.299039629677;5194.246834209094;4569.520200378979;4604.677672562955;4606.424196975378;4614.584687378085;4650.697704649187;6083.239595050619;6122.785702500391;6130.2030736004035;6135.386461353829;6143.508519318444;6325.746970121144;6334.049892516159;6336.398042185985;6337;6339.11252424661;6093.664848433379;6111.13596929516;6114.2662880453745;6130.581587307925;6182.412670796267;4833.854984350475;5711;5711.200431939532;5721.313442386857;5725.083986562214;6639.933600663931;6647.534672572873;6650.20197576294;6659.933400665931;6662.900056499059;6225.564210505221;6264.185655864709;6311.526635502448;6337.429631333202;6456.031595260749;6485.221773387224;6567.211934567882;6595.703193356215;6643;6643.069970204078;6279.654618995999;6310.305866354789;6314.368563143649;6320.715567799368;6332.0818481320875;6315.052742088724;6416.262129855127;6431.5819471734185;6435.163428754232;6444;5271.7891284349735;6141.332587233824;6180.845478863064;6223.159873417031;6247.875042499216;6223.937760622336;6232.376762323732;6241.344658810941;6247.406496382836;6256.217972753406;6195.907061393992;6224.968875155595;6242.687865606792;6251.187345645037;6256.468200202851;6145.293291271561;6202.472789812736;6214.471769899609;6223.19098517208;6243.906341404791;6206.968965155145;6216.751329946932;6224.533160012927;6245.437910588069;6253.5622506424115 07:50:40 INFO - PROCESS | 1642 | |1;ext.html;523.9240310155028;532.8934213157368;538.297521734137;539.6303532080525;556.018627123128;26219;41644.58355416445;42929.78535107328;42988.57011429885;44590;43625.563744362546;44034.7798261009;44071.77964110175;44094;44157.116857662826;9332.160105590496;9536.618535258582;9545.236381089497;9553.37903036304;9561;8930.910690893106;9116.498592577405;11526.538938442452;11705.59030433935;11746.823797643043;11645.534178632844;11707.53169873204;11714.589989350374;11714.648560543197;11715.472803723853;11548.133889958244;11623.883761162364;11625.011873990721;11635.650930472098;11643.76712465746;11455.942720286428;11559.94220028903;11564.479598418091;11564.94217528907;11574.305541667527;41708.58291417077;41963.790181049204;41990;42066.369004464956;42127.578724212675;4078.5309689385804;4120.773357465338;4127.463429754142;4131.938020929689;4162.7502349859105;30746.846265768527;31432;31569.526457103162;32197.51703724446;33111.00666979994;3272.9836350818096;3333.3666603345287;3436.3127374525193;3512.5609298837644;3513.7013353864954;500424;504590;505607;505801;506362;65941;66380.66809665921;66424.67150657056;66562;66576.99999999903;68973.3102668977;68989;69000.3099969004;69045.30954690388;69128.61742765116;17547.64904701899;17850.375236866646;17850.732239016426;17872.106394680213;17888.373906913195;12505.93747031259;13571.864281357257;13674.863251367358;13711.314434278247;13723.656908577166;14269.286535673175;15766.9211653941;16183.10992895402;18195;18229.90885045593;6345;6412.5190610704385;6667.299933507009;7598.430117741192;7665.425093118039;775.9224077592196;892.1881088209827;931.9720408387759;943.7675959837529;948.7201275623707;31108.688913110578;31184.376312473625;31304.060878173692;31785;31961.360772784414;1103.2994048779083;1124.876263611002;1145.135422755814;1145.9255148415327;1231.8213858990396;15988.520344389686;16360.263788129325;16365.427210047592;16374.590635234214;16840;709485.4525727339;885682;887917;888227;892040;50245.74877125591;50734.7316317095;50768.23847642214;56548;56994.71502642543;1461.868431841118;1484.3320505772447;1506.6384067823644;1508.9622759430883;1512.470635277644;29116.272093196993;29700.25749356197;29949.951751688586;30374.392512149192;30450.84774576113;49714.75142624408;53185;54084.72957635186;54132.458675412745;56675.433245667016;610251.8974810195;615019;616330;621027;639554;25892.093776717724;26080.478390432465;26410.735892640827;26519;26801.86599066992;43553.04011319435;43610.11760276549;43645.127097458506;44346.77826610975;44666;36375.63624363722;36470.452943205346;36622.633773661924;38172;38259;36290;36328.63671363253;36429.90710278696;37657.24685506329;37758.43362349622;36302.3251180488;36737.63262367449;36889.077773054814;37146.44280335851;37175.81412093031;29923.70076299209;32052.03843884687;32436.35127297488;32484.863029793843;32625.02124936256;19558.21767129299;24259;24319.270421887373;24370;24687.876560617082 07:50:40 INFO - PROCESS | 1642 | |2;jquery.html;402.4506548561213;407.8776367089873;413.2870797873666;418.7152736139425;440.58364845221257;20126.798732012692;20260.493487662814;20798.584028319423;21332.4666883328;21339.146434142614;17832.821671783277;17902.64194716105;17944.55138621535;21597.784022159773;22416.66375004376;5831.154482600021;6035.517158627321;6078.240219972504;6084.878302433949;6090.60411073281;5687.2606561146995;5801.47786699197;5894.145348924403;5897.439743224409;5913.319968203668;5934.614250073753;5941.0494320908665;5941.316748573904;5953.077273022667;5955.076963070731;5664.575156863231;5853.64878107315;5921.73352199152;5931.436513531229;5939.376365481627;5212.8957420851375;5216.921746173811;5218.608604354688;5226.55574276187;5227.477252274742;26578.6013209802;26696.332591685168;26783.598246026326;26824.59763103555;27021.459570808474;2824.4068745563454;2846.8091228871;2849.070868648289;2852.0588205892213;2855.163269680336;15266.313015914311;15949.441769538127;15993.920030399773;16239.269232884548;16654.916725416297;1846.7506886570409;1858.1823997441084;1876.8498520118358;1894.8957807320592;1906.8951207683572;127269;127312;127812;131257;132661.6733832659;9587.856182157273;11478.827817582744;11503.252288601214;11515.963563279345;11607.361595112181;14862.851371486147;14873.553793386216;14884.330205140795;14893.925530372278;14903.552893413214;8869.778255543662;9009.23421509166;9034.412763170372;9035.864462033074;9167.358284920125;9043.412178208395;9056.909430905607;9070.727878163665;9222.953885230665;9246.676366327147;5874.970625146932;7038.683259253346;7118.71525138999;7153.391961683211;7159.677814498256;1683.2341284715426;1872.7190921361905;1957.5497635543904;2008.4275981345247;2011.195521791266;981.5730157381562;1068.4070340960686;1083.815751322277;1089.7330154112294;1092;21526;22290.885455727148;22883.656745148837;22991;23044.539109217723;872.0320444306815;1076.4294923690456;1083.3932997521413;1127.0926903842321;1133.4332833583208;11115.610953616746;12014.459349329301;12046.518139274505;12111.515539378503;12212.511499540096;778867;780967;781411;788760.2247955124;796508;101373.49313253534;108466;114390.28414573788;120412;135331.32334338265;977.8093271812071;1034.4827586206898;1077.2889892670955;1078.2937176149635;1078.8058149533003;20891;21154;21241;21348.573028539653;21671.34985950424;57667.1349929743;57946.710266450085;58678;59421;60755.69622151861;79841.60079199799;81349.33927973374;82590.17409825824;83690.16309836824;84465;5846.9767790635615;6984.022236886738;7380.667869945758;7967;8267.29727973129;12910.225386476466;13382.531611393555;13450.46198152063;14104.294785260901;14138.78791818144;11220.438978050901;11491.770164596828;11859.822102668639;11868;12019.158658893793;11159.330440173615;11463.942680286546;11847.76304473923;11992;12019.098567607289;11392.544298227978;11485.655430337103;11536.365499897585;12019.338936358585;12162.513499459923;7182.958471021777;7465.365443937326;8347.83304333922;8569.228769410784;8975.698523714156;10193.184545236216;11059.834102488308;11166.944165279447;11730.061595072202;12078.396080196131 07:50:40 INFO - PROCESS | 1642 | |3;mootools.html;1207.746373261615;1275.9425825837839;1462.0569732522524;1474.97787533187;1477.2909003678228;8103.311218546423;8500.447470914387;8521.573921303941;8521.829563408728;8523.190296921783;7548.92451075489;7794.649240784164;7804.570748608824;8132.796680082986;8383.748487545383;1969.3698016634683;2327.441414060626;2395.0419832067137;2401.6637670726027;2402.5555272274596;2365.515069410775;2405.386626410263;2417.685700858886;2417.7703118203744;2431.112643884987;1833.431636192778;2109.535902101535;2295.908163673451;2356.0222507659387;2363.52729454109;2360.9409764755846;2374.062245413052;2376.750441203666;2377.7859992600575;2378.143868207444;1952.3654812186096;2326.592846251899;2376.6435034744754;2377.857328560292;2413.1433341163984;8484.915150848536;8541.402101852873;8545.401821872472;8558.957205213996;8574.056853746082;4931.827386041471;5333.280007199017;5338.225957236218;5345.1447768356875;5381.67709937405;3093.5359696045775;3374.3251349730153;3547.3260080584605;3577.2130131371055;3622.130688634735;1232.8212409200705;1238.0343332200898;1246.5551813036486;1258.672745086275;1312.1667740984449;10896.073833724064;10909.07272881806;10911.618093366695;10935;10958.890411095947;4112.198121366305;4585.266357382803;4655.301704744248;4794.544518270759;4822.662413631082;9650.71047868565;9663.226941844636;9664.90335096654;9669.323147379617;9675.612975481043;5340.198970154508;5344.118220493575;5349.063913815066;5349.304590403222;5352.8661783454945;4699.436067671902;4854.296127061627;4877.170880950247;4941.234108713155;4942.382202224722;3848.1726428817938;3933.567307596162;3950.2889479893897;3995.2608767377546;4015.2371049500503;1289.8387701537308;1296.0992110483312;1301.076235872541;1310.102579732886;1312.0487646456243;779.4154384211841;787.7951732549578;807.0839597057264;813.8453693798159;814.8166662501009;5456.372517160498;5492.093804522289;5542.473465020817;5620.18507316445;5672;569.3708452160304;593.9287285525764;602.4698265526309;603.770567184467;606.2058703098954;3649.5620525537106;3675.8162091895297;3757.1546402059867;3800.562935262425;3824.6366595173413;9813.950930245303;10228.744281393025;10230.897691022994;10237.590496380062;10257;9836.11474967242;9850.950745246371;10042.748931276776;10060.496975151213;10158.238132140119;7754.030746156844;7781.805454863674;7897.881531777028;7906.090799558009;7930.563818990011;4564.726116433025;5437.374701909331;5460.989716902386;5581.776728930798;5628.268325117709;8980.101989800967;9144.320803703478;9277.072292770668;9292.674756383494;9434.198093162158;9296.116868897443;9507.714768556954;9577.616895324109;9614.375065620992;9617.951910240685;6205.110617379814;7218.602976836324;7246.1666908306215;7347.375473084848;7351.926480735338;7761.611919403895;7802.336801371947;7880.802979925318;7888.7633370998965;7892.526448413114;7055.4708396871465;7205.315495027964;7262.9273707262255;7269.781906542812;7395.075615548057;7068.823279418056;7103.242957991985;7110.644467776487;7118.323759242864;7156.427485801019;6283.937160628518;6356.269029061532;6458.838529036811;6463.095166676763;6472.482201423969;4925.6305777066145;4992.600591952708;4994.850154495371;5068.315777370008;5076.137056700296;4751.904961900812;4914.975425122851;4974.32846565709;5006.199008158677;5182.922256166236 07:50:40 INFO - PROCESS | 1642 | |4;prototype.html;358.8743939621131;366.9394549899267;374.16934405619514;378.6743400675419;385.26991351389137;4715.575598196162;5076.771545280462;5147.459516750734;5252.896891652753;5327.12102503087;5368.543673787733;5375.301210842595;5379.731013449332;5392.56859451244;5426.348838139419;3508.5263489428985;3584.229390681003;3760.9435858462143;3920.411938209263;4241.109367032919;3290.572225610679;4079.6124368184974;4085.2238074765846;4129.728649242905;4154.273002224613;3577.8211089445554;3788.78758797185;3899.688024958011;4118.279301122307;4122.752634841904;3741.28915506053;3840.7311488195837;4153.1518474278955;4159.604837540429;4179.241700477701;3569.8929032129076;3668.4680721295263;3672.559292884871;3705.481232627434;3726.832292546842;4112.334504525672;4137.951713901608;4572.862814115582;5035.791410061559;5221.477852214748;3936.409538569209;4409.574733896344;4819.542143496362;4826.372571565674;4854.004928989584;4446.909952322436;4494.775261236925;4686.859394218179;5414.186247607056;5504.284443022421;3847.0956876346386;3874.2832575973534;3879.3405121129194;3880.165764360676;3887.844486220576;5080.13637681595;5681.659100453986;5782.306123265193;5786.739596718157;5804.245448091763;4083.8570650027104;4122.711410201257;4182.665386769051;4190.700882726364;4205.852795152155;3655.707543396575;4296.2696341621995;4301.591348821857;4307.978460107679;4315.482142142963;3600.8199590020395;3993.5008123984503;4565.680402371802;4831.284893862628;4904.2643603459055;4755.5719985201495;5689.378527119834;5702.914456283159;5712.6286791358425;5740.421384119317;1201.1771936223715;1390.7900126889672;1401.4324198699544;1405.4097279142784;1419.666378401075;826.349602968489;950.5484894675112;994.6966175316453;1000.9740016483163;1006.1498034161123;4249.171411574714;4879.414470263591;4937.481884239064;5048.434985154614;5135.204043373208;4595.080983803253;4810.95189048105;5137.614678899097;5474.562035037187;5580.693061881636;4085.428040074392;4376.708870883097;4463.509014008457;5100.821471248562;5154.845354639367;2508.519973215775;2862.327353072026;2911.213972227529;2920.4013177298602;2943.6909124542044;5147.382314122255;5233.450487698737;5593;5689.0328644130595;5820.912686309709;4954.20732682769;5559.833205003856;5704.833817231393;5905.379935106752;6011.368806275365;5999.850003749942;6020.488258498077;6051.122587224828;6056.757729690851;6065.696715164224;4835.371401717754;4912.312276281395;5091.414487334004;5566.860828479321;5829.795957141479;4588.908221835478;4893.975530122327;5709.429057094258;5764.42355764437;5773.91339129905;5725.456081672234;5866.853328666817;5898.519873274789;5922.674252916131;6018.849528761816;3300.9834950825093;3888.775035863694;3914.2758589661003;3918.451416801593;3939.2318497892634;5633.239712540907;5686.658800471985;5811.418858114154;5820.650760954356;5821.621594596338;5236.711980841091;5244.42311345744;5267.920076384408;5608.6073974821375;5645.9153112702525;4358.4769827620885;4828.696252012008;5191.065608190562;5643.604947653625;5664.546836253007;5338.97330513345;5342;5495;5541.33503979525;5567.610267281413;4929.778159982881;5658.688772117573;5674.205611214351;5676.1969480449025;5677.523843800559;4678.953210467852;4970.353853998957;5571.462121552762;5582.581306401955;5584 07:50:40 INFO - PROCESS | 1642 | |5;yui.html;635.961842289463;774.825664225549;795.2047952047952;860.1871231686057;880.5201165364873;12876.098673092876;15179;15429.151396673178;15678.372865085383;15689.607759805996;14287.71424571508;14460.060096093774;14464.059836110646;14464.987450878443;14477.986540942138;706.8197609609542;727.9636018199095;732.827785470414;890.3678388344283;901.0178904993555;874.0865795243985;898.5641963647626;902.5442151713409;905.7645012296817;907.314977192219;966.0339660339661;966.8211380894522;967.6274634265787;968.1963969904997;969.5152423788106;961.1397798969953;961.4663861556833;963.1379914976127;963.657901444984;965.5654955270156;717.103620474407;718.5006420537728;719.1154879498195;719.2160545005917;720.200577359131;15390.307436165287;15715.528534143994;15763.290651920692;15768.211589420598;15986.600334991603;13812.585622431243;14183.716325673531;14194.929025354808;14212.85787142136;14216.431342746278;11355.981329895169;11656.358900260482;11686.590969316034;11920.582779602672;11942.077941432139;3784.299904517673;3797.7911214883447;3990.2618015666903;4044.1102957349335;4048.5748996355255;76006;101826;105339;105478;107674.99999999921;10610.504130670357;11173.664790056311;11320.207585468937;11833.053355731521;12001.399930003465;21685.457863553223;22430.55138897213;23611.29166125019;23855.284341469785;24091.638625420634;8085.919140808634;8149.185081491803;8150.510969341858;8210.835783284301;8323.625436855356;3604.7296452766145;3835.8657446989223;4403.339499075164;4447.573959769076;4512.210363186495;3669.9816500917323;3766.9246615067545;3774.7168962327937;3782.432635104756;3784.299904517673;657.7303305644663;663.2074670768385;668.8361351468922;680.6868840333403;685.7702669605638;586.9706514674249;593.4273426143792;603.499095750526;607.2439812433548;616.3189675408698;8965.775855603662;9098.681546145985;9958.850617240747;10527.578896844194;10961.177911656658;680.8059702984625;696.3837004251172;700.8107810891031;725.5936675461759;725.7097161135588;4762.833300834454;4981.975090124526;5078.289039534468;5091.770870310845;5099.719515426687;77859.22140778633;88556.50261204263;93518.53240733752;95293.52353238189;97626;70333.2966670337;78322.6083869577;81055;82881.3423731522;83742.16257837343;69326.65336673285;70795.58408831795;72548.63725681338;74318.62840685762;76694;10686.57253709874;11060.39167845744;11252.549898004316;11381.487833047368;11492.48283827213;47101;50155.74922125366;51390;52004.739976299876;52431.73784131055;71518.64240678764;74351.8847217303;78586.2848229108;80519.59740201262;83991;12924.741505170032;13976.794555988925;14282.143071415749;14450.277486125862;14510.056846304957;15307.693846122793;15495.612609684847;15576.22118894028;15618.297176627306;15837;14044.368003440075;14295.57113286603;14650.047746896418;14893.702125957203;15095.1118831205;14250.857491424953;14648.19434931089;14700.70598588001;14847.554573362817;14963.378942520418;12248;13021.218726876417;14385;14402.85597144015;14534.418623254951;10914.890851091388;11428.71428214268;11445.427728613702;11454;11681.532738690357;9501.382410143318;10161.745956351151;11660.766784664429;11736.589219377282;11970.76058478843 07:50:40 INFO - PROCESS | 1642 | __end_tp_report 07:50:40 INFO - PROCESS | 1642 | __start_cc_report 07:50:40 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,1866 07:50:40 INFO - PROCESS | 1642 | __end_cc_report 07:50:40 INFO - PROCESS | 1642 | __startTimestamp1490367040393__endTimestamp 07:50:40 INFO - PROCESS | 1642 | 07:50:40 INFO - PROCESS | 1642 | ------- Summary: start ------- 07:50:40 INFO - PROCESS | 1642 | Number of tests: 6 07:50:40 INFO - PROCESS | 1642 | 07:50:40 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5947.08 Median:6206.97 stddev:647.91 (10.4%) stddev-sans-first:620.77 07:50:40 INFO - PROCESS | 1642 | Values: 3498.7 3508.5 3514.3 3536.5 3560.7 6011.5 6013.2 6014.8 6031.1 6037.2 5942.6 6000.1 6012.0 6012.6 6016.1 5318.9 5331.2 5352.3 5362.0 5467.5 5362.6 5374.3 5383.8 5416.1 5493.1 5363.2 5393.3 5462.5 5474.8 5481.6 5434.9 5448.0 5451.5 5466.6 5472.1 5289.7 5392.9 5410.7 5422.1 5498.3 5928.7 5946.3 5954.4 5958.6 5989.6 6335.7 6338.4 6355.4 6358.7 6361.9 6411.1 6448.9 6458.4 6464.7 6466.2 6006.1 6006.7 6145.3 6164.4 6167.6 6433.1 6480.7 6505.3 6537.2 6558.5 6269.2 6288.5 6296.9 6306.8 6319.0 6357.6 6436.8 6457.4 6467.5 6473.3 6193.0 6212.6 6233.6 6249.4 6315.4 6316.4 6329.2 6345.8 6351.9 6371.6 4426.8 5186.5 5190.0 5192.3 5194.2 4569.5 4604.7 4606.4 4614.6 4650.7 6083.2 6122.8 6130.2 6135.4 6143.5 6325.7 6334.0 6336.4 6337.0 6339.1 6093.7 6111.1 6114.3 6130.6 6182.4 4833.9 5711.0 5711.2 5721.3 5725.1 6639.9 6647.5 6650.2 6659.9 6662.9 6225.6 6264.2 6311.5 6337.4 6456.0 6485.2 6567.2 6595.7 6643.0 6643.1 6279.7 6310.3 6314.4 6320.7 6332.1 6315.1 6416.3 6431.6 6435.2 6444.0 5271.8 6141.3 6180.8 6223.2 6247.9 6223.9 6232.4 6241.3 6247.4 6256.2 6195.9 6225.0 6242.7 6251.2 6256.5 6145.3 6202.5 6214.5 6223.2 6243.9 6207.0 6216.8 6224.5 6245.4 6253.6 07:50:40 INFO - PROCESS | 1642 | 07:50:40 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:78132.72 Median:36680.13 stddev:181947.29 (496.0%) stddev-sans-first:182364.39 07:50:40 INFO - PROCESS | 1642 | Values: 523.9 532.9 538.3 539.6 556.0 26219.0 41644.6 42929.8 42988.6 44590.0 43625.6 44034.8 44071.8 44094.0 44157.1 9332.2 9536.6 9545.2 9553.4 9561.0 8930.9 9116.5 11526.5 11705.6 11746.8 11645.5 11707.5 11714.6 11714.6 11715.5 11548.1 11623.9 11625.0 11635.7 11643.8 11455.9 11559.9 11564.5 11564.9 11574.3 41708.6 41963.8 41990.0 42066.4 42127.6 4078.5 4120.8 4127.5 4131.9 4162.8 30746.8 31432.0 31569.5 32197.5 33111.0 3273.0 3333.4 3436.3 3512.6 3513.7 500424.0 504590.0 505607.0 505801.0 506362.0 65941.0 66380.7 66424.7 66562.0 66577.0 68973.3 68989.0 69000.3 69045.3 69128.6 17547.6 17850.4 17850.7 17872.1 17888.4 12505.9 13571.9 13674.9 13711.3 13723.7 14269.3 15766.9 16183.1 18195.0 18229.9 6345.0 6412.5 6667.3 7598.4 7665.4 775.9 892.2 932.0 943.8 948.7 31108.7 31184.4 31304.1 31785.0 31961.4 1103.3 1124.9 1145.1 1145.9 1231.8 15988.5 16360.3 16365.4 16374.6 16840.0 709485.5 885682.0 887917.0 888227.0 892040.0 50245.7 50734.7 50768.2 56548.0 56994.7 1461.9 1484.3 1506.6 1509.0 1512.5 29116.3 29700.3 29950.0 30374.4 30450.8 49714.8 53185.0 54084.7 54132.5 56675.4 610251.9 615019.0 616330.0 621027.0 639554.0 25892.1 26080.5 26410.7 26519.0 26801.9 43553.0 43610.1 43645.1 44346.8 44666.0 36375.6 36470.5 36622.6 38172.0 38259.0 36290.0 36328.6 36429.9 37657.2 37758.4 36302.3 36737.6 36889.1 37146.4 37175.8 29923.7 32052.0 32436.4 32484.9 32625.0 19558.2 24259.0 24319.3 24370.0 24687.9 07:50:40 INFO - PROCESS | 1642 | 07:50:40 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:41004.41 Median:21981.12 stddev:129595.18 (589.6%) stddev-sans-first:129922.87 07:50:40 INFO - PROCESS | 1642 | Values: 402.5 407.9 413.3 418.7 440.6 20126.8 20260.5 20798.6 21332.5 21339.1 17832.8 17902.6 17944.6 21597.8 22416.7 5831.2 6035.5 6078.2 6084.9 6090.6 5687.3 5801.5 5894.1 5897.4 5913.3 5934.6 5941.0 5941.3 5953.1 5955.1 5664.6 5853.6 5921.7 5931.4 5939.4 5212.9 5216.9 5218.6 5226.6 5227.5 26578.6 26696.3 26783.6 26824.6 27021.5 2824.4 2846.8 2849.1 2852.1 2855.2 15266.3 15949.4 15993.9 16239.3 16654.9 1846.8 1858.2 1876.8 1894.9 1906.9 127269.0 127312.0 127812.0 131257.0 132661.7 9587.9 11478.8 11503.3 11516.0 11607.4 14862.9 14873.6 14884.3 14893.9 14903.6 8869.8 9009.2 9034.4 9035.9 9167.4 9043.4 9056.9 9070.7 9223.0 9246.7 5875.0 7038.7 7118.7 7153.4 7159.7 1683.2 1872.7 1957.5 2008.4 2011.2 981.6 1068.4 1083.8 1089.7 1092.0 21526.0 22290.9 22883.7 22991.0 23044.5 872.0 1076.4 1083.4 1127.1 1133.4 11115.6 12014.5 12046.5 12111.5 12212.5 778867.0 780967.0 781411.0 788760.2 796508.0 101373.5 108466.0 114390.3 120412.0 135331.3 977.8 1034.5 1077.3 1078.3 1078.8 20891.0 21154.0 21241.0 21348.6 21671.3 57667.1 57946.7 58678.0 59421.0 60755.7 79841.6 81349.3 82590.2 83690.2 84465.0 5847.0 6984.0 7380.7 7967.0 8267.3 12910.2 13382.5 13450.5 14104.3 14138.8 11220.4 11491.8 11859.8 11868.0 12019.2 11159.3 11463.9 11847.8 11992.0 12019.1 11392.5 11485.7 11536.4 12019.3 12162.5 7183.0 7465.4 8347.8 8569.2 8975.7 10193.2 11059.8 11166.9 11730.1 12078.4 07:50:40 INFO - PROCESS | 1642 | 07:50:40 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5468.99 Median:5339.21 stddev:3009.97 (56.4%) stddev-sans-first:3001.38 07:50:40 INFO - PROCESS | 1642 | Values: 1207.7 1275.9 1462.1 1475.0 1477.3 8103.3 8500.4 8521.6 8521.8 8523.2 7548.9 7794.6 7804.6 8132.8 8383.7 1969.4 2327.4 2395.0 2401.7 2402.6 2365.5 2405.4 2417.7 2417.8 2431.1 1833.4 2109.5 2295.9 2356.0 2363.5 2360.9 2374.1 2376.8 2377.8 2378.1 1952.4 2326.6 2376.6 2377.9 2413.1 8484.9 8541.4 8545.4 8559.0 8574.1 4931.8 5333.3 5338.2 5345.1 5381.7 3093.5 3374.3 3547.3 3577.2 3622.1 1232.8 1238.0 1246.6 1258.7 1312.2 10896.1 10909.1 10911.6 10935.0 10958.9 4112.2 4585.3 4655.3 4794.5 4822.7 9650.7 9663.2 9664.9 9669.3 9675.6 5340.2 5344.1 5349.1 5349.3 5352.9 4699.4 4854.3 4877.2 4941.2 4942.4 3848.2 3933.6 3950.3 3995.3 4015.2 1289.8 1296.1 1301.1 1310.1 1312.0 779.4 787.8 807.1 813.8 814.8 5456.4 5492.1 5542.5 5620.2 5672.0 569.4 593.9 602.5 603.8 606.2 3649.6 3675.8 3757.2 3800.6 3824.6 9814.0 10228.7 10230.9 10237.6 10257.0 9836.1 9851.0 10042.7 10060.5 10158.2 7754.0 7781.8 7897.9 7906.1 7930.6 4564.7 5437.4 5461.0 5581.8 5628.3 8980.1 9144.3 9277.1 9292.7 9434.2 9296.1 9507.7 9577.6 9614.4 9618.0 6205.1 7218.6 7246.2 7347.4 7351.9 7761.6 7802.3 7880.8 7888.8 7892.5 7055.5 7205.3 7262.9 7269.8 7395.1 7068.8 7103.2 7110.6 7118.3 7156.4 6283.9 6356.3 6458.8 6463.1 6472.5 4925.6 4992.6 4994.9 5068.3 5076.1 4751.9 4915.0 4974.3 5006.2 5182.9 07:50:40 INFO - PROCESS | 1642 | 07:50:40 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4493.56 Median:4886.70 stddev:1356.22 (27.8%) stddev-sans-first:1324.04 07:50:40 INFO - PROCESS | 1642 | Values: 358.9 366.9 374.2 378.7 385.3 4715.6 5076.8 5147.5 5252.9 5327.1 5368.5 5375.3 5379.7 5392.6 5426.3 3508.5 3584.2 3760.9 3920.4 4241.1 3290.6 4079.6 4085.2 4129.7 4154.3 3577.8 3788.8 3899.7 4118.3 4122.8 3741.3 3840.7 4153.2 4159.6 4179.2 3569.9 3668.5 3672.6 3705.5 3726.8 4112.3 4138.0 4572.9 5035.8 5221.5 3936.4 4409.6 4819.5 4826.4 4854.0 4446.9 4494.8 4686.9 5414.2 5504.3 3847.1 3874.3 3879.3 3880.2 3887.8 5080.1 5681.7 5782.3 5786.7 5804.2 4083.9 4122.7 4182.7 4190.7 4205.9 3655.7 4296.3 4301.6 4308.0 4315.5 3600.8 3993.5 4565.7 4831.3 4904.3 4755.6 5689.4 5702.9 5712.6 5740.4 1201.2 1390.8 1401.4 1405.4 1419.7 826.3 950.5 994.7 1001.0 1006.1 4249.2 4879.4 4937.5 5048.4 5135.2 4595.1 4811.0 5137.6 5474.6 5580.7 4085.4 4376.7 4463.5 5100.8 5154.8 2508.5 2862.3 2911.2 2920.4 2943.7 5147.4 5233.5 5593.0 5689.0 5820.9 4954.2 5559.8 5704.8 5905.4 6011.4 5999.9 6020.5 6051.1 6056.8 6065.7 4835.4 4912.3 5091.4 5566.9 5829.8 4588.9 4894.0 5709.4 5764.4 5773.9 5725.5 5866.9 5898.5 5922.7 6018.8 3301.0 3888.8 3914.3 3918.5 3939.2 5633.2 5686.7 5811.4 5820.7 5821.6 5236.7 5244.4 5267.9 5608.6 5645.9 4358.5 4828.7 5191.1 5643.6 5664.5 5339.0 5342.0 5495.0 5541.3 5567.6 4929.8 5658.7 5674.2 5676.2 5677.5 4679.0 4970.4 5571.5 5582.6 5584.0 07:50:40 INFO - PROCESS | 1642 | 07:50:40 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:20109.39 Median:4046.34 stddev:27609.03 (682.3%) stddev-sans-first:27647.76 07:50:40 INFO - PROCESS | 1642 | Values: 636.0 774.8 795.2 860.2 880.5 12876.1 15179.0 15429.2 15678.4 15689.6 14287.7 14460.1 14464.1 14465.0 14478.0 706.8 728.0 732.8 890.4 901.0 874.1 898.6 902.5 905.8 907.3 966.0 966.8 967.6 968.2 969.5 961.1 961.5 963.1 963.7 965.6 717.1 718.5 719.1 719.2 720.2 15390.3 15715.5 15763.3 15768.2 15986.6 13812.6 14183.7 14194.9 14212.9 14216.4 11356.0 11656.4 11686.6 11920.6 11942.1 3784.3 3797.8 3990.3 4044.1 4048.6 76006.0 101826.0 105339.0 105478.0 107675.0 10610.5 11173.7 11320.2 11833.1 12001.4 21685.5 22430.6 23611.3 23855.3 24091.6 8085.9 8149.2 8150.5 8210.8 8323.6 3604.7 3835.9 4403.3 4447.6 4512.2 3670.0 3766.9 3774.7 3782.4 3784.3 657.7 663.2 668.8 680.7 685.8 587.0 593.4 603.5 607.2 616.3 8965.8 9098.7 9958.9 10527.6 10961.2 680.8 696.4 700.8 725.6 725.7 4762.8 4982.0 5078.3 5091.8 5099.7 77859.2 88556.5 93518.5 95293.5 97626.0 70333.3 78322.6 81055.0 82881.3 83742.2 69326.7 70795.6 72548.6 74318.6 76694.0 10686.6 11060.4 11252.5 11381.5 11492.5 47101.0 50155.7 51390.0 52004.7 52431.7 71518.6 74351.9 78586.3 80519.6 83991.0 12924.7 13976.8 14282.1 14450.3 14510.1 15307.7 15495.6 15576.2 15618.3 15837.0 14044.4 14295.6 14650.0 14893.7 15095.1 14250.9 14648.2 14700.7 14847.6 14963.4 12248.0 13021.2 14385.0 14402.9 14534.4 10914.9 11428.7 11445.4 11454.0 11681.5 9501.4 10161.7 11660.8 11736.6 11970.8 07:50:40 INFO - PROCESS | 1642 | -------- Summary: end -------- 07:50:40 INFO - PROCESS | 1642 | 07:50:40 INFO - TEST-INFO | 1642: exit 0 07:50:40 INFO - TEST-OK | dromaeo_css | took 1117550ms 07:50:40 INFO - TEST-START | kraken 07:50:40 INFO - operating with platform_type : mac_ 07:50:40 INFO - Initialising browser for kraken test... 07:50:41 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/tmpvCiIUQ/profile http://localhost:49243/getInfo.html) 07:50:43 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 07:50:43 INFO - PROCESS | 1651 | colorDepth:24 07:50:43 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 07:50:43 INFO - PROCESS | 1651 | __metrics 07:50:43 INFO - PROCESS | 1651 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:50:43 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:50:43 INFO - TEST-INFO | 1651: exit 0 07:50:43 INFO - Browser initialized. 07:50:43 INFO - Running cycle 1/1 for kraken test... 07:50:43 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/tmpvCiIUQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:50:55 INFO - PROCESS | 1653 | RSS: Main: 163229696 07:50:55 INFO - PROCESS | 1653 | 07:50:58 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 07:50:59 INFO - PROCESS | 1653 | RSS: Main: 213331968 07:50:59 INFO - PROCESS | 1653 | 07:51:02 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 07:51:02 INFO - PROCESS | 1653 | RSS: Main: 228835328 07:51:02 INFO - PROCESS | 1653 | 07:51:05 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 07:51:06 INFO - PROCESS | 1653 | RSS: Main: 325791744 07:51:06 INFO - PROCESS | 1653 | 07:51:08 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 07:51:09 INFO - PROCESS | 1653 | RSS: Main: 228831232 07:51:09 INFO - PROCESS | 1653 | 07:51:10 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:51:11 INFO - PROCESS | 1653 | RSS: Main: 231337984 07:51:11 INFO - PROCESS | 1653 | 07:51:14 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 07:51:14 INFO - PROCESS | 1653 | RSS: Main: 271261696 07:51:14 INFO - PROCESS | 1653 | 07:51:17 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 07:51:18 INFO - PROCESS | 1653 | RSS: Main: 270139392 07:51:18 INFO - PROCESS | 1653 | 07:51:21 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 07:51:21 INFO - PROCESS | 1653 | RSS: Main: 268435456 07:51:21 INFO - PROCESS | 1653 | 07:51:23 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:51:24 INFO - PROCESS | 1653 | RSS: Main: 243793920 07:51:24 INFO - PROCESS | 1653 | 07:51:26 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:51:26 INFO - PROCESS | 1653 | RSS: Main: 247926784 07:51:26 INFO - PROCESS | 1653 | 07:51:29 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:51:29 INFO - PROCESS | 1653 | RSS: Main: 249229312 07:51:29 INFO - PROCESS | 1653 | 07:51:32 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:51:33 INFO - PROCESS | 1653 | RSS: Main: 267718656 07:51:33 INFO - PROCESS | 1653 | 07:51:36 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:51:36 INFO - PROCESS | 1653 | RSS: Main: 261451776 07:51:36 INFO - PROCESS | 1653 | 07:51:38 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 07:51:38 INFO - PROCESS | 1653 | RSS: Main: 306176000 07:51:38 INFO - PROCESS | 1653 | 07:51:38 INFO - PROCESS | 1653 | __start_tp_report 07:51:38 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 07:51:38 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 07:51:38 INFO - PROCESS | 1653 | |i|pagename|runs| 07:51:38 INFO - PROCESS | 1653 | |0;ai-astar;103;113;114;113;113;113;113;113;112;113 07:51:38 INFO - PROCESS | 1653 | |1;audio-beat-detection;165;141;140;145;110;109;108;125;160;109 07:51:38 INFO - PROCESS | 1653 | |2;audio-dft;181;181;182;183;182;183;182;183;183;183 07:51:38 INFO - PROCESS | 1653 | |3;audio-fft;80;59;59;89;59;62;72;82;97;64 07:51:38 INFO - PROCESS | 1653 | |4;audio-oscillator;89;66;84;68;67;69;80;66;68;81 07:51:38 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;87;85;87;84;86;84;87;89;134;85 07:51:38 INFO - PROCESS | 1653 | |6;imaging-darkroom;93;94;92;92;93;93;93;92;93;93 07:51:38 INFO - PROCESS | 1653 | |7;imaging-desaturate;86;84;85;86;85;85;96;130;86;84 07:51:38 INFO - PROCESS | 1653 | |8;json-parse-financial;53;50;53;53;55;55;57;57;56;54 07:51:38 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;64;78;79;73;77;100;100;99;82;69 07:51:38 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;83;85;91;102;79;85;104;102;103;77 07:51:38 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;153;168;147;146;134;135;136;153;173;133 07:51:38 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;165;232;200;170;162;163;162;163;164;160 07:51:38 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;66;65;64;65;63;64;65;63;63;65 07:51:38 INFO - PROCESS | 1653 | __end_tp_report 07:51:38 INFO - PROCESS | 1653 | __start_cc_report 07:51:38 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1947 07:51:38 INFO - PROCESS | 1653 | __end_cc_report 07:51:38 INFO - PROCESS | 1653 | __startTimestamp1490367098797__endTimestamp 07:51:38 INFO - PROCESS | 1653 | 07:51:38 INFO - PROCESS | 1653 | ------- Summary: start ------- 07:51:38 INFO - PROCESS | 1653 | Number of tests: 14 07:51:38 INFO - PROCESS | 1653 | 07:51:38 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:3.20 (2.8%) stddev-sans-first:0.50 07:51:38 INFO - PROCESS | 1653 | Values: 103.0 113.0 114.0 113.0 113.0 113.0 113.0 113.0 112.0 113.0 07:51:38 INFO - PROCESS | 1653 | 07:51:38 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:131.20 Median:140.50 stddev:21.98 (15.6%) stddev-sans-first:19.62 07:51:38 INFO - PROCESS | 1653 | Values: 165.0 141.0 140.0 145.0 110.0 109.0 108.0 125.0 160.0 109.0 07:51:38 INFO - PROCESS | 1653 | 07:51:38 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:182.30 Median:183.00 stddev:0.82 (0.4%) stddev-sans-first:0.73 07:51:38 INFO - PROCESS | 1653 | Values: 181.0 181.0 182.0 183.0 182.0 183.0 182.0 183.0 183.0 183.0 07:51:38 INFO - PROCESS | 1653 | 07:51:38 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:72.30 Median:76.00 stddev:13.94 (18.3%) stddev-sans-first:14.50 07:51:38 INFO - PROCESS | 1653 | Values: 80.0 59.0 59.0 89.0 59.0 62.0 72.0 82.0 97.0 64.0 07:51:38 INFO - PROCESS | 1653 | 07:51:38 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:73.80 Median:74.50 stddev:8.72 (11.7%) stddev-sans-first:7.30 07:51:38 INFO - PROCESS | 1653 | Values: 89.0 66.0 84.0 68.0 67.0 69.0 80.0 66.0 68.0 81.0 07:51:38 INFO - PROCESS | 1653 | 07:51:38 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:90.80 Median:86.50 stddev:15.26 (17.6%) stddev-sans-first:16.12 07:51:38 INFO - PROCESS | 1653 | Values: 87.0 85.0 87.0 84.0 86.0 84.0 87.0 89.0 134.0 85.0 07:51:38 INFO - PROCESS | 1653 | 07:51:38 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:92.80 Median:93.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 07:51:38 INFO - PROCESS | 1653 | Values: 93.0 94.0 92.0 92.0 93.0 93.0 93.0 92.0 93.0 93.0 07:51:38 INFO - PROCESS | 1653 | 07:51:38 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:90.70 Median:85.50 stddev:14.24 (16.7%) stddev-sans-first:15.01 07:51:38 INFO - PROCESS | 1653 | Values: 86.0 84.0 85.0 86.0 85.0 85.0 96.0 130.0 86.0 84.0 07:51:38 INFO - PROCESS | 1653 | 07:51:38 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:55.00 stddev:2.16 (3.9%) stddev-sans-first:2.24 07:51:38 INFO - PROCESS | 1653 | Values: 53.0 50.0 53.0 53.0 55.0 55.0 57.0 57.0 56.0 54.0 07:51:38 INFO - PROCESS | 1653 | 07:51:38 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:82.10 Median:77.50 stddev:13.17 (17.0%) stddev-sans-first:12.23 07:51:38 INFO - PROCESS | 1653 | Values: 64.0 78.0 79.0 73.0 77.0 100.0 100.0 99.0 82.0 69.0 07:51:38 INFO - PROCESS | 1653 | 07:51:38 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:91.10 Median:81.00 stddev:10.70 (13.2%) stddev-sans-first:10.94 07:51:38 INFO - PROCESS | 1653 | Values: 83.0 85.0 91.0 102.0 79.0 85.0 104.0 102.0 103.0 77.0 07:51:38 INFO - PROCESS | 1653 | 07:51:38 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:147.80 Median:150.00 stddev:14.20 (9.5%) stddev-sans-first:14.93 07:51:38 INFO - PROCESS | 1653 | Values: 153.0 168.0 147.0 146.0 134.0 135.0 136.0 153.0 173.0 133.0 07:51:38 INFO - PROCESS | 1653 | 07:51:38 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.10 Median:164.50 stddev:23.48 (14.3%) stddev-sans-first:24.68 07:51:38 INFO - PROCESS | 1653 | Values: 165.0 232.0 200.0 170.0 162.0 163.0 162.0 163.0 164.0 160.0 07:51:38 INFO - PROCESS | 1653 | 07:51:38 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:65.00 stddev:1.06 (1.6%) stddev-sans-first:0.93 07:51:38 INFO - PROCESS | 1653 | Values: 66.0 65.0 64.0 65.0 63.0 64.0 65.0 63.0 63.0 65.0 07:51:38 INFO - PROCESS | 1653 | -------- Summary: end -------- 07:51:38 INFO - PROCESS | 1653 | 07:51:39 INFO - TEST-INFO | 1653: exit 0 07:51:39 INFO - TEST-OK | kraken | took 58756ms 07:51:39 INFO - SUITE-END | took 1176s 07:51:39 INFO - Completed test suite (00:19:36) 07:51:39 INFO - javascript benchmark 07:51:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3498.6676265754745, 3508.5088087667723, 3514.2620049789543, 3536.487209354645, 3560.697340726038, 6011.458968692817, 6013.188219590354, 6014.789482368118, 6031.0953356996415, 6037.245344331958, 5942.554308426864, 6000.129981152731, 6011.969940150293, 6012.60918040327, 6016.067509536029, 5318.867028324294, 5331.2269720890645, 5352.304200453936, 5362.008028514718, 5467.480589344026, 5362.570994320465, 5374.274472946161, 5383.784648614051, 5416.133418653017, 5493.093639549469, 5363.222332761748, 5393.298871146745, 5462.481064298885, 5474.753636086366, 5481.616286859921, 5434.864128396782, 5448.0, 5451.454854514556, 5466.644668096601, 5472.097103977839, 5289.709066001368, 5392.91910621341, 5410.729463526808, 5422.078246698071, 5498.3127109111365, 5928.703564821785, 5946.256717910262, 5954.434328738763, 5958.642481451084, 5989.64062156272, 6335.651539165344, 6338.429541341256, 6355.428011478989, 6358.650274234915, 6361.936380636181, 6411.1024456576115, 6448.93551064488, 6458.418742313214, 6464.709088091, 6466.159399278064, 6006.069059295816, 6006.699665016776, 6145.324014358417, 6164.445199931983, 6167.599106058092, 6433.131527243762, 6480.708368123445, 6505.284418713938, 6537.248216455168, 6558.475321974231, 6269.216347956505, 6288.465480434214, 6296.937030629727, 6306.779262725874, 6318.988961766096, 6357.618542887441, 6436.774712885027, 6457.3865482779065, 6467.51493637979, 6473.28793832678, 6193.040078787705, 6212.627242365473, 6233.594816336924, 6249.437550620466, 6315.36846315374, 6316.399942005502, 6329.208848893888, 6345.777897773648, 6351.936480635227, 6371.585846919936, 4426.75652839097, 5186.507281808223, 5189.974050129801, 5192.299039629677, 5194.246834209094, 4569.520200378979, 4604.677672562955, 4606.424196975378, 4614.584687378085, 4650.697704649187, 6083.239595050619, 6122.785702500391, 6130.2030736004035, 6135.386461353829, 6143.508519318444, 6325.746970121144, 6334.049892516159, 6336.398042185985, 6337.0, 6339.11252424661, 6093.664848433379, 6111.13596929516, 6114.2662880453745, 6130.581587307925, 6182.412670796267, 4833.854984350475, 5711.0, 5711.200431939532, 5721.313442386857, 5725.083986562214, 6639.933600663931, 6647.534672572873, 6650.20197576294, 6659.933400665931, 6662.900056499059, 6225.564210505221, 6264.185655864709, 6311.526635502448, 6337.429631333202, 6456.031595260749, 6485.221773387224, 6567.211934567882, 6595.703193356215, 6643.0, 6643.069970204078, 6279.654618995999, 6310.305866354789, 6314.368563143649, 6320.715567799368, 6332.0818481320875, 6315.052742088724, 6416.262129855127, 6431.5819471734185, 6435.163428754232, 6444.0, 5271.7891284349735, 6141.332587233824, 6180.845478863064, 6223.159873417031, 6247.875042499216, 6223.937760622336, 6232.376762323732, 6241.344658810941, 6247.406496382836, 6256.217972753406, 6195.907061393992, 6224.968875155595, 6242.687865606792, 6251.187345645037, 6256.468200202851, 6145.293291271561, 6202.472789812736, 6214.471769899609, 6223.19098517208, 6243.906341404791, 6206.968965155145, 6216.751329946932, 6224.533160012927, 6245.437910588069, 6253.5622506424115], "value": 5906.342630469218, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [523.9240310155028, 532.8934213157368, 538.297521734137, 539.6303532080525, 556.018627123128, 26219.0, 41644.58355416445, 42929.78535107328, 42988.57011429885, 44590.0, 43625.563744362546, 44034.7798261009, 44071.77964110175, 44094.0, 44157.116857662826, 9332.160105590496, 9536.618535258582, 9545.236381089497, 9553.37903036304, 9561.0, 8930.910690893106, 9116.498592577405, 11526.538938442452, 11705.59030433935, 11746.823797643043, 11645.534178632844, 11707.53169873204, 11714.589989350374, 11714.648560543197, 11715.472803723853, 11548.133889958244, 11623.883761162364, 11625.011873990721, 11635.650930472098, 11643.76712465746, 11455.942720286428, 11559.94220028903, 11564.479598418091, 11564.94217528907, 11574.305541667527, 41708.58291417077, 41963.790181049204, 41990.0, 42066.369004464956, 42127.578724212675, 4078.5309689385804, 4120.773357465338, 4127.463429754142, 4131.938020929689, 4162.7502349859105, 30746.846265768527, 31432.0, 31569.526457103162, 32197.51703724446, 33111.00666979994, 3272.9836350818096, 3333.3666603345287, 3436.3127374525193, 3512.5609298837644, 3513.7013353864954, 500424.0, 504590.0, 505607.0, 505801.0, 506362.0, 65941.0, 66380.66809665921, 66424.67150657056, 66562.0, 66576.99999999903, 68973.3102668977, 68989.0, 69000.3099969004, 69045.30954690388, 69128.61742765116, 17547.64904701899, 17850.375236866646, 17850.732239016426, 17872.106394680213, 17888.373906913195, 12505.93747031259, 13571.864281357257, 13674.863251367358, 13711.314434278247, 13723.656908577166, 14269.286535673175, 15766.9211653941, 16183.10992895402, 18195.0, 18229.90885045593, 6345.0, 6412.5190610704385, 6667.299933507009, 7598.430117741192, 7665.425093118039, 775.9224077592196, 892.1881088209827, 931.9720408387759, 943.7675959837529, 948.7201275623707, 31108.688913110578, 31184.376312473625, 31304.060878173692, 31785.0, 31961.360772784414, 1103.2994048779083, 1124.876263611002, 1145.135422755814, 1145.9255148415327, 1231.8213858990396, 15988.520344389686, 16360.263788129325, 16365.427210047592, 16374.590635234214, 16840.0, 709485.4525727339, 885682.0, 887917.0, 888227.0, 892040.0, 50245.74877125591, 50734.7316317095, 50768.23847642214, 56548.0, 56994.71502642543, 1461.868431841118, 1484.3320505772447, 1506.6384067823644, 1508.9622759430883, 1512.470635277644, 29116.272093196993, 29700.25749356197, 29949.951751688586, 30374.392512149192, 30450.84774576113, 49714.75142624408, 53185.0, 54084.72957635186, 54132.458675412745, 56675.433245667016, 610251.8974810195, 615019.0, 616330.0, 621027.0, 639554.0, 25892.093776717724, 26080.478390432465, 26410.735892640827, 26519.0, 26801.86599066992, 43553.04011319435, 43610.11760276549, 43645.127097458506, 44346.77826610975, 44666.0, 36375.63624363722, 36470.452943205346, 36622.633773661924, 38172.0, 38259.0, 36290.0, 36328.63671363253, 36429.90710278696, 37657.24685506329, 37758.43362349622, 36302.3251180488, 36737.63262367449, 36889.077773054814, 37146.44280335851, 37175.81412093031, 29923.70076299209, 32052.03843884687, 32436.35127297488, 32484.863029793843, 32625.02124936256, 19558.21767129299, 24259.0, 24319.270421887373, 24370.0, 24687.876560617082], "value": 20793.86164388307, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.4506548561213, 407.8776367089873, 413.2870797873666, 418.7152736139425, 440.58364845221257, 20126.798732012692, 20260.493487662814, 20798.584028319423, 21332.4666883328, 21339.146434142614, 17832.821671783277, 17902.64194716105, 17944.55138621535, 21597.784022159773, 22416.66375004376, 5831.154482600021, 6035.517158627321, 6078.240219972504, 6084.878302433949, 6090.60411073281, 5687.2606561146995, 5801.47786699197, 5894.145348924403, 5897.439743224409, 5913.319968203668, 5934.614250073753, 5941.0494320908665, 5941.316748573904, 5953.077273022667, 5955.076963070731, 5664.575156863231, 5853.64878107315, 5921.73352199152, 5931.436513531229, 5939.376365481627, 5212.8957420851375, 5216.921746173811, 5218.608604354688, 5226.55574276187, 5227.477252274742, 26578.6013209802, 26696.332591685168, 26783.598246026326, 26824.59763103555, 27021.459570808474, 2824.4068745563454, 2846.8091228871, 2849.070868648289, 2852.0588205892213, 2855.163269680336, 15266.313015914311, 15949.441769538127, 15993.920030399773, 16239.269232884548, 16654.916725416297, 1846.7506886570409, 1858.1823997441084, 1876.8498520118358, 1894.8957807320592, 1906.8951207683572, 127269.0, 127312.0, 127812.0, 131257.0, 132661.6733832659, 9587.856182157273, 11478.827817582744, 11503.252288601214, 11515.963563279345, 11607.361595112181, 14862.851371486147, 14873.553793386216, 14884.330205140795, 14893.925530372278, 14903.552893413214, 8869.778255543662, 9009.23421509166, 9034.412763170372, 9035.864462033074, 9167.358284920125, 9043.412178208395, 9056.909430905607, 9070.727878163665, 9222.953885230665, 9246.676366327147, 5874.970625146932, 7038.683259253346, 7118.71525138999, 7153.391961683211, 7159.677814498256, 1683.2341284715426, 1872.7190921361905, 1957.5497635543904, 2008.4275981345247, 2011.195521791266, 981.5730157381562, 1068.4070340960686, 1083.815751322277, 1089.7330154112294, 1092.0, 21526.0, 22290.885455727148, 22883.656745148837, 22991.0, 23044.539109217723, 872.0320444306815, 1076.4294923690456, 1083.3932997521413, 1127.0926903842321, 1133.4332833583208, 11115.610953616746, 12014.459349329301, 12046.518139274505, 12111.515539378503, 12212.511499540096, 778867.0, 780967.0, 781411.0, 788760.2247955124, 796508.0, 101373.49313253534, 108466.0, 114390.28414573788, 120412.0, 135331.32334338265, 977.8093271812071, 1034.4827586206898, 1077.2889892670955, 1078.2937176149635, 1078.8058149533003, 20891.0, 21154.0, 21241.0, 21348.573028539653, 21671.34985950424, 57667.1349929743, 57946.710266450085, 58678.0, 59421.0, 60755.69622151861, 79841.60079199799, 81349.33927973374, 82590.17409825824, 83690.16309836824, 84465.0, 5846.9767790635615, 6984.022236886738, 7380.667869945758, 7967.0, 8267.29727973129, 12910.225386476466, 13382.531611393555, 13450.46198152063, 14104.294785260901, 14138.78791818144, 11220.438978050901, 11491.770164596828, 11859.822102668639, 11868.0, 12019.158658893793, 11159.330440173615, 11463.942680286546, 11847.76304473923, 11992.0, 12019.098567607289, 11392.544298227978, 11485.655430337103, 11536.365499897585, 12019.338936358585, 12162.513499459923, 7182.958471021777, 7465.365443937326, 8347.83304333922, 8569.228769410784, 8975.698523714156, 10193.184545236216, 11059.834102488308, 11166.944165279447, 11730.061595072202, 12078.396080196131], "value": 10256.075374808886, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1207.746373261615, 1275.9425825837839, 1462.0569732522524, 1474.97787533187, 1477.2909003678228, 8103.311218546423, 8500.447470914387, 8521.573921303941, 8521.829563408728, 8523.190296921783, 7548.92451075489, 7794.649240784164, 7804.570748608824, 8132.796680082986, 8383.748487545383, 1969.3698016634683, 2327.441414060626, 2395.0419832067137, 2401.6637670726027, 2402.5555272274596, 2365.515069410775, 2405.386626410263, 2417.685700858886, 2417.7703118203744, 2431.112643884987, 1833.431636192778, 2109.535902101535, 2295.908163673451, 2356.0222507659387, 2363.52729454109, 2360.9409764755846, 2374.062245413052, 2376.750441203666, 2377.7859992600575, 2378.143868207444, 1952.3654812186096, 2326.592846251899, 2376.6435034744754, 2377.857328560292, 2413.1433341163984, 8484.915150848536, 8541.402101852873, 8545.401821872472, 8558.957205213996, 8574.056853746082, 4931.827386041471, 5333.280007199017, 5338.225957236218, 5345.1447768356875, 5381.67709937405, 3093.5359696045775, 3374.3251349730153, 3547.3260080584605, 3577.2130131371055, 3622.130688634735, 1232.8212409200705, 1238.0343332200898, 1246.5551813036486, 1258.672745086275, 1312.1667740984449, 10896.073833724064, 10909.07272881806, 10911.618093366695, 10935.0, 10958.890411095947, 4112.198121366305, 4585.266357382803, 4655.301704744248, 4794.544518270759, 4822.662413631082, 9650.71047868565, 9663.226941844636, 9664.90335096654, 9669.323147379617, 9675.612975481043, 5340.198970154508, 5344.118220493575, 5349.063913815066, 5349.304590403222, 5352.8661783454945, 4699.436067671902, 4854.296127061627, 4877.170880950247, 4941.234108713155, 4942.382202224722, 3848.1726428817938, 3933.567307596162, 3950.2889479893897, 3995.2608767377546, 4015.2371049500503, 1289.8387701537308, 1296.0992110483312, 1301.076235872541, 1310.102579732886, 1312.0487646456243, 779.4154384211841, 787.7951732549578, 807.0839597057264, 813.8453693798159, 814.8166662501009, 5456.372517160498, 5492.093804522289, 5542.473465020817, 5620.18507316445, 5672.0, 569.3708452160304, 593.9287285525764, 602.4698265526309, 603.770567184467, 606.2058703098954, 3649.5620525537106, 3675.8162091895297, 3757.1546402059867, 3800.562935262425, 3824.6366595173413, 9813.950930245303, 10228.744281393025, 10230.897691022994, 10237.590496380062, 10257.0, 9836.11474967242, 9850.950745246371, 10042.748931276776, 10060.496975151213, 10158.238132140119, 7754.030746156844, 7781.805454863674, 7897.881531777028, 7906.090799558009, 7930.563818990011, 4564.726116433025, 5437.374701909331, 5460.989716902386, 5581.776728930798, 5628.268325117709, 8980.101989800967, 9144.320803703478, 9277.072292770668, 9292.674756383494, 9434.198093162158, 9296.116868897443, 9507.714768556954, 9577.616895324109, 9614.375065620992, 9617.951910240685, 6205.110617379814, 7218.602976836324, 7246.1666908306215, 7347.375473084848, 7351.926480735338, 7761.611919403895, 7802.336801371947, 7880.802979925318, 7888.7633370998965, 7892.526448413114, 7055.4708396871465, 7205.315495027964, 7262.9273707262255, 7269.781906542812, 7395.075615548057, 7068.823279418056, 7103.242957991985, 7110.644467776487, 7118.323759242864, 7156.427485801019, 6283.937160628518, 6356.269029061532, 6458.838529036811, 6463.095166676763, 6472.482201423969, 4925.6305777066145, 4992.600591952708, 4994.850154495371, 5068.315777370008, 5076.137056700296, 4751.904961900812, 4914.975425122851, 4974.32846565709, 5006.199008158677, 5182.922256166236], "value": 4385.687619528055, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.8743939621131, 366.9394549899267, 374.16934405619514, 378.6743400675419, 385.26991351389137, 4715.575598196162, 5076.771545280462, 5147.459516750734, 5252.896891652753, 5327.12102503087, 5368.543673787733, 5375.301210842595, 5379.731013449332, 5392.56859451244, 5426.348838139419, 3508.5263489428985, 3584.229390681003, 3760.9435858462143, 3920.411938209263, 4241.109367032919, 3290.572225610679, 4079.6124368184974, 4085.2238074765846, 4129.728649242905, 4154.273002224613, 3577.8211089445554, 3788.78758797185, 3899.688024958011, 4118.279301122307, 4122.752634841904, 3741.28915506053, 3840.7311488195837, 4153.1518474278955, 4159.604837540429, 4179.241700477701, 3569.8929032129076, 3668.4680721295263, 3672.559292884871, 3705.481232627434, 3726.832292546842, 4112.334504525672, 4137.951713901608, 4572.862814115582, 5035.791410061559, 5221.477852214748, 3936.409538569209, 4409.574733896344, 4819.542143496362, 4826.372571565674, 4854.004928989584, 4446.909952322436, 4494.775261236925, 4686.859394218179, 5414.186247607056, 5504.284443022421, 3847.0956876346386, 3874.2832575973534, 3879.3405121129194, 3880.165764360676, 3887.844486220576, 5080.13637681595, 5681.659100453986, 5782.306123265193, 5786.739596718157, 5804.245448091763, 4083.8570650027104, 4122.711410201257, 4182.665386769051, 4190.700882726364, 4205.852795152155, 3655.707543396575, 4296.2696341621995, 4301.591348821857, 4307.978460107679, 4315.482142142963, 3600.8199590020395, 3993.5008123984503, 4565.680402371802, 4831.284893862628, 4904.2643603459055, 4755.5719985201495, 5689.378527119834, 5702.914456283159, 5712.6286791358425, 5740.421384119317, 1201.1771936223715, 1390.7900126889672, 1401.4324198699544, 1405.4097279142784, 1419.666378401075, 826.349602968489, 950.5484894675112, 994.6966175316453, 1000.9740016483163, 1006.1498034161123, 4249.171411574714, 4879.414470263591, 4937.481884239064, 5048.434985154614, 5135.204043373208, 4595.080983803253, 4810.95189048105, 5137.614678899097, 5474.562035037187, 5580.693061881636, 4085.428040074392, 4376.708870883097, 4463.509014008457, 5100.821471248562, 5154.845354639367, 2508.519973215775, 2862.327353072026, 2911.213972227529, 2920.4013177298602, 2943.6909124542044, 5147.382314122255, 5233.450487698737, 5593.0, 5689.0328644130595, 5820.912686309709, 4954.20732682769, 5559.833205003856, 5704.833817231393, 5905.379935106752, 6011.368806275365, 5999.850003749942, 6020.488258498077, 6051.122587224828, 6056.757729690851, 6065.696715164224, 4835.371401717754, 4912.312276281395, 5091.414487334004, 5566.860828479321, 5829.795957141479, 4588.908221835478, 4893.975530122327, 5709.429057094258, 5764.42355764437, 5773.91339129905, 5725.456081672234, 5866.853328666817, 5898.519873274789, 5922.674252916131, 6018.849528761816, 3300.9834950825093, 3888.775035863694, 3914.2758589661003, 3918.451416801593, 3939.2318497892634, 5633.239712540907, 5686.658800471985, 5811.418858114154, 5820.650760954356, 5821.621594596338, 5236.711980841091, 5244.42311345744, 5267.920076384408, 5608.6073974821375, 5645.9153112702525, 4358.4769827620885, 4828.696252012008, 5191.065608190562, 5643.604947653625, 5664.546836253007, 5338.97330513345, 5342.0, 5495.0, 5541.33503979525, 5567.610267281413, 4929.778159982881, 5658.688772117573, 5674.205611214351, 5676.1969480449025, 5677.523843800559, 4678.953210467852, 4970.353853998957, 5571.462121552762, 5582.581306401955, 5584.0], "value": 4090.7813259484774, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [635.961842289463, 774.825664225549, 795.2047952047952, 860.1871231686057, 880.5201165364873, 12876.098673092876, 15179.0, 15429.151396673178, 15678.372865085383, 15689.607759805996, 14287.71424571508, 14460.060096093774, 14464.059836110646, 14464.987450878443, 14477.986540942138, 706.8197609609542, 727.9636018199095, 732.827785470414, 890.3678388344283, 901.0178904993555, 874.0865795243985, 898.5641963647626, 902.5442151713409, 905.7645012296817, 907.314977192219, 966.0339660339661, 966.8211380894522, 967.6274634265787, 968.1963969904997, 969.5152423788106, 961.1397798969953, 961.4663861556833, 963.1379914976127, 963.657901444984, 965.5654955270156, 717.103620474407, 718.5006420537728, 719.1154879498195, 719.2160545005917, 720.200577359131, 15390.307436165287, 15715.528534143994, 15763.290651920692, 15768.211589420598, 15986.600334991603, 13812.585622431243, 14183.716325673531, 14194.929025354808, 14212.85787142136, 14216.431342746278, 11355.981329895169, 11656.358900260482, 11686.590969316034, 11920.582779602672, 11942.077941432139, 3784.299904517673, 3797.7911214883447, 3990.2618015666903, 4044.1102957349335, 4048.5748996355255, 76006.0, 101826.0, 105339.0, 105478.0, 107674.99999999921, 10610.504130670357, 11173.664790056311, 11320.207585468937, 11833.053355731521, 12001.399930003465, 21685.457863553223, 22430.55138897213, 23611.29166125019, 23855.284341469785, 24091.638625420634, 8085.919140808634, 8149.185081491803, 8150.510969341858, 8210.835783284301, 8323.625436855356, 3604.7296452766145, 3835.8657446989223, 4403.339499075164, 4447.573959769076, 4512.210363186495, 3669.9816500917323, 3766.9246615067545, 3774.7168962327937, 3782.432635104756, 3784.299904517673, 657.7303305644663, 663.2074670768385, 668.8361351468922, 680.6868840333403, 685.7702669605638, 586.9706514674249, 593.4273426143792, 603.499095750526, 607.2439812433548, 616.3189675408698, 8965.775855603662, 9098.681546145985, 9958.850617240747, 10527.578896844194, 10961.177911656658, 680.8059702984625, 696.3837004251172, 700.8107810891031, 725.5936675461759, 725.7097161135588, 4762.833300834454, 4981.975090124526, 5078.289039534468, 5091.770870310845, 5099.719515426687, 77859.22140778633, 88556.50261204263, 93518.53240733752, 95293.52353238189, 97626.0, 70333.2966670337, 78322.6083869577, 81055.0, 82881.3423731522, 83742.16257837343, 69326.65336673285, 70795.58408831795, 72548.63725681338, 74318.62840685762, 76694.0, 10686.57253709874, 11060.39167845744, 11252.549898004316, 11381.487833047368, 11492.48283827213, 47101.0, 50155.74922125366, 51390.0, 52004.739976299876, 52431.73784131055, 71518.64240678764, 74351.8847217303, 78586.2848229108, 80519.59740201262, 83991.0, 12924.741505170032, 13976.794555988925, 14282.143071415749, 14450.277486125862, 14510.056846304957, 15307.693846122793, 15495.612609684847, 15576.22118894028, 15618.297176627306, 15837.0, 14044.368003440075, 14295.57113286603, 14650.047746896418, 14893.702125957203, 15095.1118831205, 14250.857491424953, 14648.19434931089, 14700.70598588001, 14847.554573362817, 14963.378942520418, 12248.0, 13021.218726876417, 14385.0, 14402.85597144015, 14534.418623254951, 10914.890851091388, 11428.71428214268, 11445.427728613702, 11454.0, 11681.532738690357, 9501.382410143318, 10161.745956351151, 11660.766784664429, 11736.589219377282, 11970.76058478843], "value": 7675.768175764916, "unit": "score"}], "name": "dromaeo_css", "value": 7468.070332667337, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 141.0, 140.0, 145.0, 110.0, 109.0, 108.0, 125.0, 160.0, 109.0], "value": 131.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 181.0, 182.0, 183.0, 182.0, 183.0, 182.0, 183.0, 183.0, 183.0], "value": 182.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 89.0, 59.0, 62.0, 72.0, 82.0, 97.0, 64.0], "value": 72.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 66.0, 84.0, 68.0, 67.0, 69.0, 80.0, 66.0, 68.0, 81.0], "value": 73.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 84.0, 86.0, 84.0, 87.0, 89.0, 134.0, 85.0], "value": 90.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 92.0, 92.0, 93.0, 93.0, 93.0, 92.0, 93.0, 93.0], "value": 92.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 86.0, 85.0, 85.0, 96.0, 130.0, 86.0, 84.0], "value": 90.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 53.0, 53.0, 55.0, 55.0, 57.0, 57.0, 56.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 78.0, 79.0, 73.0, 77.0, 100.0, 100.0, 99.0, 82.0, 69.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 91.0, 102.0, 79.0, 85.0, 104.0, 102.0, 103.0, 77.0], "value": 91.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 168.0, 147.0, 146.0, 134.0, 135.0, 136.0, 153.0, 173.0, 133.0], "value": 147.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 232.0, 200.0, 170.0, 162.0, 163.0, 162.0, 163.0, 164.0, 160.0], "value": 174.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 65.0, 63.0, 64.0, 65.0, 63.0, 63.0, 65.0], "value": 64.3, "unit": "score"}], "name": "kraken", "value": 1459.5999999999997, "alertThreshold": 2.0}]} 07:51:40 INFO - Return code: 0 07:51:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:51:40 INFO - # TBPL SUCCESS # 07:51:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:51:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:51:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:51:40 INFO - 2017-03-24 07:51:40.083 screenresolution[1657:9769] starting screenresolution argv=screenresolution get 07:51:40 INFO - 2017-03-24 07:51:40.086 screenresolution[1657:9769] Display 0: 1600x1200x32@60 07:51:40 INFO - 2017-03-24 07:51:40.093 screenresolution[1658:9772] starting screenresolution argv=screenresolution list 07:51:40 INFO - Available Modes on Display 0 07:51:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:51:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:51:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:51:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:51:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:51:40 INFO - Intel Iris: 07:51:40 INFO - Chipset Model: Intel Iris 07:51:40 INFO - Type: GPU 07:51:40 INFO - Bus: Built-In 07:51:40 INFO - VRAM (Dynamic, Max): 1536 MB 07:51:40 INFO - Vendor: Intel (0x8086) 07:51:40 INFO - Device ID: 0x0a2e 07:51:40 INFO - Revision ID: 0x0009 07:51:40 INFO - Displays: 07:51:40 INFO - Display: 07:51:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:51:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:51:40 INFO - Display Serial Number: 1600x1200 60 07:51:40 INFO - Main Display: Yes 07:51:40 INFO - Mirror: Off 07:51:40 INFO - Online: Yes 07:51:40 INFO - Rotation: Supported 07:51:40 INFO - Return code: 0 07:51:40 INFO - Running post-action listener: _resource_record_post_action 07:51:40 INFO - [mozharness: 2017-03-24 14:51:40.334122Z] Finished run-tests step (success) 07:51:40 INFO - Running post-run listener: _resource_record_post_run 07:51:40 INFO - Total resource usage - Wall time: 1191s; CPU: 53.0%; Read bytes: 38011904; Write bytes: 419771392; Read time: 241; Write time: 1393 07:51:40 INFO - TinderboxPrint: CPU usage
53.4% 07:51:40 INFO - TinderboxPrint: I/O read bytes / time
38,011,904 / 241 07:51:40 INFO - TinderboxPrint: I/O write bytes / time
419,771,392 / 1,393 07:51:40 INFO - TinderboxPrint: CPU idle
2,219.1 (46.6%) 07:51:40 INFO - TinderboxPrint: CPU system
948.8 (19.9%) 07:51:40 INFO - TinderboxPrint: CPU user
1,597.8 (33.5%) 07:51:40 INFO - TinderboxPrint: Swap in / out
160,165,888 / 0 07:51:40 INFO - install - Wall time: 15s; CPU: 53.0%; Read bytes: 113324544; Write bytes: 104415232; Read time: 10036; Write time: 232 07:51:40 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 37057536; Write bytes: 296973312; Read time: 229; Write time: 1107 07:51:40 INFO - Running post-run listener: _upload_blobber_files 07:51:40 INFO - Blob upload gear active. 07:51:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:51:40 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 07:51:40 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:51:40 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:51:41 INFO - (blobuploader) - INFO - Open directory for files ... 07:51:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:51:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:51:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:43 INFO - (blobuploader) - INFO - Done attempting. 07:51:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:51:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:51:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:44 INFO - (blobuploader) - INFO - Done attempting. 07:51:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:51:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:51:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:45 INFO - (blobuploader) - INFO - Done attempting. 07:51:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:51:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:51:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:47 INFO - (blobuploader) - INFO - Done attempting. 07:51:47 INFO - (blobuploader) - INFO - Iteration through files over. 07:51:47 INFO - Return code: 0 07:51:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:51:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:51:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7f224ca2c940d913cd5822302473279be936965e11070ba7bb50d38d811c06e2d3ca187aa69607b729aedac6b4456246034a237f2e472b3ae3e66933644e1b2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e85806c57b0157f3b6197887824beabf69f9dadbbafef0367b399e1c348a881d3fa6f141b49733af4ba4c200987e029ecb9902607831838ef8f0fb3fc720eb19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a61cade93dce71d0f4bbcb39be58eeec169c7752c0635bc058194d95f9ec7efd99f2113713facc96e54b7d3f3d3dcdec6cbd692470f3b952e21fad4a24fbfaa7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3c433745ad551d9d552ef49fcc6eb1c86e66572d1c606946584ff492b90d64074f89e4d033f91c3120803e09cafbcc0d5a37f7145c8daec1c4d7e29d5ace17e5"} 07:51:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:51:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:51:47 INFO - Contents: 07:51:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7f224ca2c940d913cd5822302473279be936965e11070ba7bb50d38d811c06e2d3ca187aa69607b729aedac6b4456246034a237f2e472b3ae3e66933644e1b2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e85806c57b0157f3b6197887824beabf69f9dadbbafef0367b399e1c348a881d3fa6f141b49733af4ba4c200987e029ecb9902607831838ef8f0fb3fc720eb19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a61cade93dce71d0f4bbcb39be58eeec169c7752c0635bc058194d95f9ec7efd99f2113713facc96e54b7d3f3d3dcdec6cbd692470f3b952e21fad4a24fbfaa7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3c433745ad551d9d552ef49fcc6eb1c86e66572d1c606946584ff492b90d64074f89e4d033f91c3120803e09cafbcc0d5a37f7145c8daec1c4d7e29d5ace17e5"} 07:51:47 INFO - Running post-run listener: copy_logs_to_upload_dir 07:51:47 INFO - Copying logs to upload dir... 07:51:47 INFO - mkdir: /builds/slave/test/build/upload/logs 07:51:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.253261 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-03-24 07:51:47.253155) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 07:51:47.257541) ========= 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.BsqbIx62FF/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.PwKOZY4gku/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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-Beta/sha512/7f224ca2c940d913cd5822302473279be936965e11070ba7bb50d38d811c06e2d3ca187aa69607b729aedac6b4456246034a237f2e472b3ae3e66933644e1b2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e85806c57b0157f3b6197887824beabf69f9dadbbafef0367b399e1c348a881d3fa6f141b49733af4ba4c200987e029ecb9902607831838ef8f0fb3fc720eb19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a61cade93dce71d0f4bbcb39be58eeec169c7752c0635bc058194d95f9ec7efd99f2113713facc96e54b7d3f3d3dcdec6cbd692470f3b952e21fad4a24fbfaa7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3c433745ad551d9d552ef49fcc6eb1c86e66572d1c606946584ff492b90d64074f89e4d033f91c3120803e09cafbcc0d5a37f7145c8daec1c4d7e29d5ace17e5"} build_url:https://queue.taskcluster.net/v1/task/N79vKfzCS-u1AIE6IgULbA/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011160 build_url: 'https://queue.taskcluster.net/v1/task/N79vKfzCS-u1AIE6IgULbA/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7f224ca2c940d913cd5822302473279be936965e11070ba7bb50d38d811c06e2d3ca187aa69607b729aedac6b4456246034a237f2e472b3ae3e66933644e1b2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e85806c57b0157f3b6197887824beabf69f9dadbbafef0367b399e1c348a881d3fa6f141b49733af4ba4c200987e029ecb9902607831838ef8f0fb3fc720eb19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a61cade93dce71d0f4bbcb39be58eeec169c7752c0635bc058194d95f9ec7efd99f2113713facc96e54b7d3f3d3dcdec6cbd692470f3b952e21fad4a24fbfaa7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3c433745ad551d9d552ef49fcc6eb1c86e66572d1c606946584ff492b90d64074f89e4d033f91c3120803e09cafbcc0d5a37f7145c8daec1c4d7e29d5ace17e5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 07:51:47.292825) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 07:51:47.293198) ========= 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.BsqbIx62FF/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.PwKOZY4gku/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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.005179 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 07:51:47.342090) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 07:51:47.342423) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 07:51:47.342771) ========= ========= Total master_lag: 0.18 =========