builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0251 starttime: 1485796365.73 results: success (0) buildid: 20170130065342 builduid: 16703b17ddbc4964acb485f04b1112b5 revision: 0f339c1e154f75c484fe2fac507a9a225990d212 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-30 09:12:45.734659) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-30 09:12:45.735279) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-30 09:12:45.735595) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-30 09:12:45.761316) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 09:12:45.761679) ========= 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.9sS9Nlp6hC/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.GBIBAVmaNr/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-30 09:12:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.6M=0.001s 2017-01-30 09:12:45 (20.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114567 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 09:12:45.900114) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 09:12:45.900421) ========= 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.9sS9Nlp6hC/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.GBIBAVmaNr/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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.024871 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 09:12:45.948715) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-30 09:12:45.949069) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0f339c1e154f75c484fe2fac507a9a225990d212 --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 0f339c1e154f75c484fe2fac507a9a225990d212 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9sS9Nlp6hC/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.GBIBAVmaNr/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-30 09:12:46,055 truncating revision to first 12 chars 2017-01-30 09:12:46,055 Setting DEBUG logging. 2017-01-30 09:12:46,055 attempt 1/10 2017-01-30 09:12:46,055 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0f339c1e154f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-30 09:12:46,885 unpacking tar archive at: mozilla-beta-0f339c1e154f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.101835 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-30 09:12:47.125318) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-30 09:12:47.125631) ========= script_repo_revision: 0f339c1e154f75c484fe2fac507a9a225990d212 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-30 09:12:47.126022) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-30 09:12:47.126280) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-30 09:12:47.145855) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-30 09:12:47.146126) ========= /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.9sS9Nlp6hC/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.GBIBAVmaNr/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 09:12:47 INFO - MultiFileLogger online at 20170130 09:12:47 in /builds/slave/test 09:12:47 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 09:12:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:12:47 INFO - {'append_to_log': False, 09:12:47 INFO - 'base_work_dir': '/builds/slave/test', 09:12:47 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:12:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:12:47 INFO - 'branch': 'Mozilla-Beta', 09:12:47 INFO - 'buildbot_json_path': 'buildprops.json', 09:12:47 INFO - 'config_files': ('talos/mac_config.py',), 09:12:47 INFO - 'default_actions': ('clobber', 09:12:47 INFO - 'read-buildbot-config', 09:12:47 INFO - 'download-and-extract', 09:12:47 INFO - 'populate-webroot', 09:12:47 INFO - 'create-virtualenv', 09:12:47 INFO - 'install', 09:12:47 INFO - 'run-tests'), 09:12:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:12:47 INFO - 'download_minidump_stackwalk': True, 09:12:47 INFO - 'download_symbols': 'ondemand', 09:12:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:12:47 INFO - 'tooltool.py': '/tools/tooltool.py', 09:12:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:12:47 INFO - '/tools/misc-python/virtualenv.py')}, 09:12:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:12:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:12:47 INFO - 'installer_path': 'installer.exe', 09:12:47 INFO - 'log_level': 'info', 09:12:47 INFO - 'log_name': 'talos', 09:12:47 INFO - 'log_to_console': True, 09:12:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:12:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:12:47 INFO - 'opt_config_files': (), 09:12:47 INFO - 'pip_index': False, 09:12:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:12:47 INFO - 'cmd': ('bash', 09:12:47 INFO - '-c', 09:12:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:12:47 INFO - 'enabled': True, 09:12:47 INFO - 'halt_on_failure': False, 09:12:47 INFO - 'name': 'check_screen_resolution'},), 09:12:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:12:47 INFO - 'cmd': ('bash', 09:12:47 INFO - '-c', 09:12:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:12:47 INFO - 'enabled': True, 09:12:47 INFO - 'halt_on_failure': False, 09:12:47 INFO - 'name': 'check_screen_resolution'},), 09:12:47 INFO - 'run_cmd_checks_enabled': True, 09:12:47 INFO - 'sps_profile': False, 09:12:47 INFO - 'sps_profile_interval': 0, 09:12:47 INFO - 'suite': 'dromaeojs', 09:12:47 INFO - 'system_bits': '32', 09:12:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:12:47 INFO - 'title': 't-yosemite-r7-0251', 09:12:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:12:47 INFO - 'use_talos_json': True, 09:12:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:12:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:12:47 INFO - 'work_dir': 'build'} 09:12:47 INFO - [mozharness: 2017-01-30 17:12:47.356880Z] Running clobber step. 09:12:47 INFO - Running pre-action listener: _resource_record_pre_action 09:12:47 INFO - Running main action method: clobber 09:12:47 INFO - rmtree: /builds/slave/test/build 09:12:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:12:49 INFO - Running post-action listener: _resource_record_post_action 09:12:49 INFO - [mozharness: 2017-01-30 17:12:49.597603Z] Finished clobber step (success) 09:12:49 INFO - [mozharness: 2017-01-30 17:12:49.597743Z] Running read-buildbot-config step. 09:12:49 INFO - Running pre-action listener: _resource_record_pre_action 09:12:49 INFO - Running main action method: read_buildbot_config 09:12:49 INFO - Using buildbot properties: 09:12:49 INFO - { 09:12:49 INFO - "project": "", 09:12:49 INFO - "product": "firefox", 09:12:49 INFO - "script_repo_revision": "production", 09:12:49 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:12:49 INFO - "repository": "", 09:12:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:12:49 INFO - "buildid": "20170130065342", 09:12:49 INFO - "pgo_build": "False", 09:12:49 INFO - "basedir": "/builds/slave/test", 09:12:49 INFO - "buildnumber": 13, 09:12:49 INFO - "slavename": "t-yosemite-r7-0251", 09:12:49 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:12:49 INFO - "platform": "yosemite_r7", 09:12:49 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:12:49 INFO - "branch": "mozilla-beta", 09:12:49 INFO - "repo_path": "releases/mozilla-beta", 09:12:49 INFO - "revision": "0f339c1e154f75c484fe2fac507a9a225990d212", 09:12:49 INFO - "stage_platform": "macosx64", 09:12:49 INFO - "builduid": "16703b17ddbc4964acb485f04b1112b5", 09:12:49 INFO - "slavebuilddir": "test" 09:12:49 INFO - } 09:12:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/PSAwuQfWQbK53_4QgDn8jA/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 09:12:49 INFO - Running post-action listener: _resource_record_post_action 09:12:49 INFO - [mozharness: 2017-01-30 17:12:49.601058Z] Finished read-buildbot-config step (success) 09:12:49 INFO - [mozharness: 2017-01-30 17:12:49.601193Z] Running download-and-extract step. 09:12:49 INFO - Running pre-action listener: _resource_record_pre_action 09:12:49 INFO - Running main action method: download_and_extract 09:12:49 INFO - mkdir: /builds/slave/test/build/tests 09:12:49 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')]} 09:12:49 INFO - trying https://queue.taskcluster.net/v1/task/PSAwuQfWQbK53_4QgDn8jA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 09:12:49 INFO - Downloading https://queue.taskcluster.net/v1/task/PSAwuQfWQbK53_4QgDn8jA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 09:12:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PSAwuQfWQbK53_4QgDn8jA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 09:12:50 INFO - Downloaded 1165 bytes. 09:12:50 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 09:12:50 INFO - Using the following test package requirements: 09:12:50 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 09:12:50 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:12:50 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 09:12:50 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:12:50 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 09:12:50 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:12:50 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:12:50 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 09:12:50 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 09:12:50 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:12:50 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 09:12:50 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:12:50 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 09:12:50 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:12:50 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 09:12:50 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:12:50 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 09:12:50 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 09:12:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PSAwuQfWQbK53_4QgDn8jA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 09:12:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PSAwuQfWQbK53_4QgDn8jA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 09:12:50 INFO - Fetch https://queue.taskcluster.net/v1/task/PSAwuQfWQbK53_4QgDn8jA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 09:12:51 INFO - Http code: 200 09:12:51 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 09:12:51 INFO - x-amz-cf-id: 0m-QqkzGjC1hhr9flOajYaaAOJxEj0k_vxkyDFbyXeHCM0svWA5zoQ== 09:12:51 INFO - x-amz-version-id: EGs5uRqghk6NpAXvXwid5SGKPtaX.nA4 09:12:51 INFO - Expected file size: 16087641 09:12:51 INFO - Obtained file size: 16087641 09:12:58 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:12:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PSAwuQfWQbK53_4QgDn8jA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 09:12:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PSAwuQfWQbK53_4QgDn8jA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 09:12:58 INFO - Fetch https://queue.taskcluster.net/v1/task/PSAwuQfWQbK53_4QgDn8jA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 09:12:58 INFO - Http code: 200 09:12:58 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 09:12:58 INFO - x-amz-cf-id: 4g5l8XjaCFR_acI0he_z1j63YOMar3dOZN4Gwb81F5AwPgqj0z5o7Q== 09:12:58 INFO - x-amz-version-id: EGs5uRqghk6NpAXvXwid5SGKPtaX.nA4 09:12:59 INFO - Expected file size: 16087641 09:12:59 INFO - Obtained file size: 16087641 09:13:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PSAwuQfWQbK53_4QgDn8jA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 09:13:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PSAwuQfWQbK53_4QgDn8jA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 09:13:05 INFO - Fetch https://queue.taskcluster.net/v1/task/PSAwuQfWQbK53_4QgDn8jA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 09:13:06 INFO - Http code: 200 09:13:06 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 09:13:06 INFO - x-amz-cf-id: AD9-YXgWv_e0ZSP1kc8re8FVC2vajL2KwsAWJEpikZh63a9bHm_ocw== 09:13:06 INFO - x-amz-version-id: DM2Rx8F_zp3YcjT9JOfslQZct79Am3qJ 09:13:06 INFO - Expected file size: 14402992 09:13:06 INFO - Obtained file size: 14402992 09:13:07 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')]} 09:13:07 INFO - trying https://queue.taskcluster.net/v1/task/PSAwuQfWQbK53_4QgDn8jA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 09:13:07 INFO - Downloading https://queue.taskcluster.net/v1/task/PSAwuQfWQbK53_4QgDn8jA/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 09:13:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PSAwuQfWQbK53_4QgDn8jA/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 09:13:09 INFO - Downloaded 82137351 bytes. 09:13:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PSAwuQfWQbK53_4QgDn8jA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 09:13:09 INFO - mkdir: /builds/slave/test/properties 09:13:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:13:09 INFO - Writing to file /builds/slave/test/properties/build_url 09:13:09 INFO - Contents: 09:13:09 INFO - build_url:https://queue.taskcluster.net/v1/task/PSAwuQfWQbK53_4QgDn8jA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 09:13:10 INFO - Running post-action listener: _resource_record_post_action 09:13:10 INFO - Running post-action listener: set_extra_try_arguments 09:13:10 INFO - [mozharness: 2017-01-30 17:13:10.191357Z] Finished download-and-extract step (success) 09:13:10 INFO - [mozharness: 2017-01-30 17:13:10.191516Z] Running populate-webroot step. 09:13:10 INFO - Running pre-action listener: _resource_record_pre_action 09:13:10 INFO - Running main action method: populate_webroot 09:13:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:13:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:13:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:13:10 INFO - '--tppagecycles', 09:13:10 INFO - '7'], 09:13:10 INFO - 'tests': ['tsvgm']}}, 09:13:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:13:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:13:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:13:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:13:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:13:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:13:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:10 INFO - 'talos_options': ['--disable-e10s'], 09:13:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:13:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:13:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:10 INFO - 'talos_options': ['--disable-e10s'], 09:13:10 INFO - 'tests': ['damp', 'tps']}, 09:13:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:10 INFO - 'tests': ['damp', 'tps']}, 09:13:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:13:10 INFO - 'tests': ['dromaeo_dom']}, 09:13:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:13:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:13:10 INFO - 'tests': ['basic_compositor_video']}, 09:13:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:13:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:13:10 INFO - 'tests': ['a11yr', 09:13:10 INFO - 'ts_paint', 09:13:10 INFO - 'tpaint', 09:13:10 INFO - 'sessionrestore', 09:13:10 INFO - 'sessionrestore_no_auto_restore', 09:13:10 INFO - 'tabpaint']}, 09:13:10 INFO - 'other-e10s': {'tests': ['a11yr', 09:13:10 INFO - 'ts_paint', 09:13:10 INFO - 'tpaint', 09:13:10 INFO - 'sessionrestore', 09:13:10 INFO - 'sessionrestore_no_auto_restore', 09:13:10 INFO - 'tabpaint']}, 09:13:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:13:10 INFO - 'ts_paint', 09:13:10 INFO - 'tpaint', 09:13:10 INFO - 'sessionrestore', 09:13:10 INFO - 'sessionrestore_no_auto_restore', 09:13:10 INFO - 'tabpaint']}, 09:13:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:13:10 INFO - 'ts_paint', 09:13:10 INFO - 'tpaint', 09:13:10 INFO - 'sessionrestore', 09:13:10 INFO - 'sessionrestore_no_auto_restore', 09:13:10 INFO - 'tabpaint']}, 09:13:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:13:10 INFO - 'tests': ['a11yr', 09:13:10 INFO - 'ts_paint', 09:13:10 INFO - 'tpaint', 09:13:10 INFO - 'sessionrestore', 09:13:10 INFO - 'sessionrestore_no_auto_restore', 09:13:10 INFO - 'tabpaint']}, 09:13:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:13:10 INFO - 'tests': ['a11yr', 09:13:10 INFO - 'ts_paint', 09:13:10 INFO - 'tpaint', 09:13:10 INFO - 'sessionrestore', 09:13:10 INFO - 'sessionrestore_no_auto_restore', 09:13:10 INFO - 'tabpaint']}, 09:13:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:13:10 INFO - 'tests': ['tsvgx', 09:13:10 INFO - 'tsvgr_opacity', 09:13:10 INFO - 'tart', 09:13:10 INFO - 'tscrollx', 09:13:10 INFO - 'cart']}, 09:13:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:13:10 INFO - 'tsvgr_opacity', 09:13:10 INFO - 'tart', 09:13:10 INFO - 'tscrollx', 09:13:10 INFO - 'cart']}, 09:13:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:10 INFO - 'talos_options': ['--disable-e10s'], 09:13:10 INFO - 'tests': ['tp5o']}, 09:13:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:10 INFO - 'tests': ['tp5o']}, 09:13:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:10 INFO - 'talos_options': ['--disable-e10s', 09:13:10 INFO - '--xperf_path', 09:13:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:13:10 INFO - 'tests': ['tp5n']}, 09:13:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:13:10 INFO - 'talos_options': ['--xperf_path', 09:13:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:13:10 INFO - 'tests': ['tp5n']}}, 09:13:10 INFO - 'talos.zip': {'path': '', 09:13:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:13:10 INFO - Running post-action listener: _resource_record_post_action 09:13:10 INFO - [mozharness: 2017-01-30 17:13:10.210348Z] Finished populate-webroot step (success) 09:13:10 INFO - [mozharness: 2017-01-30 17:13:10.210486Z] Running create-virtualenv step. 09:13:10 INFO - Running pre-action listener: _resource_record_pre_action 09:13:10 INFO - Running main action method: create_virtualenv 09:13:10 INFO - Creating virtualenv /builds/slave/test/build/venv 09:13:10 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 09:13:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:13:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:13:10 INFO - Using real prefix '/tools/python27' 09:13:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:13:11 INFO - Installing distribute.............................................................................................................................................................................................done. 09:13:13 INFO - Installing pip.................done. 09:13:13 INFO - Return code: 0 09:13:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:13:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:13:14 INFO - Reading from file tmpfile_stdout 09:13:14 INFO - Output received: 09:13:14 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) 09:13:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:14 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 0x1099d1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109947570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febbbc8b9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097e5d30>, '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 0x10964bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097ddb20>, '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.9sS9Nlp6hC/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.GBIBAVmaNr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 09:13:14 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 09:13:14 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 09:13:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9sS9Nlp6hC/Render', 09:13:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:14 INFO - 'HOME': '/Users/cltbld', 09:13:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:14 INFO - 'LOGNAME': 'cltbld', 09:13:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:14 INFO - 'MOZ_NO_REMOTE': '1', 09:13:14 INFO - 'NO_EM_RESTART': '1', 09:13:14 INFO - 'PAGER': '/bin/cat', 09:13:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:14 INFO - 'PWD': '/builds/slave/test', 09:13:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:14 INFO - 'SHELL': '/bin/bash', 09:13:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GBIBAVmaNr/Listeners', 09:13:14 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 09:13:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:14 INFO - 'USER': 'cltbld', 09:13:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:14 INFO - 'XPC_FLAGS': '0x0', 09:13:14 INFO - 'XPC_SERVICE_NAME': '0', 09:13:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:14 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 09:13:14 INFO - Cleaning up... 09:13:14 INFO - Return code: 0 09:13:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:14 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 0x1099d1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109947570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febbbc8b9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097e5d30>, '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 0x10964bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097ddb20>, '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.9sS9Nlp6hC/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.GBIBAVmaNr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 09:13:14 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 09:13:14 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 09:13:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9sS9Nlp6hC/Render', 09:13:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:14 INFO - 'HOME': '/Users/cltbld', 09:13:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:14 INFO - 'LOGNAME': 'cltbld', 09:13:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:14 INFO - 'MOZ_NO_REMOTE': '1', 09:13:14 INFO - 'NO_EM_RESTART': '1', 09:13:14 INFO - 'PAGER': '/bin/cat', 09:13:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:14 INFO - 'PWD': '/builds/slave/test', 09:13:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:14 INFO - 'SHELL': '/bin/bash', 09:13:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GBIBAVmaNr/Listeners', 09:13:14 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 09:13:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:14 INFO - 'USER': 'cltbld', 09:13:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:14 INFO - 'XPC_FLAGS': '0x0', 09:13:14 INFO - 'XPC_SERVICE_NAME': '0', 09:13:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:14 INFO - Downloading/unpacking psutil>=3.1.1 09:13:14 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 09:13:14 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 09:13:14 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 09:13:14 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 09:13:14 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 09:13:14 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 09:13:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:13:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:13:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:13:18 INFO - Installing collected packages: psutil 09:13:18 INFO - Running setup.py install for psutil 09:13:18 INFO - building 'psutil._psutil_osx' extension 09:13:18 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 09:13:18 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 09:13:18 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 09:13:18 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 09:13:19 INFO - building 'psutil._psutil_posix' extension 09:13:19 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 09:13:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:13:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:13:19 INFO - ^ 09:13:19 INFO - 1 warning generated. 09:13:19 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 09:13:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:13:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:13:19 INFO - Successfully installed psutil 09:13:19 INFO - Cleaning up... 09:13:19 INFO - Return code: 0 09:13:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:13: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')]} 09:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13: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')]} 09:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1099d1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109947570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febbbc8b9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097e5d30>, '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 0x10964bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097ddb20>, '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.9sS9Nlp6hC/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.GBIBAVmaNr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 09:13: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:13: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 mozsystemmonitor==0.3 09:13:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9sS9Nlp6hC/Render', 09:13:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:19 INFO - 'HOME': '/Users/cltbld', 09:13:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:19 INFO - 'LOGNAME': 'cltbld', 09:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:19 INFO - 'MOZ_NO_REMOTE': '1', 09:13:19 INFO - 'NO_EM_RESTART': '1', 09:13:19 INFO - 'PAGER': '/bin/cat', 09:13:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:19 INFO - 'PWD': '/builds/slave/test', 09:13:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:19 INFO - 'SHELL': '/bin/bash', 09:13:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GBIBAVmaNr/Listeners', 09:13:19 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 09:13:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:19 INFO - 'USER': 'cltbld', 09:13:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:19 INFO - 'XPC_FLAGS': '0x0', 09:13:19 INFO - 'XPC_SERVICE_NAME': '0', 09:13:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:13:19 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 09:13:19 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 09:13:19 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 09:13:19 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 09:13:19 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 09:13:19 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 09:13:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:13:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:13:22 INFO - Installing collected packages: mozsystemmonitor 09:13:22 INFO - Running setup.py install for mozsystemmonitor 09:13:22 INFO - Successfully installed mozsystemmonitor 09:13:22 INFO - Cleaning up... 09:13:22 INFO - Return code: 0 09:13:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:13:22 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')]} 09:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:22 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')]} 09:13:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:22 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 0x1099d1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109947570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febbbc8b9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097e5d30>, '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 0x10964bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097ddb20>, '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.9sS9Nlp6hC/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.GBIBAVmaNr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 09:13:22 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 09:13:22 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 09:13:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9sS9Nlp6hC/Render', 09:13:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:22 INFO - 'HOME': '/Users/cltbld', 09:13:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:22 INFO - 'LOGNAME': 'cltbld', 09:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:22 INFO - 'MOZ_NO_REMOTE': '1', 09:13:22 INFO - 'NO_EM_RESTART': '1', 09:13:22 INFO - 'PAGER': '/bin/cat', 09:13:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:22 INFO - 'PWD': '/builds/slave/test', 09:13:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:22 INFO - 'SHELL': '/bin/bash', 09:13:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GBIBAVmaNr/Listeners', 09:13:22 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 09:13:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:22 INFO - 'USER': 'cltbld', 09:13:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:22 INFO - 'XPC_FLAGS': '0x0', 09:13:22 INFO - 'XPC_SERVICE_NAME': '0', 09:13:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:22 INFO - Downloading/unpacking jsonschema==2.5.1 09:13:22 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 09:13:22 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 09:13:22 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 09:13:22 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 09:13:22 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 09:13:22 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 09:13:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:13:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:13: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 09:13: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 09:13: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 09:13: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 09:13: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 09:13: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 09:13:25 INFO - Downloading functools32-3.2.3-2.tar.gz 09:13:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:13:25 INFO - warning: no files found matching '*.txt' 09:13:25 INFO - no previously-included directories found matching 'build' 09:13:25 INFO - no previously-included directories found matching 'dist' 09:13:25 INFO - no previously-included directories found matching '.git*' 09:13:25 INFO - Installing collected packages: jsonschema, functools32 09:13:25 INFO - Running setup.py install for functools32 09:13:25 INFO - warning: no files found matching '*.txt' 09:13:25 INFO - no previously-included directories found matching 'build' 09:13:25 INFO - no previously-included directories found matching 'dist' 09:13:25 INFO - no previously-included directories found matching '.git*' 09:13:25 INFO - Successfully installed jsonschema functools32 09:13:25 INFO - Cleaning up... 09:13:26 INFO - Return code: 0 09:13:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:13:26 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')]} 09:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:26 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')]} 09:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:26 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 0x1099d1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109947570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febbbc8b9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097e5d30>, '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 0x10964bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097ddb20>, '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.9sS9Nlp6hC/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.GBIBAVmaNr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 09:13:26 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 09:13:26 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 09:13:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9sS9Nlp6hC/Render', 09:13:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:26 INFO - 'HOME': '/Users/cltbld', 09:13:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:26 INFO - 'LOGNAME': 'cltbld', 09:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:26 INFO - 'MOZ_NO_REMOTE': '1', 09:13:26 INFO - 'NO_EM_RESTART': '1', 09:13:26 INFO - 'PAGER': '/bin/cat', 09:13:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:26 INFO - 'PWD': '/builds/slave/test', 09:13:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:26 INFO - 'SHELL': '/bin/bash', 09:13:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GBIBAVmaNr/Listeners', 09:13:26 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 09:13:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:26 INFO - 'USER': 'cltbld', 09:13:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:26 INFO - 'XPC_FLAGS': '0x0', 09:13:26 INFO - 'XPC_SERVICE_NAME': '0', 09:13:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:13:26 INFO - Cleaning up... 09:13:26 INFO - Return code: 0 09:13:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:13:26 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')]} 09:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:26 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')]} 09:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:26 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 0x1099d1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109947570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febbbc8b9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097e5d30>, '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 0x10964bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097ddb20>, '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.9sS9Nlp6hC/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.GBIBAVmaNr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 09:13:26 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 09:13:26 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 09:13:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9sS9Nlp6hC/Render', 09:13:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:26 INFO - 'HOME': '/Users/cltbld', 09:13:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:26 INFO - 'LOGNAME': 'cltbld', 09:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:26 INFO - 'MOZ_NO_REMOTE': '1', 09:13:26 INFO - 'NO_EM_RESTART': '1', 09:13:26 INFO - 'PAGER': '/bin/cat', 09:13:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:26 INFO - 'PWD': '/builds/slave/test', 09:13:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:26 INFO - 'SHELL': '/bin/bash', 09:13:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GBIBAVmaNr/Listeners', 09:13:26 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 09:13:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:26 INFO - 'USER': 'cltbld', 09:13:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:26 INFO - 'XPC_FLAGS': '0x0', 09:13:26 INFO - 'XPC_SERVICE_NAME': '0', 09:13:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:26 INFO - Downloading/unpacking blobuploader==1.2.4 09:13:26 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 09:13:26 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 09:13:26 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 09:13:26 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 09:13:26 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 09:13:26 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 09:13:29 INFO - Downloading blobuploader-1.2.4.tar.gz 09:13:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:13:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:13:29 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 09:13:29 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 09:13:29 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 09:13:29 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 09:13:29 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 09:13:29 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 09:13:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:13:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:13:29 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 09:13:29 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 09:13:29 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 09:13:29 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 09:13:29 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 09:13:29 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 09:13:30 INFO - Downloading docopt-0.6.1.tar.gz 09:13:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:13:30 INFO - Installing collected packages: blobuploader, requests, docopt 09:13:30 INFO - Running setup.py install for blobuploader 09:13:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:13:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:13:30 INFO - Running setup.py install for requests 09:13:31 INFO - Running setup.py install for docopt 09:13:31 INFO - Successfully installed blobuploader requests docopt 09:13:31 INFO - Cleaning up... 09:13:31 INFO - Return code: 0 09:13:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:13: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')]} 09:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13: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')]} 09:13:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:31 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 0x1099d1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109947570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febbbc8b9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097e5d30>, '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 0x10964bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097ddb20>, '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.9sS9Nlp6hC/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.GBIBAVmaNr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 09:13:31 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 09:13:31 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 09:13:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9sS9Nlp6hC/Render', 09:13:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:31 INFO - 'HOME': '/Users/cltbld', 09:13:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:31 INFO - 'LOGNAME': 'cltbld', 09:13:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:31 INFO - 'MOZ_NO_REMOTE': '1', 09:13:31 INFO - 'NO_EM_RESTART': '1', 09:13:31 INFO - 'PAGER': '/bin/cat', 09:13:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:31 INFO - 'PWD': '/builds/slave/test', 09:13:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:31 INFO - 'SHELL': '/bin/bash', 09:13:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GBIBAVmaNr/Listeners', 09:13:31 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 09:13:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:31 INFO - 'USER': 'cltbld', 09:13:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:31 INFO - 'XPC_FLAGS': '0x0', 09:13:31 INFO - 'XPC_SERVICE_NAME': '0', 09:13:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:13:31 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-zxmJSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:13:31 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-KN_9_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:13:31 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-zVrHER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:13:32 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-EqtuD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:13:32 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-1bzstv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:13:32 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-u_Lg6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:13:32 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-xzdpNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:13:32 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-U3XEuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:13:32 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-buhxQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:13:32 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-s9_edX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:13:32 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-XEIAIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:13:32 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-sOicvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:13:32 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-ssQYC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:13:33 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-nS5RbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:13:33 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-iSWINz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:13:33 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-X_1wXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:13:33 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-Meog4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:13:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:13:33 INFO - Running setup.py install for manifestparser 09:13:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:13:33 INFO - Running setup.py install for mozcrash 09:13:33 INFO - Running setup.py install for mozdebug 09:13:33 INFO - Running setup.py install for mozdevice 09:13:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:13:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:13:34 INFO - Running setup.py install for mozfile 09:13:34 INFO - Running setup.py install for mozhttpd 09:13:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:13:34 INFO - Running setup.py install for mozinfo 09:13:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:13:34 INFO - Running setup.py install for mozInstall 09:13:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:13:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:13:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:13:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:13:34 INFO - Running setup.py install for mozleak 09:13:34 INFO - Running setup.py install for mozlog 09:13:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:13:34 INFO - Running setup.py install for moznetwork 09:13:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:13:35 INFO - Running setup.py install for mozprocess 09:13:35 INFO - Running setup.py install for mozprofile 09:13:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:13:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:13:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:13:35 INFO - Running setup.py install for mozrunner 09:13:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:13:35 INFO - Running setup.py install for mozscreenshot 09:13:35 INFO - Running setup.py install for moztest 09:13:35 INFO - Running setup.py install for mozversion 09:13:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:13:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:13:36 INFO - Cleaning up... 09:13:36 INFO - Return code: 0 09:13:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:36 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 0x1099d1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109947570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febbbc8b9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097e5d30>, '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 0x10964bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097ddb20>, '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.9sS9Nlp6hC/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.GBIBAVmaNr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 09:13:36 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 09:13:36 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 09:13:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9sS9Nlp6hC/Render', 09:13:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:36 INFO - 'HOME': '/Users/cltbld', 09:13:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:36 INFO - 'LOGNAME': 'cltbld', 09:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:36 INFO - 'MOZ_NO_REMOTE': '1', 09:13:36 INFO - 'NO_EM_RESTART': '1', 09:13:36 INFO - 'PAGER': '/bin/cat', 09:13:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:36 INFO - 'PWD': '/builds/slave/test', 09:13:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:36 INFO - 'SHELL': '/bin/bash', 09:13:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GBIBAVmaNr/Listeners', 09:13:36 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 09:13:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:36 INFO - 'USER': 'cltbld', 09:13:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:36 INFO - 'XPC_FLAGS': '0x0', 09:13:36 INFO - 'XPC_SERVICE_NAME': '0', 09:13:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:13:36 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-0Yow6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:13:36 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)) 09:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:13:36 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-0QDm7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:13:36 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)) 09:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:13:36 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-rrdIaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:13:36 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)) 09:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:13:36 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-MsAJjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:13:36 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-3k3pRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:13:36 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)) 09:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:13:36 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-GJJbqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:13:36 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)) 09:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:13:36 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-1iJCBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:13:37 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)) 09:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:13:37 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-CgzDx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:13:37 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)) 09:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:13:37 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-JfwJ8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:13:37 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)) 09:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:13:37 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-cnmRlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:13:37 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)) 09:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:13:37 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-gSnqD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:13:37 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)) 09:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:13:37 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-AG7aPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:13:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:13:37 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-NPAKxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:13:37 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)) 09:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:13:37 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-Lvt2w1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:13:37 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)) 09:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:13:37 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-qVOxZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:13:37 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)) 09:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:13:37 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-eqn3rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:13:38 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)) 09:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:13:38 INFO - Running setup.py (path:/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/pip-Na9FKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:13:38 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)) 09:13:38 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)) 09:13:38 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)) 09:13:38 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)) 09:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:13:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:13:38 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 09:13:38 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 09:13:38 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 09:13:38 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 09:13:38 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 09:13:38 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 09:13:40 INFO - Downloading blessings-1.6.tar.gz 09:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:13:40 INFO - Installing collected packages: blessings 09:13:40 INFO - Running setup.py install for blessings 09:13:40 INFO - Successfully installed blessings 09:13:40 INFO - Cleaning up... 09:13:41 INFO - Return code: 0 09:13:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:13:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:13:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:13:41 INFO - Reading from file tmpfile_stdout 09:13:41 INFO - Current package versions: 09:13:41 INFO - blessings == 1.6 09:13:41 INFO - blobuploader == 1.2.4 09:13:41 INFO - docopt == 0.6.1 09:13:41 INFO - functools32 == 3.2.3-2 09:13:41 INFO - jsonschema == 2.5.1 09:13:41 INFO - manifestparser == 1.1 09:13:41 INFO - mozInstall == 1.12 09:13:41 INFO - mozcrash == 1.0 09:13:41 INFO - mozdebug == 0.1 09:13:41 INFO - mozdevice == 0.48 09:13:41 INFO - mozfile == 1.2 09:13:41 INFO - mozhttpd == 0.7 09:13:41 INFO - mozinfo == 0.9 09:13:41 INFO - mozleak == 0.1 09:13:41 INFO - mozlog == 3.4 09:13:41 INFO - moznetwork == 0.27 09:13:41 INFO - mozprocess == 0.23 09:13:41 INFO - mozprofile == 0.28 09:13:41 INFO - mozrunner == 6.13 09:13:41 INFO - mozscreenshot == 0.1 09:13:41 INFO - mozsystemmonitor == 0.3 09:13:41 INFO - moztest == 0.8 09:13:41 INFO - mozversion == 1.4 09:13:41 INFO - psutil == 3.1.1 09:13:41 INFO - requests == 1.2.3 09:13:41 INFO - wsgiref == 0.1.2 09:13:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:13: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')]} 09:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:42 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 0x1099d1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109947570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febbbc8b9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097e5d30>, '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 0x10964bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097ddb20>, '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.9sS9Nlp6hC/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.GBIBAVmaNr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 09:13:42 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 09:13:42 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 09:13:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9sS9Nlp6hC/Render', 09:13:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:42 INFO - 'HOME': '/Users/cltbld', 09:13:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:42 INFO - 'LOGNAME': 'cltbld', 09:13:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:42 INFO - 'MOZ_NO_REMOTE': '1', 09:13:42 INFO - 'NO_EM_RESTART': '1', 09:13:42 INFO - 'PAGER': '/bin/cat', 09:13:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:42 INFO - 'PWD': '/builds/slave/test', 09:13:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:42 INFO - 'SHELL': '/bin/bash', 09:13:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GBIBAVmaNr/Listeners', 09:13:42 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 09:13:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:42 INFO - 'USER': 'cltbld', 09:13:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:42 INFO - 'XPC_FLAGS': '0x0', 09:13:42 INFO - 'XPC_SERVICE_NAME': '0', 09:13:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:42 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)) 09:13:42 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)) 09:13:42 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)) 09:13:42 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)) 09:13:42 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)) 09:13:42 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)) 09:13:42 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)) 09:13:42 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)) 09:13:42 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)) 09:13:42 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)) 09:13:42 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)) 09:13:42 INFO - Cleaning up... 09:13:42 INFO - Return code: 0 09:13:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1099d1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109947570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febbbc8b9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097e5d30>, '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 0x10964bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097ddb20>, '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.9sS9Nlp6hC/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.GBIBAVmaNr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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 09:13:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:13:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:13:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9sS9Nlp6hC/Render', 09:13:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:43 INFO - 'HOME': '/Users/cltbld', 09:13:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:43 INFO - 'LOGNAME': 'cltbld', 09:13:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:43 INFO - 'MOZ_NO_REMOTE': '1', 09:13:43 INFO - 'NO_EM_RESTART': '1', 09:13:43 INFO - 'PAGER': '/bin/cat', 09:13:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:43 INFO - 'PWD': '/builds/slave/test', 09:13:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:43 INFO - 'SHELL': '/bin/bash', 09:13:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GBIBAVmaNr/Listeners', 09:13:43 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 09:13:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:43 INFO - 'USER': 'cltbld', 09:13:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:43 INFO - 'XPC_FLAGS': '0x0', 09:13:43 INFO - 'XPC_SERVICE_NAME': '0', 09:13:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:13:43 INFO - Cleaning up... 09:13:43 INFO - Return code: 0 09:13:43 INFO - Running post-action listener: _resource_record_post_action 09:13:43 INFO - Running post-action listener: _start_resource_monitoring 09:13:43 INFO - Starting resource monitoring. 09:13:43 INFO - [mozharness: 2017-01-30 17:13:43.333144Z] Finished create-virtualenv step (success) 09:13:43 INFO - [mozharness: 2017-01-30 17:13:43.334117Z] Running install step. 09:13:43 INFO - Running pre-action listener: _resource_record_pre_action 09:13:43 INFO - Running main action method: install 09:13:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:13:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:13:43 INFO - Reading from file tmpfile_stdout 09:13:43 INFO - Detecting whether we're running mozinstall >=1.0... 09:13:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:13:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:13:43 INFO - Reading from file tmpfile_stdout 09:13:43 INFO - Output received: 09:13:43 INFO - Usage: mozinstall [options] installer 09:13:43 INFO - Options: 09:13:43 INFO - -h, --help show this help message and exit 09:13:43 INFO - -d DEST, --destination=DEST 09:13:43 INFO - Directory to install application into. [default: 09:13:43 INFO - "/builds/slave/test"] 09:13:43 INFO - --app=APP Application being installed. [default: firefox] 09:13:43 INFO - mkdir: /builds/slave/test/build/application 09:13:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:13:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:14:05 INFO - Reading from file tmpfile_stdout 09:14:05 INFO - Output received: 09:14:05 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:14:05 INFO - Running post-action listener: _resource_record_post_action 09:14:05 INFO - [mozharness: 2017-01-30 17:14:05.179599Z] Finished install step (success) 09:14:05 INFO - [mozharness: 2017-01-30 17:14:05.179729Z] Running run-tests step. 09:14:05 INFO - Running pre-action listener: _resource_record_pre_action 09:14:05 INFO - Running main action method: run_tests 09:14:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:14:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:14:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:14:05 INFO - 2017-01-30 09:14:05.194 screenresolution[1624:7454] starting screenresolution argv=screenresolution get 09:14:05 INFO - 2017-01-30 09:14:05.196 screenresolution[1624:7454] Display 0: 1600x1200x32@60 09:14:05 INFO - 2017-01-30 09:14:05.202 screenresolution[1625:7456] starting screenresolution argv=screenresolution list 09:14:05 INFO - Available Modes on Display 0 09:14:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:14:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:14:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:14:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:14:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:14:05 INFO - Intel Iris: 09:14:05 INFO - Chipset Model: Intel Iris 09:14:05 INFO - Type: GPU 09:14:05 INFO - Bus: Built-In 09:14:05 INFO - VRAM (Dynamic, Max): 1536 MB 09:14:05 INFO - Vendor: Intel (0x8086) 09:14:05 INFO - Device ID: 0x0a2e 09:14:05 INFO - Revision ID: 0x0009 09:14:05 INFO - Displays: 09:14:05 INFO - Display: 09:14:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:14:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:14:05 INFO - Display Serial Number: 1600x1200 60 09:14:05 INFO - Main Display: Yes 09:14:05 INFO - Mirror: Off 09:14:05 INFO - Online: Yes 09:14:05 INFO - Rotation: Supported 09:14:05 INFO - Return code: 0 09:14:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:14:05 INFO - Python 2.7.3 09:14:05 INFO - Return code: 0 09:14:05 INFO - grabbing minidump binary from tooltool 09:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:05 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 0x1097e5d30>, '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 0x10964bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097ddb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:14:05 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 09:14:05 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 09:14:05 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 09:14:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:14:05 INFO - Return code: 0 09:14:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:14:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:14:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:14:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:14:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:14:05 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/PSAwuQfWQbK53_4QgDn8jA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0251', '--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 09:14:05 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/PSAwuQfWQbK53_4QgDn8jA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0251 --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 09:14:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9sS9Nlp6hC/Render', 09:14:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:14:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:14:05 INFO - 'HOME': '/Users/cltbld', 09:14:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:14:05 INFO - 'LOGNAME': 'cltbld', 09:14:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:14:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:05 INFO - 'MOZ_NO_REMOTE': '1', 09:14:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:14:05 INFO - 'NO_EM_RESTART': '1', 09:14:05 INFO - 'PAGER': '/bin/cat', 09:14:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:05 INFO - 'PWD': '/builds/slave/test', 09:14:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:14:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:14:05 INFO - 'SHELL': '/bin/bash', 09:14:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GBIBAVmaNr/Listeners', 09:14:05 INFO - 'TMPDIR': '/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/', 09:14:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:14:05 INFO - 'USER': 'cltbld', 09:14:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:14:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:05 INFO - 'XPC_FLAGS': '0x0', 09:14:05 INFO - 'XPC_SERVICE_NAME': '0', 09:14:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:14:05 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/PSAwuQfWQbK53_4QgDn8jA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0251', '--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 09:14:05 INFO - mozversion application_buildid: 20170130065342 09:14:05 INFO - mozversion application_changeset: 0f339c1e154f75c484fe2fac507a9a225990d212 09:14:05 INFO - mozversion application_display_name: Firefox 09:14:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:14:05 INFO - mozversion application_name: Firefox 09:14:05 INFO - mozversion application_remotingname: firefox 09:14:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:14:05 INFO - mozversion application_vendor: Mozilla 09:14:05 INFO - mozversion application_version: 52.0 09:14:05 INFO - mozversion platform_buildid: 20170130065342 09:14:05 INFO - mozversion platform_changeset: 0f339c1e154f75c484fe2fac507a9a225990d212 09:14:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:14:05 INFO - mozversion platform_version: 52.0 09:14:05 INFO - using testdate: 1485796445 09:14:05 INFO - actual date: 1485796445 09:14:05 INFO - starting webserver on 'localhost:49241' 09:14:05 INFO - SUITE-START | Running 2 tests 09:14:05 INFO - TEST-START | dromaeo_css 09:14:05 INFO - operating with platform_type : mac_ 09:14:05 INFO - Initialising browser for dromaeo_css test... 09:14:05 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/tmpa5H6FE/profile http://localhost:49241/getInfo.html) 09:14:08 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 09:14:08 INFO - PROCESS | 1635 | colorDepth:24 09:14:08 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 09:14:08 INFO - PROCESS | 1635 | __metrics 09:14:08 INFO - PROCESS | 1635 | 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" 09:14:08 INFO - PROCESS | 1635 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:14:09 INFO - TEST-INFO | 1635: exit 0 09:14:09 INFO - Browser initialized. 09:14:09 INFO - Running cycle 1/1 for dromaeo_css test... 09:14:09 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/tmpa5H6FE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:14:21 INFO - PROCESS | 1638 | RSS: Main: 167624704 09:14:21 INFO - PROCESS | 1638 | 09:17:24 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 09:17:25 INFO - PROCESS | 1638 | RSS: Main: 280035328 09:17:25 INFO - PROCESS | 1638 | 09:20:28 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 09:20:29 INFO - PROCESS | 1638 | RSS: Main: 297558016 09:20:29 INFO - PROCESS | 1638 | 09:23:31 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 09:23:32 INFO - PROCESS | 1638 | RSS: Main: 293744640 09:23:32 INFO - PROCESS | 1638 | 09:26:34 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 09:26:35 INFO - PROCESS | 1638 | RSS: Main: 264871936 09:26:35 INFO - PROCESS | 1638 | 09:29:38 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 09:29:38 INFO - PROCESS | 1638 | RSS: Main: 256245760 09:29:38 INFO - PROCESS | 1638 | 09:32:41 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 09:32:42 INFO - PROCESS | 1638 | RSS: Main: 381267968 09:32:42 INFO - PROCESS | 1638 | 09:32:42 INFO - PROCESS | 1638 | __start_tp_report 09:32:42 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 09:32:42 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 09:32:42 INFO - PROCESS | 1638 | |i|pagename|runs| 09:32:42 INFO - PROCESS | 1638 | |0;dojo.html;3508.3334166508366;3516.5252690886723;3530.3998320285555;3553.413686741688;3587.3363427765867;5828.854278643031;5913.526917846572;5923.229980102581;5937.40625937406;5940.227770389854;5683.772649094031;5902.527797776178;5979.701014949257;5993;6001.939980600193;5275.920861187085;5324.92012619811;5328.5470734987575;5439.5376393006645;5447.210154527591;5277.340332458442;5300.973495132519;5303.28405665236;5304.708241046741;5425.6202065855405;5349.197620356958;5434.184872269152;5434.7826086956475;5449.509544141027;5474.151506516477;5399.271098401705;5406.216098665691;5409.540189083933;5411.540019098381;5418.2685337479725;5225.764840582183;5247.081760691864;5291.788328466857;5328.387235467932;5399.271098401705;5778.219940308089;5790.797322093748;5880.5883588148845;5884.264466941632;5917.704114794286;6289.182406287154;6321.759028952352;6369.904451433232;6381.042843573455;6384.361563843579;6298.433141017331;6301.7164227609865;6302.87394252117;6308.621482711006;6325.557210995232;5610.382857885629;5760.913586296167;5831.708414579254;5857.824265271964;5895.852603684943;5366.248725178478;6304.401081897213;6312.895243332398;6350.714217860115;6364.363563643691;6292.738724968685;6301.747930082745;6303.149074874925;6308.053791931247;6309.810705678837;6218.533609979179;6239.656818875005;6271.62370257786;6311.779087731908;6320.936790632127;6354.9514330135935;6377.74489020434;6386.808395748135;6390.488760899117;6399.104125422445;6262.3111457739615;6358.1416508771645;6370.394812492806;6399.968000159969;6403.103565500834;4952.133376659071;5013.348264725635;5032.169692000852;5089.796408143633;5165.767540460688;4522.683412161117;4554.840580579664;4555.544445555418;4570.291604801261;4608.769561521977;6112.205413296243;6128.754849805958;6132.816015519542;6137.355577664281;6146.815595532141;6200.503959683215;6213.65824879627;6237.157983672237;6289.056641503811;6290.402411770874;6085.756569737249;6140.513092197578;6143.109249158847;6147.293061297919;6150.292716337589;5554.586719415668;5560.499555040065;5567.888642227133;5575.247341608912;5589.105743081088;6264.59280146789;6309.810705678837;6473.643949582818;6477.514186436036;6489.286178520453;5002.424721157114;6197.25632924052;6248.750049997949;6260.092286618506;6301.684915754102;6412.647304398303;6452.9997850333275;6471.644059576768;6483.708233129426;6486.189226346707;6186.566940314135;6366.395192456709;6372.171617689671;6386.584871983307;6387.105805187184;4896.36347274852;6165.70520190747;6211;6229.56393052482;6305.148804911279;6303.873922521432;6314.1160237565855;6322.589031712924;6323.494120470259;6328.6519241442165;6258.593191442542;6284.654344010941;6318.652474113784;6320.905186422299;6337.96831015842;5986.132010858489;6065.545084118797;6114.723190878713;6117.92936236148;6126.1423400724825;6105.633661980295;6223;6324.525660575383;6340.397662222082;6355.1420558224045;6027.246594175728;6071.39286071407;6156.569040167145;6196.349383314687;6201.937980620317 09:32:42 INFO - PROCESS | 1638 | |1;ext.html;510.0589412533874;520.232656831174;526.4551189518847;532.9474288280644;542.4846395923873;31673.68326316739;33429.33141337175;41953.37069943953;42676.78661606688;42975.14049719004;44231.55768442315;44452.555474445246;44485;44487.77756111223;44591;9646.469444180568;9810.558524866363;9832.655857045005;9835.754106147368;9841.852372214422;7696.9615151924445;9233.907660923405;9257.444553326788;9373.953130234338;9374.531273436334;11978.401079946012;12222.511099556052;12262.957648599835;12287.877121228807;12299.139060265785;11907;11981.640550783402;11986.760264794742;12021.93989030058;12033.39833008346;11731.17881748278;11822.290662560274;11825.526978920832;11832.284318773816;11846.644600661994;41055.794721026505;41258.9685257868;41262;41322;41388.793056034825;3464.012756364424;3472.2013936794424;3599.992002239377;3763.284975854579;3872.5933776953298;30102.84948575265;31482.842585787155;31590.526142107887;31689.52465713016;32093;3165.5251712243116;3202.6316973547873;3206.1824234820206;3292.604887413526;3338.165458635341;536138;538725;542111;542859;544215.2789236068;63479.68260158762;63879.361206387344;63981;64071.67964160242;64208.715825683226;35827.92516224518;36379.90860274196;36537.45193822095;37794.62205377966;68447.65776171087;16215.594610134605;16327.755083673754;16347.264373103239;16366.099864507329;16374;9743.464109474047;12425.502979880703;12430.005599552014;12433.502659893684;12456;17276.913615431844;17672.823271767375;19350.612987740165;19614.509637258896;19619.01904904749;7779.3776497880035;7781.688732450639;7819.804504887424;7824.452288339876;7830.2952734254195;943.598970437575;1005.9195264378978;1014.9188064954786;1061.543536279392;1067.7277294289906;24195.274141775775;29945.850270748506;30008.399832003674;30978.380432391226;31031.534526982112;951.5432592355708;960.5149399553181;1080.8596930238673;1103.542030057533;1136.1649187846926;12724.872751272369;15425.614359640875;15733.842661573466;15896.602584935468;16065.518034458984;709556;715622;716897;717662;718794;58075;58941.410585893595;59529.40470595325;59945.801083978076;60138.79722405528;1261.1928365845865;1306.477409036393;1350.8041334006318;1404.5435233548933;1423.9074460160057;30107.69892301049;31191.84404077965;31625.8418707905;31788.8410557955;31870.52194217042;46315;46930.76534617305;47302.763486182346;47416.7629161852;47483;559747;560876;561271;561691;563079;24769.25692229236;25361.873190633927;26816.06143784958;27541.44917101687;27554.724452755217;47001.529984699715;47207.763961179975;47318;47798.52201477941;48509.51490485191;31488.842555787076;39590.802045989585;39988.40017399683;40062.599374005884;40204.1959160821;38102;38349;39144.80427597958;40333.39499907445;40434.39348409717;38456.81692291507;39156;39328.41007384834;39359.40960885532;39621.60378396294;32528.698852045654;34350.65649343475;34502.48246276358;34980.30039399147;35131.824340878135;25551.23346299614;25622.871885640452;25720.871395642902;26297.474050519264;26401.867990659925 09:32:42 INFO - PROCESS | 1638 | |2;jquery.html;335.18549923685447;358.27449414934756;389.62595907928386;399.53055160186784;405.57617289932017;16963.491095267145;19255.859142641864;20524.8973755131;21241.15035398582;21443.463913402175;20101;20296.188152473882;20626.1749530019;20659.38021859343;20803.16787328505;5737.942620573793;5743.684097374643;6044.909326360108;6049.697515124226;6050.727717252734;4037.8788636340955;6051.334353221142;6105.938940610604;6106.389361063881;6109.14471973924;4202.726822756526;4207.894802629929;4246.532881383046;4263.850765223217;4297.763623000734;6632.767853125141;6699.732010719566;6701.2963638817955;6710.83222919426;6717.059611654372;5175.508326708994;5457.836264912019;5503.367112782042;5560.110382338807;5954.910676339859;13442.663933401744;13603.047786654937;13686.31568421575;18864.5283867903;25380.096492762932;2174.5868285025795;2270.9545809083725;2536.9112081077074;2602.9088981885543;2859.771218302531;9635.421874687541;9897.257705672031;10140.442275674835;10171.135453486462;10521.316114452613;1778.457570441015;1833.7982821889582;1846.2707230643955;1909.6944488881852;1922.2215002923838;81641.59179204125;96411;116105.83894161035;121867;122520;11527.76944461106;11696;11759.412029398496;11771.470283837249;11952.701182470508;14679.339429725687;14938.32777525014;14942.70114597702;14958.551243462714;14984.850151498564;8343.8331233375;8396.706115285935;8408.369372297102;8494.830103397897;8501.277391421798;8226.341892648574;8265.421420500628;8266.917330826735;8344.374171937128;8436.24073833358;4511.909761804811;4635.1656701794;4641.071785642885;4683.2038553446;4708.293755936568;1886.3586380630652;1939.3406241877829;1951.6389467948475;1963.7152612871055;1963.891985940787;872.445996792029;918.8713580098791;927.7912469694264;975.3513913247752;997.3866072365588;19920.50198745014;20744.688829667568;20758.962051897346;20826.958652067337;20880.582388352148;884.3146561414826;921.2767977137914;925;934.1452570897552;958.6405098088217;7977.641006154737;10705;10911.890881091247;10951.123910087173;10970.396628185526;367758;472310;492983;561375;618563;98033;112097.87902120875;114378;125652;132149;938.9530523473935;957.1242313283407;981.5533932060895;994.4635538093663;996.9482196282846;18464.723029154306;19073;19405.70891436658;19436.02819858973;19477.22091116396;56650.150247747144;56762;56882.14676779934;58049.419505806094;58306;78665.21334786579;79562.602186991;81987.5900620493;83413.58293208494;84549.57725211335;8045.758627241192;8081.878771818545;8143.714969976022;8238.423310368216;8396.160383961555;11189.496472658588;12250.009979641432;12680.6829829255;12845.486180552673;12920.741585168433;8218.712345068134;11047.281926674741;11117.388543629855;11278.718032049264;11431.314121152758;10422.843657345298;11161.944190278997;11388.430578470878;11699.473523691624;11873.940630296793;9995.750106247402;11420.428978550874;11728.120390970882;12088.335141566946;12152.696182595506;7996.800079998046;8201.630926608197;8388.993320801543;8413.663453461793;8574.22831945128;11409.54361825551;11491.827622585835;11540.134489913122;11627.360495172847;11848.111391645833 09:32:42 INFO - PROCESS | 1638 | |3;mootools.html;1496.3640452807558;1536.9846301536984;1701.4895531340594;1840.7238914162865;1851.4908400189954;8166.550839703814;8600;8612.267957223643;8616.224539791418;8637.438566493174;7605.619719014055;7815.843683126334;8134.023917129938;8306.54314012729;8413.663453461853;2013.32553594546;2358.7759162879543;2394.449276666368;2399.8560086394787;2403.002753857147;2368.7039120109985;2381.3570336009266;2421.055788242587;2425.854448733082;2426.466177440969;2117.544727883512;2266.784655457729;2382.118616112032;2399.256230568529;2408.6989126359204;1952.326447375653;2368.6802281691926;2389.988050059756;2395.5568219879206;2399.1243196233336;2386.928392148221;2409.7831195192516;2417.721961974378;2417.987910060456;2418.6372044193336;8492.235698787139;8540;8541.06048334689;8554.914450855475;8571.314294856396;4915.754212289371;5256.448072952323;5257.526822585947;5257.737113144366;5260.421353651095;3303.711552494529;3453.4474484082675;3599.892003239907;3606.6032736398975;3608.4767708682093;1040.9895901040968;1072.0565902006185;1095.1731442760745;1100.741325788439;1110.983450143118;9363.765905852408;11063.225574209808;11180.385078820662;11185;11256.887431125666;3680.7607505512055;4644.442666879929;4723.173444647173;4726.220173671374;4774.4509381420885;8070.273675369128;9556.713298601053;9559;9562.235021198287;9589.664361747306;5290.81482148123;5297.205419187076;5298.602604804655;5299.49654782795;5310.522053015247;4288.742675439484;4331.826726930951;4807.78364973577;4875.853724388274;4884.877878053077;3235.8058516489086;3854.3640299350855;3941.2511622791576;3972.82122304497;4011.7592944423427;1284.9678758031123;1285.7042880137622;1293.6313150752178;1294.6892745740954;1308.9280089595163;766.5324152267112;867.6225841758729;917.4907926101077;917.7659696777279;931.1898648175995;5609.8597535061135;5634.267545219095;5676.8864622707315;5779.104238842986;5978.282606087298;917.4678686361895;919.3518569408685;952.8761261036021;964.2912459342377;1017.659084206799;3653.178034942117;3678.3378991781738;3810.704360517437;3891.494105766232;3908.2769687607883;10004.149647279917;10295.227857910537;10430.68707938763;10439.478026098664;10440.947795260976;10353.689389318182;10389.584416623251;10399;10401.167906567456;10407;7594.658240379306;7852.685892564234;7993.000874890638;8006.039275286887;8032.558209298545;5766.94233057664;5837.67892765902;5894.557908156991;6024.457798798129;6045.335013148462;9169.724908252763;9530.666426675032;9602.759931001501;9648.807023859625;9649.421034737938;9521.428714277166;9720;9742.95128524353;9863.112319891245;9869.851952220579;6535.771248006297;6720.193576770819;6905.551139175937;7232.566046037255;7369.77890663281;7830.451868369388;8107.1892810718455;8112.18878112184;8126.471779334324;8160.5103693778565;6968.825779355354;7066.787996359912;7077.433805295667;7104.360607545345;7214.675339609835;6898.172219333712;6910.654467276516;6957.2694867038235;6979.1625004997695;6999.860002800017;6598.934010660024;6617;6705.530612857053;6708.563943343667;6715.026321183499;4168.749875007509;4763.809447622057;4816.470188279357;4843.321934929183;4907.288443175648;4748.192807222711;4770.499097594841;4775.594074503567;4985.052839960396;5034.018366418513 09:32:42 INFO - PROCESS | 1638 | |4;prototype.html;262.58904813966143;310.4458541503415;317.62044356993385;322.7805092537074;323.91254361322444;4306.246406878796;5217.50433708798;5274.762635681394;5310.548603368708;5330.960462709773;4784.40194975628;4973.577245934091;5024.693579669285;5088.414832294287;5098.77055532501;3621.8189090545497;3797.8480860765603;3948;3963.425303331015;4041.7777022263763;4016.0361513236903;4031.1937612477477;4040.5555388907196;4056.4523789288364;4067.9186416271655;3878.5151856017997;3978.2242462719782;4009.8596549120784;4012.0571665658695;4021.718479706422;3574.1422058705984;3782.243551289753;4005.816829827751;4011.338129208677;4020;2828.603995440619;3355.7147642450423;3510.473428985647;3520.348735483918;3537.133402316449;4187.748735075906;4901.607871370282;4955.240889484217;5071.644984851062;5075.796968121271;3522.947155792665;3832.9425058624142;4360.454943132108;4544.341070544786;4592.334111553806;5276.630635855492;5437.4775062982035;5495;5510.504054635062;5529.3364796224305;3619.4663735385334;3864.0726225705907;3883.262180185756;3885.2812229737588;3885.8834234972996;4722.76386180693;5069.451384031193;5109.310243117169;5743.856403589902;5803.187553742479;3928.253631809947;3929.7031979446715;3942.842286308573;3952.407138929126;3952.9642234249386;3667.972967569085;3969.206158768258;3981.5620281768984;4005;4011.3782363733667;4149.647279981175;4334.802283864441;4543.568361005699;4566.611837993808;4573.451185857718;5028.767951851746;5034.446210916796;5056.089903817275;5492.022871766161;5493.862653433696;1239.8512178538633;1259.5213818749;1292.926870697319;1301.6225294664441;1305.2038256663427;756.6292516666794;826.6362800367818;848.2365870716282;859.2138193552829;894.0255121917141;4029.7179197456485;4117.382392641068;4390.319500477431;4926.33977652071;5001.424836143818;4581.625512346282;4879.926801097987;5081.28861959326;5115.462876397999;5178.456262092502;3957.55549224531;4294.613484786321;4763.359380388825;4881.511848815161;4891.288049182757;2326.3835083702834;2556.2331300610113;2619.751123643289;2694.582339737344;2776.4035679484377;5116.846494605168;5525.917111243334;5535.335759708861;5567.415421380778;5585.804496842672;5237.240600112962;5381.327334083239;5435.173709671028;5926.318473375531;5930.525557955353;5188.63679542436;5583.878126312056;5713.028785106459;6005.6396616203165;6007.30915944672;5081.669691470042;5081.77132029067;5685.709895970138;5749.310082790092;5755.71221438918;5538.280023596906;5648;5684.914726279027;5690.573207009574;5719.942800571941;5237.319148510669;5398.4871437213405;5658.755073883739;5926.377730338252;5979.850503737442;3644;3842.1557652327597;3862.613738626227;3877.360235561101;3879.4568760374136;5631;5655.095184770417;5671.829845104653;5678;5687.857803554944;5473.370562385377;5477.945220547744;5521.089020311764;5546.502444339925;5555.916661250165;4760.9285860711425;5271.630985831109;5279.973600131974;5425.918611220756;5478.835634930959;5338.9055243674175;5364.544013758874;5369.731513424391;5376.301080859464;5390.4879036491475;4590.140992897882;4805.567498925114;5345.808218630343;5426.7829286829665;5525.834224973257;5122.463261021753;5404.270423492778;5458.397457677914;5461.5357694596405;5483.725813709379 09:32:42 INFO - PROCESS | 1638 | |5;yui.html;657.5857209957726;691.847793485433;725.7858931615173;750.504666919833;765.4106338119648;14342.498012569562;15475.380984760624;15478.148701821396;15505.30226139825;15514.30185641646;13903.652408689788;13944;13963.162210267392;14010.649733756662;14070.788938165935;705.929407059295;730.6529398535706;851.5188918261193;867.3754896474528;887.5029983209423;888.6711916590871;889.3374436045156;889.6975028490313;890;891.3092353426114;945.1021529546923;949.9477528735916;951.7906060666677;952.1478276942132;952.2477242978039;936.2463217110223;936.840737074699;940.3652534539159;941.8398872191743;942.4627962061628;700.7407259314035;702.764573867755;703.3775109028546;703.6587255181233;704.4223736536043;14092.718145637133;14130.50543230982;14138.575842724631;14143.929280353532;14834.33245503944;13006.674833129153;13121.671958201121;13356.398962046731;13490.662733431645;13720.108192967526;10643;10912.290701104403;11030.448477576168;11147.665570032912;11267.887321126766;3578.7137029037876;3676.761010534307;3681.5582130144285;3714.7771133731794;3724.553053633554;81391.18608813896;81441.59279203626;81829;84568;86199;7581.431392645573;9745.415275083518;9865.654702085536;9950.751231219278;10154.644587439405;18914.43256702301;19481.90259048724;19501.90249048774;21393.358199254046;21512;7401.925980740231;7618.5809780461495;7634.658325169147;7698.499597526143;7834.569098699512;3989.3218152914073;4085.5914408558906;4127.9174416511505;4197.727147735387;4257.680673949404;3527.9294414112087;3644.7630903991158;3648.6533779290926;3650.926981460356;3659.9451008234896;642.5566359212129;647.1296106736432;655.9737610495622;662.1788981662703;663.873863965845;576.1789450033685;589.4753669234385;594.3462191589304;649.3344322069917;650.3691419323249;8857.335699822539;9003.549822508849;9127.132922372364;9366.063393660716;9424.293178011676;614.8985417406167;621.3072424246932;632.7152781248457;667.3060017581757;692.608676098003;4352.673549483801;4376.256036473807;4475.283954567253;4480.932786008212;4518.482441928671;106529;115758;116894;119407.40296298463;124491.37754311171;61828.69085654543;62705.68647156735;73965.89051164237;93568.06431935729;99654.5017274909;83604.58197708972;87451.56274218588;89469.55265223763;93946.59080113804;97617.51191243998;9421.15209631109;9889.26937785899;9922.801543968935;9940.850887236842;9972.750681233027;36778.63221367752;48883.53349399524;49318;52924;55715.721421392635;56028.71985640046;70334;80212.59893700494;82020;84623;11941.343226122646;11990.820137697767;12528.436220369922;12717.345736929119;13254.53609123676;13946.790798137834;14187.503437379642;14338.022167499756;14649.70700585961;14964;12918.677033074247;13118;13132.409041593342;13291.136076155406;13538.458461661818;10288.537015834456;12237.632871013884;12381.257124572554;12590.24458532491;12691.873081269068;11805.586804461802;11940.880591193976;12153.574624888086;12517.749645006867;12823.61529154127;9901.207903367569;10049.648262310784;10371.357666121055;10970.380468459536;11066.225364224427;10936.50785714629;11396.715082123013;11487.770244595229;11724.41377931083;11761.588344408246 09:32:42 INFO - PROCESS | 1638 | __end_tp_report 09:32:42 INFO - PROCESS | 1638 | __start_cc_report 09:32:42 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,1208 09:32:42 INFO - PROCESS | 1638 | __end_cc_report 09:32:42 INFO - PROCESS | 1638 | __startTimestamp1485797562045__endTimestamp 09:32:42 INFO - PROCESS | 1638 | 09:32:42 INFO - PROCESS | 1638 | ------- Summary: start ------- 09:32:42 INFO - PROCESS | 1638 | Number of tests: 6 09:32:42 INFO - PROCESS | 1638 | 09:32:42 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5875.83 Median:6143.11 stddev:633.11 (10.3%) stddev-sans-first:607.20 09:32:42 INFO - PROCESS | 1638 | Values: 3508.3 3516.5 3530.4 3553.4 3587.3 5828.9 5913.5 5923.2 5937.4 5940.2 5683.8 5902.5 5979.7 5993.0 6001.9 5275.9 5324.9 5328.5 5439.5 5447.2 5277.3 5301.0 5303.3 5304.7 5425.6 5349.2 5434.2 5434.8 5449.5 5474.2 5399.3 5406.2 5409.5 5411.5 5418.3 5225.8 5247.1 5291.8 5328.4 5399.3 5778.2 5790.8 5880.6 5884.3 5917.7 6289.2 6321.8 6369.9 6381.0 6384.4 6298.4 6301.7 6302.9 6308.6 6325.6 5610.4 5760.9 5831.7 5857.8 5895.9 5366.2 6304.4 6312.9 6350.7 6364.4 6292.7 6301.7 6303.1 6308.1 6309.8 6218.5 6239.7 6271.6 6311.8 6320.9 6355.0 6377.7 6386.8 6390.5 6399.1 6262.3 6358.1 6370.4 6400.0 6403.1 4952.1 5013.3 5032.2 5089.8 5165.8 4522.7 4554.8 4555.5 4570.3 4608.8 6112.2 6128.8 6132.8 6137.4 6146.8 6200.5 6213.7 6237.2 6289.1 6290.4 6085.8 6140.5 6143.1 6147.3 6150.3 5554.6 5560.5 5567.9 5575.2 5589.1 6264.6 6309.8 6473.6 6477.5 6489.3 5002.4 6197.3 6248.8 6260.1 6301.7 6412.6 6453.0 6471.6 6483.7 6486.2 6186.6 6366.4 6372.2 6386.6 6387.1 4896.4 6165.7 6211.0 6229.6 6305.1 6303.9 6314.1 6322.6 6323.5 6328.7 6258.6 6284.7 6318.7 6320.9 6338.0 5986.1 6065.5 6114.7 6117.9 6126.1 6105.6 6223.0 6324.5 6340.4 6355.1 6027.2 6071.4 6156.6 6196.3 6201.9 09:32:42 INFO - PROCESS | 1638 | 09:32:42 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:73161.25 Median:20778.95 stddev:163587.56 (787.3%) stddev-sans-first:163955.52 09:32:42 INFO - PROCESS | 1638 | Values: 510.1 520.2 526.5 532.9 542.5 31673.7 33429.3 41953.4 42676.8 42975.1 44231.6 44452.6 44485.0 44487.8 44591.0 9646.5 9810.6 9832.7 9835.8 9841.9 7697.0 9233.9 9257.4 9374.0 9374.5 11978.4 12222.5 12263.0 12287.9 12299.1 11907.0 11981.6 11986.8 12021.9 12033.4 11731.2 11822.3 11825.5 11832.3 11846.6 41055.8 41259.0 41262.0 41322.0 41388.8 3464.0 3472.2 3600.0 3763.3 3872.6 30102.8 31482.8 31590.5 31689.5 32093.0 3165.5 3202.6 3206.2 3292.6 3338.2 536138.0 538725.0 542111.0 542859.0 544215.3 63479.7 63879.4 63981.0 64071.7 64208.7 35827.9 36379.9 36537.5 37794.6 68447.7 16215.6 16327.8 16347.3 16366.1 16374.0 9743.5 12425.5 12430.0 12433.5 12456.0 17276.9 17672.8 19350.6 19614.5 19619.0 7779.4 7781.7 7819.8 7824.5 7830.3 943.6 1005.9 1014.9 1061.5 1067.7 24195.3 29945.9 30008.4 30978.4 31031.5 951.5 960.5 1080.9 1103.5 1136.2 12724.9 15425.6 15733.8 15896.6 16065.5 709556.0 715622.0 716897.0 717662.0 718794.0 58075.0 58941.4 59529.4 59945.8 60138.8 1261.2 1306.5 1350.8 1404.5 1423.9 30107.7 31191.8 31625.8 31788.8 31870.5 46315.0 46930.8 47302.8 47416.8 47483.0 559747.0 560876.0 561271.0 561691.0 563079.0 24769.3 25361.9 26816.1 27541.4 27554.7 47001.5 47207.8 47318.0 47798.5 48509.5 31488.8 39590.8 39988.4 40062.6 40204.2 38102.0 38349.0 39144.8 40333.4 40434.4 38456.8 39156.0 39328.4 39359.4 39621.6 32528.7 34350.7 34502.5 34980.3 35131.8 25551.2 25622.9 25720.9 26297.5 26401.9 09:32:42 INFO - PROCESS | 1638 | 09:32:42 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:31742.79 Median:394.58 stddev:85661.80 (21709.7%) stddev-sans-first:85869.64 09:32:42 INFO - PROCESS | 1638 | Values: 335.2 358.3 389.6 399.5 405.6 16963.5 19255.9 20524.9 21241.2 21443.5 20101.0 20296.2 20626.2 20659.4 20803.2 5737.9 5743.7 6044.9 6049.7 6050.7 4037.9 6051.3 6105.9 6106.4 6109.1 4202.7 4207.9 4246.5 4263.9 4297.8 6632.8 6699.7 6701.3 6710.8 6717.1 5175.5 5457.8 5503.4 5560.1 5954.9 13442.7 13603.0 13686.3 18864.5 25380.1 2174.6 2271.0 2536.9 2602.9 2859.8 9635.4 9897.3 10140.4 10171.1 10521.3 1778.5 1833.8 1846.3 1909.7 1922.2 81641.6 96411.0 116105.8 121867.0 122520.0 11527.8 11696.0 11759.4 11771.5 11952.7 14679.3 14938.3 14942.7 14958.6 14984.9 8343.8 8396.7 8408.4 8494.8 8501.3 8226.3 8265.4 8266.9 8344.4 8436.2 4511.9 4635.2 4641.1 4683.2 4708.3 1886.4 1939.3 1951.6 1963.7 1963.9 872.4 918.9 927.8 975.4 997.4 19920.5 20744.7 20759.0 20827.0 20880.6 884.3 921.3 925.0 934.1 958.6 7977.6 10705.0 10911.9 10951.1 10970.4 367758.0 472310.0 492983.0 561375.0 618563.0 98033.0 112097.9 114378.0 125652.0 132149.0 939.0 957.1 981.6 994.5 996.9 18464.7 19073.0 19405.7 19436.0 19477.2 56650.2 56762.0 56882.1 58049.4 58306.0 78665.2 79562.6 81987.6 83413.6 84549.6 8045.8 8081.9 8143.7 8238.4 8396.2 11189.5 12250.0 12680.7 12845.5 12920.7 8218.7 11047.3 11117.4 11278.7 11431.3 10422.8 11161.9 11388.4 11699.5 11873.9 9995.8 11420.4 11728.1 12088.3 12152.7 7996.8 8201.6 8389.0 8413.7 8574.2 11409.5 11491.8 11540.1 11627.4 11848.1 09:32:42 INFO - PROCESS | 1638 | 09:32:42 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5510.89 Median:5145.23 stddev:3023.13 (58.8%) stddev-sans-first:3016.56 09:32:42 INFO - PROCESS | 1638 | Values: 1496.4 1537.0 1701.5 1840.7 1851.5 8166.6 8600.0 8612.3 8616.2 8637.4 7605.6 7815.8 8134.0 8306.5 8413.7 2013.3 2358.8 2394.4 2399.9 2403.0 2368.7 2381.4 2421.1 2425.9 2426.5 2117.5 2266.8 2382.1 2399.3 2408.7 1952.3 2368.7 2390.0 2395.6 2399.1 2386.9 2409.8 2417.7 2418.0 2418.6 8492.2 8540.0 8541.1 8554.9 8571.3 4915.8 5256.4 5257.5 5257.7 5260.4 3303.7 3453.4 3599.9 3606.6 3608.5 1041.0 1072.1 1095.2 1100.7 1111.0 9363.8 11063.2 11180.4 11185.0 11256.9 3680.8 4644.4 4723.2 4726.2 4774.5 8070.3 9556.7 9559.0 9562.2 9589.7 5290.8 5297.2 5298.6 5299.5 5310.5 4288.7 4331.8 4807.8 4875.9 4884.9 3235.8 3854.4 3941.3 3972.8 4011.8 1285.0 1285.7 1293.6 1294.7 1308.9 766.5 867.6 917.5 917.8 931.2 5609.9 5634.3 5676.9 5779.1 5978.3 917.5 919.4 952.9 964.3 1017.7 3653.2 3678.3 3810.7 3891.5 3908.3 10004.1 10295.2 10430.7 10439.5 10440.9 10353.7 10389.6 10399.0 10401.2 10407.0 7594.7 7852.7 7993.0 8006.0 8032.6 5766.9 5837.7 5894.6 6024.5 6045.3 9169.7 9530.7 9602.8 9648.8 9649.4 9521.4 9720.0 9743.0 9863.1 9869.9 6535.8 6720.2 6905.6 7232.6 7369.8 7830.5 8107.2 8112.2 8126.5 8160.5 6968.8 7066.8 7077.4 7104.4 7214.7 6898.2 6910.7 6957.3 6979.2 6999.9 6598.9 6617.0 6705.5 6708.6 6715.0 4168.7 4763.8 4816.5 4843.3 4907.3 4748.2 4770.5 4775.6 4985.1 5034.0 09:32:42 INFO - PROCESS | 1638 | 09:32:42 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4416.58 Median:4987.50 stddev:1356.18 (27.2%) stddev-sans-first:1323.66 09:32:42 INFO - PROCESS | 1638 | Values: 262.6 310.4 317.6 322.8 323.9 4306.2 5217.5 5274.8 5310.5 5331.0 4784.4 4973.6 5024.7 5088.4 5098.8 3621.8 3797.8 3948.0 3963.4 4041.8 4016.0 4031.2 4040.6 4056.5 4067.9 3878.5 3978.2 4009.9 4012.1 4021.7 3574.1 3782.2 4005.8 4011.3 4020.0 2828.6 3355.7 3510.5 3520.3 3537.1 4187.7 4901.6 4955.2 5071.6 5075.8 3522.9 3832.9 4360.5 4544.3 4592.3 5276.6 5437.5 5495.0 5510.5 5529.3 3619.5 3864.1 3883.3 3885.3 3885.9 4722.8 5069.5 5109.3 5743.9 5803.2 3928.3 3929.7 3942.8 3952.4 3953.0 3668.0 3969.2 3981.6 4005.0 4011.4 4149.6 4334.8 4543.6 4566.6 4573.5 5028.8 5034.4 5056.1 5492.0 5493.9 1239.9 1259.5 1292.9 1301.6 1305.2 756.6 826.6 848.2 859.2 894.0 4029.7 4117.4 4390.3 4926.3 5001.4 4581.6 4879.9 5081.3 5115.5 5178.5 3957.6 4294.6 4763.4 4881.5 4891.3 2326.4 2556.2 2619.8 2694.6 2776.4 5116.8 5525.9 5535.3 5567.4 5585.8 5237.2 5381.3 5435.2 5926.3 5930.5 5188.6 5583.9 5713.0 6005.6 6007.3 5081.7 5081.8 5685.7 5749.3 5755.7 5538.3 5648.0 5684.9 5690.6 5719.9 5237.3 5398.5 5658.8 5926.4 5979.9 3644.0 3842.2 3862.6 3877.4 3879.5 5631.0 5655.1 5671.8 5678.0 5687.9 5473.4 5477.9 5521.1 5546.5 5555.9 4760.9 5271.6 5280.0 5425.9 5478.8 5338.9 5364.5 5369.7 5376.3 5390.5 4590.1 4805.6 5345.8 5426.8 5525.8 5122.5 5404.3 5458.4 5461.5 5483.7 09:32:42 INFO - PROCESS | 1638 | 09:32:42 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:20140.06 Median:26701.01 stddev:29630.21 (111.0%) stddev-sans-first:29677.22 09:32:42 INFO - PROCESS | 1638 | Values: 657.6 691.8 725.8 750.5 765.4 14342.5 15475.4 15478.1 15505.3 15514.3 13903.7 13944.0 13963.2 14010.6 14070.8 705.9 730.7 851.5 867.4 887.5 888.7 889.3 889.7 890.0 891.3 945.1 949.9 951.8 952.1 952.2 936.2 936.8 940.4 941.8 942.5 700.7 702.8 703.4 703.7 704.4 14092.7 14130.5 14138.6 14143.9 14834.3 13006.7 13121.7 13356.4 13490.7 13720.1 10643.0 10912.3 11030.4 11147.7 11267.9 3578.7 3676.8 3681.6 3714.8 3724.6 81391.2 81441.6 81829.0 84568.0 86199.0 7581.4 9745.4 9865.7 9950.8 10154.6 18914.4 19481.9 19501.9 21393.4 21512.0 7401.9 7618.6 7634.7 7698.5 7834.6 3989.3 4085.6 4127.9 4197.7 4257.7 3527.9 3644.8 3648.7 3650.9 3659.9 642.6 647.1 656.0 662.2 663.9 576.2 589.5 594.3 649.3 650.4 8857.3 9003.5 9127.1 9366.1 9424.3 614.9 621.3 632.7 667.3 692.6 4352.7 4376.3 4475.3 4480.9 4518.5 106529.0 115758.0 116894.0 119407.4 124491.4 61828.7 62705.7 73965.9 93568.1 99654.5 83604.6 87451.6 89469.6 93946.6 97617.5 9421.2 9889.3 9922.8 9940.9 9972.8 36778.6 48883.5 49318.0 52924.0 55715.7 56028.7 70334.0 80212.6 82020.0 84623.0 11941.3 11990.8 12528.4 12717.3 13254.5 13946.8 14187.5 14338.0 14649.7 14964.0 12918.7 13118.0 13132.4 13291.1 13538.5 10288.5 12237.6 12381.3 12590.2 12691.9 11805.6 11940.9 12153.6 12517.7 12823.6 9901.2 10049.6 10371.4 10970.4 11066.2 10936.5 11396.7 11487.8 11724.4 11761.6 09:32:42 INFO - PROCESS | 1638 | -------- Summary: end -------- 09:32:42 INFO - PROCESS | 1638 | 09:32:42 INFO - TEST-INFO | 1638: exit 0 09:32:42 INFO - TEST-OK | dromaeo_css | took 1116824ms 09:32:42 INFO - TEST-START | kraken 09:32:42 INFO - operating with platform_type : mac_ 09:32:42 INFO - Initialising browser for kraken test... 09:32:42 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/tmp6vCidN/profile http://localhost:49241/getInfo.html) 09:32:45 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 09:32:45 INFO - PROCESS | 1649 | colorDepth:24 09:32:45 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 09:32:45 INFO - PROCESS | 1649 | __metrics 09:32:45 INFO - PROCESS | 1649 | 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" 09:32:45 INFO - PROCESS | 1649 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:32:46 INFO - TEST-INFO | 1649: exit 0 09:32:46 INFO - Browser initialized. 09:32:46 INFO - Running cycle 1/1 for kraken test... 09:32:46 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/T/tmp6vCidN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:32:58 INFO - PROCESS | 1651 | RSS: Main: 171991040 09:32:58 INFO - PROCESS | 1651 | 09:33:00 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 09:33:01 INFO - PROCESS | 1651 | RSS: Main: 221892608 09:33:01 INFO - PROCESS | 1651 | 09:33:04 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 09:33:04 INFO - PROCESS | 1651 | RSS: Main: 232972288 09:33:04 INFO - PROCESS | 1651 | 09:33:07 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 09:33:08 INFO - PROCESS | 1651 | RSS: Main: 330399744 09:33:08 INFO - PROCESS | 1651 | 09:33:10 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 09:33:11 INFO - PROCESS | 1651 | RSS: Main: 233312256 09:33:11 INFO - PROCESS | 1651 | 09:33:13 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:33:13 INFO - PROCESS | 1651 | RSS: Main: 235425792 09:33:13 INFO - PROCESS | 1651 | 09:33:16 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 09:33:17 INFO - PROCESS | 1651 | RSS: Main: 274993152 09:33:17 INFO - PROCESS | 1651 | 09:33:19 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 09:33:20 INFO - PROCESS | 1651 | RSS: Main: 275443712 09:33:20 INFO - PROCESS | 1651 | 09:33:23 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 09:33:24 INFO - PROCESS | 1651 | RSS: Main: 273358848 09:33:24 INFO - PROCESS | 1651 | 09:33:25 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:33:26 INFO - PROCESS | 1651 | RSS: Main: 247787520 09:33:26 INFO - PROCESS | 1651 | 09:33:28 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:33:28 INFO - PROCESS | 1651 | RSS: Main: 250335232 09:33:28 INFO - PROCESS | 1651 | 09:33:30 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:33:31 INFO - PROCESS | 1651 | RSS: Main: 253419520 09:33:31 INFO - PROCESS | 1651 | 09:33:34 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:33:34 INFO - PROCESS | 1651 | RSS: Main: 271011840 09:33:34 INFO - PROCESS | 1651 | 09:33:38 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:33:38 INFO - PROCESS | 1651 | RSS: Main: 264183808 09:33:38 INFO - PROCESS | 1651 | 09:33:40 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 09:33:40 INFO - PROCESS | 1651 | RSS: Main: 308588544 09:33:40 INFO - PROCESS | 1651 | 09:33:40 INFO - PROCESS | 1651 | __start_tp_report 09:33:40 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 09:33:40 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 09:33:40 INFO - PROCESS | 1651 | |i|pagename|runs| 09:33:40 INFO - PROCESS | 1651 | |0;ai-astar;114;114;115;114;107;106;113;113;115;115 09:33:40 INFO - PROCESS | 1651 | |1;audio-beat-detection;138;105;106;141;107;109;106;108;135;104 09:33:40 INFO - PROCESS | 1651 | |2;audio-dft;184;182;184;182;181;182;180;182;181;182 09:33:40 INFO - PROCESS | 1651 | |3;audio-fft;81;58;58;87;59;58;61;74;99;58 09:33:40 INFO - PROCESS | 1651 | |4;audio-oscillator;87;69;92;70;67;68;89;88;99;124 09:33:40 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;86;88;134;85;92;126;86;83;86;83 09:33:40 INFO - PROCESS | 1651 | |6;imaging-darkroom;110;149;92;93;92;93;95;93;93;94 09:33:40 INFO - PROCESS | 1651 | |7;imaging-desaturate;86;83;82;89;130;123;92;84;84;80 09:33:40 INFO - PROCESS | 1651 | |8;json-parse-financial;52;54;54;54;55;58;58;57;56;56 09:33:40 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;62;71;64;75;71;69;69;68;67;69 09:33:40 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;82;81;81;81;79;76;76;78;81;82 09:33:40 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;140;128;160;183;149;159;130;142;182;138 09:33:40 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;162;169;162;220;209;161;163;162;216;221 09:33:40 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;67;67;69;66;65;66;64;66;66;63 09:33:40 INFO - PROCESS | 1651 | __end_tp_report 09:33:40 INFO - PROCESS | 1651 | __start_cc_report 09:33:40 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1804 09:33:40 INFO - PROCESS | 1651 | __end_cc_report 09:33:40 INFO - PROCESS | 1651 | __startTimestamp1485797620609__endTimestamp 09:33:40 INFO - PROCESS | 1651 | 09:33:40 INFO - PROCESS | 1651 | ------- Summary: start ------- 09:33:40 INFO - PROCESS | 1651 | Number of tests: 14 09:33:40 INFO - PROCESS | 1651 | 09:33:40 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:112.60 Median:114.00 stddev:3.31 (2.9%) stddev-sans-first:3.47 09:33:40 INFO - PROCESS | 1651 | Values: 114.0 114.0 115.0 114.0 107.0 106.0 113.0 113.0 115.0 115.0 09:33:40 INFO - PROCESS | 1651 | 09:33:40 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:115.90 Median:108.50 stddev:15.38 (14.2%) stddev-sans-first:14.08 09:33:40 INFO - PROCESS | 1651 | Values: 138.0 105.0 106.0 141.0 107.0 109.0 106.0 108.0 135.0 104.0 09:33:40 INFO - PROCESS | 1651 | 09:33:40 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:182.00 Median:182.00 stddev:1.25 (0.7%) stddev-sans-first:1.09 09:33:40 INFO - PROCESS | 1651 | Values: 184.0 182.0 184.0 182.0 181.0 182.0 180.0 182.0 181.0 182.0 09:33:40 INFO - PROCESS | 1651 | 09:33:40 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:69.30 Median:67.50 stddev:15.06 (22.3%) stddev-sans-first:15.36 09:33:40 INFO - PROCESS | 1651 | Values: 81.0 58.0 58.0 87.0 59.0 58.0 61.0 74.0 99.0 58.0 09:33:40 INFO - PROCESS | 1651 | 09:33:40 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:85.30 Median:87.50 stddev:17.91 (20.5%) stddev-sans-first:18.99 09:33:40 INFO - PROCESS | 1651 | Values: 87.0 69.0 92.0 70.0 67.0 68.0 89.0 88.0 99.0 124.0 09:33:40 INFO - PROCESS | 1651 | 09:33:40 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:94.90 Median:86.00 stddev:18.77 (21.8%) stddev-sans-first:19.63 09:33:40 INFO - PROCESS | 1651 | Values: 86.0 88.0 134.0 85.0 92.0 126.0 86.0 83.0 86.0 83.0 09:33:40 INFO - PROCESS | 1651 | 09:33:40 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:100.40 Median:93.00 stddev:17.90 (19.2%) stddev-sans-first:18.65 09:33:40 INFO - PROCESS | 1651 | Values: 110.0 149.0 92.0 93.0 92.0 93.0 95.0 93.0 93.0 94.0 09:33:40 INFO - PROCESS | 1651 | 09:33:40 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:93.30 Median:84.00 stddev:17.91 (21.3%) stddev-sans-first:18.80 09:33:40 INFO - PROCESS | 1651 | Values: 86.0 83.0 82.0 89.0 130.0 123.0 92.0 84.0 84.0 80.0 09:33:40 INFO - PROCESS | 1651 | 09:33:40 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:56.00 stddev:1.96 (3.5%) stddev-sans-first:1.64 09:33:40 INFO - PROCESS | 1651 | Values: 52.0 54.0 54.0 54.0 55.0 58.0 58.0 57.0 56.0 56.0 09:33:40 INFO - PROCESS | 1651 | 09:33:40 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:3.66 (5.3%) stddev-sans-first:3.03 09:33:40 INFO - PROCESS | 1651 | Values: 62.0 71.0 64.0 75.0 71.0 69.0 69.0 68.0 67.0 69.0 09:33:40 INFO - PROCESS | 1651 | 09:33:40 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:81.00 stddev:2.31 (2.9%) stddev-sans-first:2.30 09:33:40 INFO - PROCESS | 1651 | Values: 82.0 81.0 81.0 81.0 79.0 76.0 76.0 78.0 81.0 82.0 09:33:40 INFO - PROCESS | 1651 | 09:33:40 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:151.10 Median:154.00 stddev:19.65 (12.8%) stddev-sans-first:20.43 09:33:40 INFO - PROCESS | 1651 | Values: 140.0 128.0 160.0 183.0 149.0 159.0 130.0 142.0 182.0 138.0 09:33:40 INFO - PROCESS | 1651 | 09:33:40 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.50 Median:189.00 stddev:27.81 (14.7%) stddev-sans-first:28.28 09:33:40 INFO - PROCESS | 1651 | Values: 162.0 169.0 162.0 220.0 209.0 161.0 163.0 162.0 216.0 221.0 09:33:40 INFO - PROCESS | 1651 | 09:33:40 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.66 (2.5%) stddev-sans-first:1.72 09:33:40 INFO - PROCESS | 1651 | Values: 67.0 67.0 69.0 66.0 65.0 66.0 64.0 66.0 66.0 63.0 09:33:40 INFO - PROCESS | 1651 | -------- Summary: end -------- 09:33:40 INFO - PROCESS | 1651 | 09:33:41 INFO - TEST-INFO | 1651: exit 0 09:33:41 INFO - TEST-OK | kraken | took 59023ms 09:33:41 INFO - SUITE-END | took 1175s 09:33:41 INFO - Completed test suite (00:19:35) 09:33:41 INFO - javascript benchmark 09:33:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3508.3334166508366, 3516.5252690886723, 3530.3998320285555, 3553.413686741688, 3587.3363427765867, 5828.854278643031, 5913.526917846572, 5923.229980102581, 5937.40625937406, 5940.227770389854, 5683.772649094031, 5902.527797776178, 5979.701014949257, 5993.0, 6001.939980600193, 5275.920861187085, 5324.92012619811, 5328.5470734987575, 5439.5376393006645, 5447.210154527591, 5277.340332458442, 5300.973495132519, 5303.28405665236, 5304.708241046741, 5425.6202065855405, 5349.197620356958, 5434.184872269152, 5434.7826086956475, 5449.509544141027, 5474.151506516477, 5399.271098401705, 5406.216098665691, 5409.540189083933, 5411.540019098381, 5418.2685337479725, 5225.764840582183, 5247.081760691864, 5291.788328466857, 5328.387235467932, 5399.271098401705, 5778.219940308089, 5790.797322093748, 5880.5883588148845, 5884.264466941632, 5917.704114794286, 6289.182406287154, 6321.759028952352, 6369.904451433232, 6381.042843573455, 6384.361563843579, 6298.433141017331, 6301.7164227609865, 6302.87394252117, 6308.621482711006, 6325.557210995232, 5610.382857885629, 5760.913586296167, 5831.708414579254, 5857.824265271964, 5895.852603684943, 5366.248725178478, 6304.401081897213, 6312.895243332398, 6350.714217860115, 6364.363563643691, 6292.738724968685, 6301.747930082745, 6303.149074874925, 6308.053791931247, 6309.810705678837, 6218.533609979179, 6239.656818875005, 6271.62370257786, 6311.779087731908, 6320.936790632127, 6354.9514330135935, 6377.74489020434, 6386.808395748135, 6390.488760899117, 6399.104125422445, 6262.3111457739615, 6358.1416508771645, 6370.394812492806, 6399.968000159969, 6403.103565500834, 4952.133376659071, 5013.348264725635, 5032.169692000852, 5089.796408143633, 5165.767540460688, 4522.683412161117, 4554.840580579664, 4555.544445555418, 4570.291604801261, 4608.769561521977, 6112.205413296243, 6128.754849805958, 6132.816015519542, 6137.355577664281, 6146.815595532141, 6200.503959683215, 6213.65824879627, 6237.157983672237, 6289.056641503811, 6290.402411770874, 6085.756569737249, 6140.513092197578, 6143.109249158847, 6147.293061297919, 6150.292716337589, 5554.586719415668, 5560.499555040065, 5567.888642227133, 5575.247341608912, 5589.105743081088, 6264.59280146789, 6309.810705678837, 6473.643949582818, 6477.514186436036, 6489.286178520453, 5002.424721157114, 6197.25632924052, 6248.750049997949, 6260.092286618506, 6301.684915754102, 6412.647304398303, 6452.9997850333275, 6471.644059576768, 6483.708233129426, 6486.189226346707, 6186.566940314135, 6366.395192456709, 6372.171617689671, 6386.584871983307, 6387.105805187184, 4896.36347274852, 6165.70520190747, 6211.0, 6229.56393052482, 6305.148804911279, 6303.873922521432, 6314.1160237565855, 6322.589031712924, 6323.494120470259, 6328.6519241442165, 6258.593191442542, 6284.654344010941, 6318.652474113784, 6320.905186422299, 6337.96831015842, 5986.132010858489, 6065.545084118797, 6114.723190878713, 6117.92936236148, 6126.1423400724825, 6105.633661980295, 6223.0, 6324.525660575383, 6340.397662222082, 6355.1420558224045, 6027.246594175728, 6071.39286071407, 6156.569040167145, 6196.349383314687, 6201.937980620317], "value": 5837.857344646399, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [510.0589412533874, 520.232656831174, 526.4551189518847, 532.9474288280644, 542.4846395923873, 31673.68326316739, 33429.33141337175, 41953.37069943953, 42676.78661606688, 42975.14049719004, 44231.55768442315, 44452.555474445246, 44485.0, 44487.77756111223, 44591.0, 9646.469444180568, 9810.558524866363, 9832.655857045005, 9835.754106147368, 9841.852372214422, 7696.9615151924445, 9233.907660923405, 9257.444553326788, 9373.953130234338, 9374.531273436334, 11978.401079946012, 12222.511099556052, 12262.957648599835, 12287.877121228807, 12299.139060265785, 11907.0, 11981.640550783402, 11986.760264794742, 12021.93989030058, 12033.39833008346, 11731.17881748278, 11822.290662560274, 11825.526978920832, 11832.284318773816, 11846.644600661994, 41055.794721026505, 41258.9685257868, 41262.0, 41322.0, 41388.793056034825, 3464.012756364424, 3472.2013936794424, 3599.992002239377, 3763.284975854579, 3872.5933776953298, 30102.84948575265, 31482.842585787155, 31590.526142107887, 31689.52465713016, 32093.0, 3165.5251712243116, 3202.6316973547873, 3206.1824234820206, 3292.604887413526, 3338.165458635341, 536138.0, 538725.0, 542111.0, 542859.0, 544215.2789236068, 63479.68260158762, 63879.361206387344, 63981.0, 64071.67964160242, 64208.715825683226, 35827.92516224518, 36379.90860274196, 36537.45193822095, 37794.62205377966, 68447.65776171087, 16215.594610134605, 16327.755083673754, 16347.264373103239, 16366.099864507329, 16374.0, 9743.464109474047, 12425.502979880703, 12430.005599552014, 12433.502659893684, 12456.0, 17276.913615431844, 17672.823271767375, 19350.612987740165, 19614.509637258896, 19619.01904904749, 7779.3776497880035, 7781.688732450639, 7819.804504887424, 7824.452288339876, 7830.2952734254195, 943.598970437575, 1005.9195264378978, 1014.9188064954786, 1061.543536279392, 1067.7277294289906, 24195.274141775775, 29945.850270748506, 30008.399832003674, 30978.380432391226, 31031.534526982112, 951.5432592355708, 960.5149399553181, 1080.8596930238673, 1103.542030057533, 1136.1649187846926, 12724.872751272369, 15425.614359640875, 15733.842661573466, 15896.602584935468, 16065.518034458984, 709556.0, 715622.0, 716897.0, 717662.0, 718794.0, 58075.0, 58941.410585893595, 59529.40470595325, 59945.801083978076, 60138.79722405528, 1261.1928365845865, 1306.477409036393, 1350.8041334006318, 1404.5435233548933, 1423.9074460160057, 30107.69892301049, 31191.84404077965, 31625.8418707905, 31788.8410557955, 31870.52194217042, 46315.0, 46930.76534617305, 47302.763486182346, 47416.7629161852, 47483.0, 559747.0, 560876.0, 561271.0, 561691.0, 563079.0, 24769.25692229236, 25361.873190633927, 26816.06143784958, 27541.44917101687, 27554.724452755217, 47001.529984699715, 47207.763961179975, 47318.0, 47798.52201477941, 48509.51490485191, 31488.842555787076, 39590.802045989585, 39988.40017399683, 40062.599374005884, 40204.1959160821, 38102.0, 38349.0, 39144.80427597958, 40333.39499907445, 40434.39348409717, 38456.81692291507, 39156.0, 39328.41007384834, 39359.40960885532, 39621.60378396294, 32528.698852045654, 34350.65649343475, 34502.48246276358, 34980.30039399147, 35131.824340878135, 25551.23346299614, 25622.871885640452, 25720.871395642902, 26297.474050519264, 26401.867990659925], "value": 20360.705884064824, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.18549923685447, 358.27449414934756, 389.62595907928386, 399.53055160186784, 405.57617289932017, 16963.491095267145, 19255.859142641864, 20524.8973755131, 21241.15035398582, 21443.463913402175, 20101.0, 20296.188152473882, 20626.1749530019, 20659.38021859343, 20803.16787328505, 5737.942620573793, 5743.684097374643, 6044.909326360108, 6049.697515124226, 6050.727717252734, 4037.8788636340955, 6051.334353221142, 6105.938940610604, 6106.389361063881, 6109.14471973924, 4202.726822756526, 4207.894802629929, 4246.532881383046, 4263.850765223217, 4297.763623000734, 6632.767853125141, 6699.732010719566, 6701.2963638817955, 6710.83222919426, 6717.059611654372, 5175.508326708994, 5457.836264912019, 5503.367112782042, 5560.110382338807, 5954.910676339859, 13442.663933401744, 13603.047786654937, 13686.31568421575, 18864.5283867903, 25380.096492762932, 2174.5868285025795, 2270.9545809083725, 2536.9112081077074, 2602.9088981885543, 2859.771218302531, 9635.421874687541, 9897.257705672031, 10140.442275674835, 10171.135453486462, 10521.316114452613, 1778.457570441015, 1833.7982821889582, 1846.2707230643955, 1909.6944488881852, 1922.2215002923838, 81641.59179204125, 96411.0, 116105.83894161035, 121867.0, 122520.0, 11527.76944461106, 11696.0, 11759.412029398496, 11771.470283837249, 11952.701182470508, 14679.339429725687, 14938.32777525014, 14942.70114597702, 14958.551243462714, 14984.850151498564, 8343.8331233375, 8396.706115285935, 8408.369372297102, 8494.830103397897, 8501.277391421798, 8226.341892648574, 8265.421420500628, 8266.917330826735, 8344.374171937128, 8436.24073833358, 4511.909761804811, 4635.1656701794, 4641.071785642885, 4683.2038553446, 4708.293755936568, 1886.3586380630652, 1939.3406241877829, 1951.6389467948475, 1963.7152612871055, 1963.891985940787, 872.445996792029, 918.8713580098791, 927.7912469694264, 975.3513913247752, 997.3866072365588, 19920.50198745014, 20744.688829667568, 20758.962051897346, 20826.958652067337, 20880.582388352148, 884.3146561414826, 921.2767977137914, 925.0, 934.1452570897552, 958.6405098088217, 7977.641006154737, 10705.0, 10911.890881091247, 10951.123910087173, 10970.396628185526, 367758.0, 472310.0, 492983.0, 561375.0, 618563.0, 98033.0, 112097.87902120875, 114378.0, 125652.0, 132149.0, 938.9530523473935, 957.1242313283407, 981.5533932060895, 994.4635538093663, 996.9482196282846, 18464.723029154306, 19073.0, 19405.70891436658, 19436.02819858973, 19477.22091116396, 56650.150247747144, 56762.0, 56882.14676779934, 58049.419505806094, 58306.0, 78665.21334786579, 79562.602186991, 81987.5900620493, 83413.58293208494, 84549.57725211335, 8045.758627241192, 8081.878771818545, 8143.714969976022, 8238.423310368216, 8396.160383961555, 11189.496472658588, 12250.009979641432, 12680.6829829255, 12845.486180552673, 12920.741585168433, 8218.712345068134, 11047.281926674741, 11117.388543629855, 11278.718032049264, 11431.314121152758, 10422.843657345298, 11161.944190278997, 11388.430578470878, 11699.473523691624, 11873.940630296793, 9995.750106247402, 11420.428978550874, 11728.120390970882, 12088.335141566946, 12152.696182595506, 7996.800079998046, 8201.630926608197, 8388.993320801543, 8413.663453461793, 8574.22831945128, 11409.54361825551, 11491.827622585835, 11540.134489913122, 11627.360495172847, 11848.111391645833], "value": 9374.129870332079, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1496.3640452807558, 1536.9846301536984, 1701.4895531340594, 1840.7238914162865, 1851.4908400189954, 8166.550839703814, 8600.0, 8612.267957223643, 8616.224539791418, 8637.438566493174, 7605.619719014055, 7815.843683126334, 8134.023917129938, 8306.54314012729, 8413.663453461853, 2013.32553594546, 2358.7759162879543, 2394.449276666368, 2399.8560086394787, 2403.002753857147, 2368.7039120109985, 2381.3570336009266, 2421.055788242587, 2425.854448733082, 2426.466177440969, 2117.544727883512, 2266.784655457729, 2382.118616112032, 2399.256230568529, 2408.6989126359204, 1952.326447375653, 2368.6802281691926, 2389.988050059756, 2395.5568219879206, 2399.1243196233336, 2386.928392148221, 2409.7831195192516, 2417.721961974378, 2417.987910060456, 2418.6372044193336, 8492.235698787139, 8540.0, 8541.06048334689, 8554.914450855475, 8571.314294856396, 4915.754212289371, 5256.448072952323, 5257.526822585947, 5257.737113144366, 5260.421353651095, 3303.711552494529, 3453.4474484082675, 3599.892003239907, 3606.6032736398975, 3608.4767708682093, 1040.9895901040968, 1072.0565902006185, 1095.1731442760745, 1100.741325788439, 1110.983450143118, 9363.765905852408, 11063.225574209808, 11180.385078820662, 11185.0, 11256.887431125666, 3680.7607505512055, 4644.442666879929, 4723.173444647173, 4726.220173671374, 4774.4509381420885, 8070.273675369128, 9556.713298601053, 9559.0, 9562.235021198287, 9589.664361747306, 5290.81482148123, 5297.205419187076, 5298.602604804655, 5299.49654782795, 5310.522053015247, 4288.742675439484, 4331.826726930951, 4807.78364973577, 4875.853724388274, 4884.877878053077, 3235.8058516489086, 3854.3640299350855, 3941.2511622791576, 3972.82122304497, 4011.7592944423427, 1284.9678758031123, 1285.7042880137622, 1293.6313150752178, 1294.6892745740954, 1308.9280089595163, 766.5324152267112, 867.6225841758729, 917.4907926101077, 917.7659696777279, 931.1898648175995, 5609.8597535061135, 5634.267545219095, 5676.8864622707315, 5779.104238842986, 5978.282606087298, 917.4678686361895, 919.3518569408685, 952.8761261036021, 964.2912459342377, 1017.659084206799, 3653.178034942117, 3678.3378991781738, 3810.704360517437, 3891.494105766232, 3908.2769687607883, 10004.149647279917, 10295.227857910537, 10430.68707938763, 10439.478026098664, 10440.947795260976, 10353.689389318182, 10389.584416623251, 10399.0, 10401.167906567456, 10407.0, 7594.658240379306, 7852.685892564234, 7993.000874890638, 8006.039275286887, 8032.558209298545, 5766.94233057664, 5837.67892765902, 5894.557908156991, 6024.457798798129, 6045.335013148462, 9169.724908252763, 9530.666426675032, 9602.759931001501, 9648.807023859625, 9649.421034737938, 9521.428714277166, 9720.0, 9742.95128524353, 9863.112319891245, 9869.851952220579, 6535.771248006297, 6720.193576770819, 6905.551139175937, 7232.566046037255, 7369.77890663281, 7830.451868369388, 8107.1892810718455, 8112.18878112184, 8126.471779334324, 8160.5103693778565, 6968.825779355354, 7066.787996359912, 7077.433805295667, 7104.360607545345, 7214.675339609835, 6898.172219333712, 6910.654467276516, 6957.2694867038235, 6979.1625004997695, 6999.860002800017, 6598.934010660024, 6617.0, 6705.530612857053, 6708.563943343667, 6715.026321183499, 4168.749875007509, 4763.809447622057, 4816.470188279357, 4843.321934929183, 4907.288443175648, 4748.192807222711, 4770.499097594841, 4775.594074503567, 4985.052839960396, 5034.018366418513], "value": 4477.1653271868145, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [262.58904813966143, 310.4458541503415, 317.62044356993385, 322.7805092537074, 323.91254361322444, 4306.246406878796, 5217.50433708798, 5274.762635681394, 5310.548603368708, 5330.960462709773, 4784.40194975628, 4973.577245934091, 5024.693579669285, 5088.414832294287, 5098.77055532501, 3621.8189090545497, 3797.8480860765603, 3948.0, 3963.425303331015, 4041.7777022263763, 4016.0361513236903, 4031.1937612477477, 4040.5555388907196, 4056.4523789288364, 4067.9186416271655, 3878.5151856017997, 3978.2242462719782, 4009.8596549120784, 4012.0571665658695, 4021.718479706422, 3574.1422058705984, 3782.243551289753, 4005.816829827751, 4011.338129208677, 4020.0, 2828.603995440619, 3355.7147642450423, 3510.473428985647, 3520.348735483918, 3537.133402316449, 4187.748735075906, 4901.607871370282, 4955.240889484217, 5071.644984851062, 5075.796968121271, 3522.947155792665, 3832.9425058624142, 4360.454943132108, 4544.341070544786, 4592.334111553806, 5276.630635855492, 5437.4775062982035, 5495.0, 5510.504054635062, 5529.3364796224305, 3619.4663735385334, 3864.0726225705907, 3883.262180185756, 3885.2812229737588, 3885.8834234972996, 4722.76386180693, 5069.451384031193, 5109.310243117169, 5743.856403589902, 5803.187553742479, 3928.253631809947, 3929.7031979446715, 3942.842286308573, 3952.407138929126, 3952.9642234249386, 3667.972967569085, 3969.206158768258, 3981.5620281768984, 4005.0, 4011.3782363733667, 4149.647279981175, 4334.802283864441, 4543.568361005699, 4566.611837993808, 4573.451185857718, 5028.767951851746, 5034.446210916796, 5056.089903817275, 5492.022871766161, 5493.862653433696, 1239.8512178538633, 1259.5213818749, 1292.926870697319, 1301.6225294664441, 1305.2038256663427, 756.6292516666794, 826.6362800367818, 848.2365870716282, 859.2138193552829, 894.0255121917141, 4029.7179197456485, 4117.382392641068, 4390.319500477431, 4926.33977652071, 5001.424836143818, 4581.625512346282, 4879.926801097987, 5081.28861959326, 5115.462876397999, 5178.456262092502, 3957.55549224531, 4294.613484786321, 4763.359380388825, 4881.511848815161, 4891.288049182757, 2326.3835083702834, 2556.2331300610113, 2619.751123643289, 2694.582339737344, 2776.4035679484377, 5116.846494605168, 5525.917111243334, 5535.335759708861, 5567.415421380778, 5585.804496842672, 5237.240600112962, 5381.327334083239, 5435.173709671028, 5926.318473375531, 5930.525557955353, 5188.63679542436, 5583.878126312056, 5713.028785106459, 6005.6396616203165, 6007.30915944672, 5081.669691470042, 5081.77132029067, 5685.709895970138, 5749.310082790092, 5755.71221438918, 5538.280023596906, 5648.0, 5684.914726279027, 5690.573207009574, 5719.942800571941, 5237.319148510669, 5398.4871437213405, 5658.755073883739, 5926.377730338252, 5979.850503737442, 3644.0, 3842.1557652327597, 3862.613738626227, 3877.360235561101, 3879.4568760374136, 5631.0, 5655.095184770417, 5671.829845104653, 5678.0, 5687.857803554944, 5473.370562385377, 5477.945220547744, 5521.089020311764, 5546.502444339925, 5555.916661250165, 4760.9285860711425, 5271.630985831109, 5279.973600131974, 5425.918611220756, 5478.835634930959, 5338.9055243674175, 5364.544013758874, 5369.731513424391, 5376.301080859464, 5390.4879036491475, 4590.140992897882, 4805.567498925114, 5345.808218630343, 5426.7829286829665, 5525.834224973257, 5122.463261021753, 5404.270423492778, 5458.397457677914, 5461.5357694596405, 5483.725813709379], "value": 3982.7790205203723, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.5857209957726, 691.847793485433, 725.7858931615173, 750.504666919833, 765.4106338119648, 14342.498012569562, 15475.380984760624, 15478.148701821396, 15505.30226139825, 15514.30185641646, 13903.652408689788, 13944.0, 13963.162210267392, 14010.649733756662, 14070.788938165935, 705.929407059295, 730.6529398535706, 851.5188918261193, 867.3754896474528, 887.5029983209423, 888.6711916590871, 889.3374436045156, 889.6975028490313, 890.0, 891.3092353426114, 945.1021529546923, 949.9477528735916, 951.7906060666677, 952.1478276942132, 952.2477242978039, 936.2463217110223, 936.840737074699, 940.3652534539159, 941.8398872191743, 942.4627962061628, 700.7407259314035, 702.764573867755, 703.3775109028546, 703.6587255181233, 704.4223736536043, 14092.718145637133, 14130.50543230982, 14138.575842724631, 14143.929280353532, 14834.33245503944, 13006.674833129153, 13121.671958201121, 13356.398962046731, 13490.662733431645, 13720.108192967526, 10643.0, 10912.290701104403, 11030.448477576168, 11147.665570032912, 11267.887321126766, 3578.7137029037876, 3676.761010534307, 3681.5582130144285, 3714.7771133731794, 3724.553053633554, 81391.18608813896, 81441.59279203626, 81829.0, 84568.0, 86199.0, 7581.431392645573, 9745.415275083518, 9865.654702085536, 9950.751231219278, 10154.644587439405, 18914.43256702301, 19481.90259048724, 19501.90249048774, 21393.358199254046, 21512.0, 7401.925980740231, 7618.5809780461495, 7634.658325169147, 7698.499597526143, 7834.569098699512, 3989.3218152914073, 4085.5914408558906, 4127.9174416511505, 4197.727147735387, 4257.680673949404, 3527.9294414112087, 3644.7630903991158, 3648.6533779290926, 3650.926981460356, 3659.9451008234896, 642.5566359212129, 647.1296106736432, 655.9737610495622, 662.1788981662703, 663.873863965845, 576.1789450033685, 589.4753669234385, 594.3462191589304, 649.3344322069917, 650.3691419323249, 8857.335699822539, 9003.549822508849, 9127.132922372364, 9366.063393660716, 9424.293178011676, 614.8985417406167, 621.3072424246932, 632.7152781248457, 667.3060017581757, 692.608676098003, 4352.673549483801, 4376.256036473807, 4475.283954567253, 4480.932786008212, 4518.482441928671, 106529.0, 115758.0, 116894.0, 119407.40296298463, 124491.37754311171, 61828.69085654543, 62705.68647156735, 73965.89051164237, 93568.06431935729, 99654.5017274909, 83604.58197708972, 87451.56274218588, 89469.55265223763, 93946.59080113804, 97617.51191243998, 9421.15209631109, 9889.26937785899, 9922.801543968935, 9940.850887236842, 9972.750681233027, 36778.63221367752, 48883.53349399524, 49318.0, 52924.0, 55715.721421392635, 56028.71985640046, 70334.0, 80212.59893700494, 82020.0, 84623.0, 11941.343226122646, 11990.820137697767, 12528.436220369922, 12717.345736929119, 13254.53609123676, 13946.790798137834, 14187.503437379642, 14338.022167499756, 14649.70700585961, 14964.0, 12918.677033074247, 13118.0, 13132.409041593342, 13291.136076155406, 13538.458461661818, 10288.537015834456, 12237.632871013884, 12381.257124572554, 12590.24458532491, 12691.873081269068, 11805.586804461802, 11940.880591193976, 12153.574624888086, 12517.749645006867, 12823.61529154127, 9901.207903367569, 10049.648262310784, 10371.357666121055, 10970.380468459536, 11066.225364224427, 10936.50785714629, 11396.715082123013, 11487.770244595229, 11724.41377931083, 11761.588344408246], "value": 7311.72239493262, "unit": "score"}], "name": "dromaeo_css", "value": 7250.574190643443, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 107.0, 106.0, 113.0, 113.0, 115.0, 115.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 105.0, 106.0, 141.0, 107.0, 109.0, 106.0, 108.0, 135.0, 104.0], "value": 115.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 184.0, 182.0, 181.0, 182.0, 180.0, 182.0, 181.0, 182.0], "value": 182.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 58.0, 87.0, 59.0, 58.0, 61.0, 74.0, 99.0, 58.0], "value": 69.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 92.0, 70.0, 67.0, 68.0, 89.0, 88.0, 99.0, 124.0], "value": 85.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 134.0, 85.0, 92.0, 126.0, 86.0, 83.0, 86.0, 83.0], "value": 94.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 149.0, 92.0, 93.0, 92.0, 93.0, 95.0, 93.0, 93.0, 94.0], "value": 100.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 82.0, 89.0, 130.0, 123.0, 92.0, 84.0, 84.0, 80.0], "value": 93.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 54.0, 54.0, 55.0, 58.0, 58.0, 57.0, 56.0, 56.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 71.0, 64.0, 75.0, 71.0, 69.0, 69.0, 68.0, 67.0, 69.0], "value": 68.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 81.0, 81.0, 79.0, 76.0, 76.0, 78.0, 81.0, 82.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 128.0, 160.0, 183.0, 149.0, 159.0, 130.0, 142.0, 182.0, 138.0], "value": 151.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 169.0, 162.0, 220.0, 209.0, 161.0, 163.0, 162.0, 216.0, 221.0], "value": 184.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 69.0, 66.0, 65.0, 66.0, 64.0, 66.0, 66.0, 63.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1458.8, "alertThreshold": 2.0}]} 09:33:41 INFO - Return code: 0 09:33:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:33:41 INFO - # TBPL SUCCESS # 09:33:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:33:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:33:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:33:41 INFO - 2017-01-30 09:33:41.953 screenresolution[1655:10451] starting screenresolution argv=screenresolution get 09:33:41 INFO - 2017-01-30 09:33:41.955 screenresolution[1655:10451] Display 0: 1600x1200x32@60 09:33:41 INFO - 2017-01-30 09:33:41.962 screenresolution[1656:10454] starting screenresolution argv=screenresolution list 09:33:41 INFO - Available Modes on Display 0 09:33:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:33:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:33:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:33:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:33:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:33:42 INFO - Intel Iris: 09:33:42 INFO - Chipset Model: Intel Iris 09:33:42 INFO - Type: GPU 09:33:42 INFO - Bus: Built-In 09:33:42 INFO - VRAM (Dynamic, Max): 1536 MB 09:33:42 INFO - Vendor: Intel (0x8086) 09:33:42 INFO - Device ID: 0x0a2e 09:33:42 INFO - Revision ID: 0x0009 09:33:42 INFO - Displays: 09:33:42 INFO - Display: 09:33:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:33:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:33:42 INFO - Display Serial Number: 1600x1200 60 09:33:42 INFO - Main Display: Yes 09:33:42 INFO - Mirror: Off 09:33:42 INFO - Online: Yes 09:33:42 INFO - Rotation: Supported 09:33:42 INFO - Return code: 0 09:33:42 INFO - Running post-action listener: _resource_record_post_action 09:33:42 INFO - [mozharness: 2017-01-30 17:33:42.210848Z] Finished run-tests step (success) 09:33:42 INFO - Running post-run listener: _resource_record_post_run 09:33:42 INFO - Total resource usage - Wall time: 1198s; CPU: 53.0%; Read bytes: 37958656; Write bytes: 500109312; Read time: 249; Write time: 1581 09:33:42 INFO - TinderboxPrint: CPU usage
53.4% 09:33:42 INFO - TinderboxPrint: I/O read bytes / time
37,958,656 / 249 09:33:42 INFO - TinderboxPrint: I/O write bytes / time
500,109,312 / 1,581 09:33:42 INFO - TinderboxPrint: CPU idle
2,231.5 (46.6%) 09:33:42 INFO - TinderboxPrint: CPU system
960.1 (20.0%) 09:33:42 INFO - TinderboxPrint: CPU user
1,602.0 (33.4%) 09:33:42 INFO - TinderboxPrint: Swap in / out
229,441,536 / 0 09:33:42 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 181088768; Write bytes: 174424064; Read time: 16675; Write time: 366 09:33:42 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 37012480; Write bytes: 307953664; Read time: 234; Write time: 1160 09:33:42 INFO - Running post-run listener: _upload_blobber_files 09:33:42 INFO - Blob upload gear active. 09:33:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:33:42 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 09:33:42 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'] 09:33:42 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 09:33:43 INFO - (blobuploader) - INFO - Open directory for files ... 09:33:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:33:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:33:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:33:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:33:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:33:44 INFO - (blobuploader) - INFO - Done attempting. 09:33:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:33:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:33:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:33:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:33:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:33:45 INFO - (blobuploader) - INFO - Done attempting. 09:33:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:33:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:33:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:33:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:33:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:33:47 INFO - (blobuploader) - INFO - Done attempting. 09:33:47 INFO - (blobuploader) - INFO - Iteration through files over. 09:33:47 INFO - Return code: 0 09:33:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:33:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:33:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2e398ea9e0caf184ae6fcf089ac240b393e896e9f82e8ba664836740e755bb126c6da11f84d95c5c19ab5b3aa892867a8496956b9dc7ef16b5f5a25301348cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c81b3e6e62f06015b1f3334af47281c35944323f92b15dae201d4c545a16059d84d928c6698a85b85897dea4d26b26e6bab95042ccbcfe31b900ae0a6c5c0592", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7f13ff48e747a6652f2eaf991422eaa30b302eb056e897bad99714f99979b2936840ddbf76869a3381f2366d529a0f8329407f4073c47cbe94629a35ad3851c2"} 09:33:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:33:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:33:47 INFO - Contents: 09:33:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2e398ea9e0caf184ae6fcf089ac240b393e896e9f82e8ba664836740e755bb126c6da11f84d95c5c19ab5b3aa892867a8496956b9dc7ef16b5f5a25301348cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c81b3e6e62f06015b1f3334af47281c35944323f92b15dae201d4c545a16059d84d928c6698a85b85897dea4d26b26e6bab95042ccbcfe31b900ae0a6c5c0592", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7f13ff48e747a6652f2eaf991422eaa30b302eb056e897bad99714f99979b2936840ddbf76869a3381f2366d529a0f8329407f4073c47cbe94629a35ad3851c2"} 09:33:47 INFO - Running post-run listener: copy_logs_to_upload_dir 09:33:47 INFO - Copying logs to upload dir... 09:33:47 INFO - mkdir: /builds/slave/test/build/upload/logs 09:33:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.817222 ========= master_lag: 1.39 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-30 09:33:49.348622) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-30 09:33:49.353269) ========= 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.9sS9Nlp6hC/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.GBIBAVmaNr/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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/e2e398ea9e0caf184ae6fcf089ac240b393e896e9f82e8ba664836740e755bb126c6da11f84d95c5c19ab5b3aa892867a8496956b9dc7ef16b5f5a25301348cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c81b3e6e62f06015b1f3334af47281c35944323f92b15dae201d4c545a16059d84d928c6698a85b85897dea4d26b26e6bab95042ccbcfe31b900ae0a6c5c0592", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7f13ff48e747a6652f2eaf991422eaa30b302eb056e897bad99714f99979b2936840ddbf76869a3381f2366d529a0f8329407f4073c47cbe94629a35ad3851c2"} build_url:https://queue.taskcluster.net/v1/task/PSAwuQfWQbK53_4QgDn8jA/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011180 build_url: 'https://queue.taskcluster.net/v1/task/PSAwuQfWQbK53_4QgDn8jA/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2e398ea9e0caf184ae6fcf089ac240b393e896e9f82e8ba664836740e755bb126c6da11f84d95c5c19ab5b3aa892867a8496956b9dc7ef16b5f5a25301348cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c81b3e6e62f06015b1f3334af47281c35944323f92b15dae201d4c545a16059d84d928c6698a85b85897dea4d26b26e6bab95042ccbcfe31b900ae0a6c5c0592", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7f13ff48e747a6652f2eaf991422eaa30b302eb056e897bad99714f99979b2936840ddbf76869a3381f2366d529a0f8329407f4073c47cbe94629a35ad3851c2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-30 09:33:49.388217) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 09:33:49.388551) ========= 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.9sS9Nlp6hC/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.GBIBAVmaNr/Listeners TMPDIR=/var/folders/nm/b01fmtbx5f59cgm2djktykb800000w/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.005100 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 09:33:49.444742) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-30 09:33:49.448117) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-30 09:33:49.448477) ========= ========= Total master_lag: 1.58 =========