builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0325 starttime: 1490185859.89 results: success (0) buildid: 20170322040835 builduid: 423a7953fb414449a2e70b37cd18a9e1 revision: ccd778892fcf082fac94b499d0fada57dd2b712a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 05:30:59.888516) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 05:30:59.888954) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 05:30:59.889225) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 05:30:59.915145) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 05:30:59.915488) ========= 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.H5kHGMDbtr/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.YEt39LeKTo/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-22 05:30:59-- 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% 38.8M=0s 2017-03-22 05:31:00 (38.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.084355 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 05:31:00.023638) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 05:31:00.024013) ========= 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.H5kHGMDbtr/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.YEt39LeKTo/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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.025821 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 05:31:00.072692) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-22 05:31:00.073068) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ccd778892fcf082fac94b499d0fada57dd2b712a --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 ccd778892fcf082fac94b499d0fada57dd2b712a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.H5kHGMDbtr/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.YEt39LeKTo/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-22 05:31:00,177 truncating revision to first 12 chars 2017-03-22 05:31:00,177 Setting DEBUG logging. 2017-03-22 05:31:00,177 attempt 1/10 2017-03-22 05:31:00,177 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ccd778892fcf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-22 05:31:01,168 unpacking tar archive at: mozilla-beta-ccd778892fcf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.264427 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-22 05:31:01.361366) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 05:31:01.361711) ========= script_repo_revision: ccd778892fcf082fac94b499d0fada57dd2b712a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 05:31:01.362118) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 05:31:01.362453) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 05:31:01.383251) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-03-22 05:31:01.383881) ========= /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.H5kHGMDbtr/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.YEt39LeKTo/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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 05:31:01 INFO - MultiFileLogger online at 20170322 05:31:01 in /builds/slave/test 05:31:01 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 05:31:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:31:01 INFO - {'append_to_log': False, 05:31:01 INFO - 'base_work_dir': '/builds/slave/test', 05:31:01 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:31:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:31:01 INFO - 'branch': 'Mozilla-Beta', 05:31:01 INFO - 'buildbot_json_path': 'buildprops.json', 05:31:01 INFO - 'config_files': ('talos/mac_config.py',), 05:31:01 INFO - 'default_actions': ('clobber', 05:31:01 INFO - 'read-buildbot-config', 05:31:01 INFO - 'download-and-extract', 05:31:01 INFO - 'populate-webroot', 05:31:01 INFO - 'create-virtualenv', 05:31:01 INFO - 'install', 05:31:01 INFO - 'run-tests'), 05:31:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:31:01 INFO - 'download_minidump_stackwalk': True, 05:31:01 INFO - 'download_symbols': 'ondemand', 05:31:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:31:01 INFO - 'tooltool.py': '/tools/tooltool.py', 05:31:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:31:01 INFO - '/tools/misc-python/virtualenv.py')}, 05:31:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:31:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:31:01 INFO - 'installer_path': 'installer.exe', 05:31:01 INFO - 'log_level': 'info', 05:31:01 INFO - 'log_name': 'talos', 05:31:01 INFO - 'log_to_console': True, 05:31:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:31:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:31:01 INFO - 'opt_config_files': (), 05:31:01 INFO - 'pip_index': False, 05:31:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:31:01 INFO - 'cmd': ('bash', 05:31:01 INFO - '-c', 05:31:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:31:01 INFO - 'enabled': True, 05:31:01 INFO - 'halt_on_failure': False, 05:31:01 INFO - 'name': 'check_screen_resolution'},), 05:31:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:31:01 INFO - 'cmd': ('bash', 05:31:01 INFO - '-c', 05:31:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:31:01 INFO - 'enabled': True, 05:31:01 INFO - 'halt_on_failure': False, 05:31:01 INFO - 'name': 'check_screen_resolution'},), 05:31:01 INFO - 'run_cmd_checks_enabled': True, 05:31:01 INFO - 'sps_profile': False, 05:31:01 INFO - 'sps_profile_interval': 0, 05:31:01 INFO - 'suite': 'dromaeojs', 05:31:01 INFO - 'system_bits': '32', 05:31:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:31:01 INFO - 'title': 't-yosemite-r7-0325', 05:31:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:31:01 INFO - 'use_talos_json': True, 05:31:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:31:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:31:01 INFO - 'work_dir': 'build'} 05:31:01 INFO - [mozharness: 2017-03-22 12:31:01.606293Z] Running clobber step. 05:31:01 INFO - Running pre-action listener: _resource_record_pre_action 05:31:01 INFO - Running main action method: clobber 05:31:01 INFO - rmtree: /builds/slave/test/build 05:31:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:31:04 INFO - Running post-action listener: _resource_record_post_action 05:31:04 INFO - [mozharness: 2017-03-22 12:31:04.052047Z] Finished clobber step (success) 05:31:04 INFO - [mozharness: 2017-03-22 12:31:04.052267Z] Running read-buildbot-config step. 05:31:04 INFO - Running pre-action listener: _resource_record_pre_action 05:31:04 INFO - Running main action method: read_buildbot_config 05:31:04 INFO - Using buildbot properties: 05:31:04 INFO - { 05:31:04 INFO - "project": "", 05:31:04 INFO - "product": "firefox", 05:31:04 INFO - "script_repo_revision": "production", 05:31:04 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 05:31:04 INFO - "repository": "", 05:31:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 05:31:04 INFO - "buildid": "20170322040835", 05:31:04 INFO - "pgo_build": "False", 05:31:04 INFO - "basedir": "/builds/slave/test", 05:31:04 INFO - "buildnumber": 4, 05:31:04 INFO - "slavename": "t-yosemite-r7-0325", 05:31:04 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 05:31:04 INFO - "platform": "yosemite_r7", 05:31:04 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 05:31:04 INFO - "branch": "mozilla-beta", 05:31:04 INFO - "repo_path": "releases/mozilla-beta", 05:31:04 INFO - "revision": "ccd778892fcf082fac94b499d0fada57dd2b712a", 05:31:04 INFO - "stage_platform": "macosx64", 05:31:04 INFO - "builduid": "423a7953fb414449a2e70b37cd18a9e1", 05:31:04 INFO - "slavebuilddir": "test" 05:31:04 INFO - } 05:31:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ado8egYdSrSP6BkrxWwfQA/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 05:31:04 INFO - Running post-action listener: _resource_record_post_action 05:31:04 INFO - [mozharness: 2017-03-22 12:31:04.057724Z] Finished read-buildbot-config step (success) 05:31:04 INFO - [mozharness: 2017-03-22 12:31:04.057898Z] Running download-and-extract step. 05:31:04 INFO - Running pre-action listener: _resource_record_pre_action 05:31:04 INFO - Running main action method: download_and_extract 05:31:04 INFO - mkdir: /builds/slave/test/build/tests 05:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:04 INFO - trying https://queue.taskcluster.net/v1/task/Ado8egYdSrSP6BkrxWwfQA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 05:31:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Ado8egYdSrSP6BkrxWwfQA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 05:31:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ado8egYdSrSP6BkrxWwfQA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 05:31:05 INFO - Downloaded 1165 bytes. 05:31:05 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 05:31:05 INFO - Using the following test package requirements: 05:31:05 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 05:31:05 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:31:05 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 05:31:05 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:31:05 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 05:31:05 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 05:31:05 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:31:05 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 05:31:05 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 05:31:05 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:31:05 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 05:31:05 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:31:05 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 05:31:05 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:31:05 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 05:31:05 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:31:05 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 05:31:05 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 05:31:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ado8egYdSrSP6BkrxWwfQA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 05:31:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ado8egYdSrSP6BkrxWwfQA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 05:31:05 INFO - Fetch https://queue.taskcluster.net/v1/task/Ado8egYdSrSP6BkrxWwfQA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 05:31:05 INFO - Expected file size: 16108238 05:31:05 INFO - Obtained file size: 16108238 05:31:12 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 05:31:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ado8egYdSrSP6BkrxWwfQA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 05:31:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ado8egYdSrSP6BkrxWwfQA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 05:31:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Ado8egYdSrSP6BkrxWwfQA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 05:31:13 INFO - Expected file size: 16108238 05:31:13 INFO - Obtained file size: 16108238 05:31:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ado8egYdSrSP6BkrxWwfQA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 05:31:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ado8egYdSrSP6BkrxWwfQA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 05:31:19 INFO - Fetch https://queue.taskcluster.net/v1/task/Ado8egYdSrSP6BkrxWwfQA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 05:31:20 INFO - Expected file size: 14403663 05:31:20 INFO - Obtained file size: 14403663 05:31:21 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')]} 05:31:21 INFO - trying https://queue.taskcluster.net/v1/task/Ado8egYdSrSP6BkrxWwfQA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 05:31:21 INFO - Downloading https://queue.taskcluster.net/v1/task/Ado8egYdSrSP6BkrxWwfQA/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 05:31:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ado8egYdSrSP6BkrxWwfQA/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 05:31:22 INFO - Downloaded 58762647 bytes. 05:31:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ado8egYdSrSP6BkrxWwfQA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 05:31:22 INFO - mkdir: /builds/slave/test/properties 05:31:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:31:22 INFO - Writing to file /builds/slave/test/properties/build_url 05:31:22 INFO - Contents: 05:31:22 INFO - build_url:https://queue.taskcluster.net/v1/task/Ado8egYdSrSP6BkrxWwfQA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 05:31:23 INFO - Running post-action listener: _resource_record_post_action 05:31:23 INFO - Running post-action listener: set_extra_try_arguments 05:31:23 INFO - [mozharness: 2017-03-22 12:31:23.592875Z] Finished download-and-extract step (success) 05:31:23 INFO - [mozharness: 2017-03-22 12:31:23.593034Z] Running populate-webroot step. 05:31:23 INFO - Running pre-action listener: _resource_record_pre_action 05:31:23 INFO - Running main action method: populate_webroot 05:31:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:31:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:31:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:31:23 INFO - '--tppagecycles', 05:31:23 INFO - '7'], 05:31:23 INFO - 'tests': ['tsvgm']}}, 05:31:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:31:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:31:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:31:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:31:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:31:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:31:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:31:23 INFO - 'talos_options': ['--disable-e10s'], 05:31:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:31:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:31:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:31:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:31:23 INFO - 'talos_options': ['--disable-e10s'], 05:31:23 INFO - 'tests': ['damp', 'tps']}, 05:31:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:31:23 INFO - 'tests': ['damp', 'tps']}, 05:31:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:31:23 INFO - 'tests': ['dromaeo_dom']}, 05:31:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:31:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:31:23 INFO - 'tests': ['basic_compositor_video']}, 05:31:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:31:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:31:23 INFO - 'tests': ['a11yr', 05:31:23 INFO - 'ts_paint', 05:31:23 INFO - 'tpaint', 05:31:23 INFO - 'sessionrestore', 05:31:23 INFO - 'sessionrestore_no_auto_restore', 05:31:23 INFO - 'tabpaint']}, 05:31:23 INFO - 'other-e10s': {'tests': ['a11yr', 05:31:23 INFO - 'ts_paint', 05:31:23 INFO - 'tpaint', 05:31:23 INFO - 'sessionrestore', 05:31:23 INFO - 'sessionrestore_no_auto_restore', 05:31:23 INFO - 'tabpaint']}, 05:31:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:31:23 INFO - 'ts_paint', 05:31:23 INFO - 'tpaint', 05:31:23 INFO - 'sessionrestore', 05:31:23 INFO - 'sessionrestore_no_auto_restore', 05:31:23 INFO - 'tabpaint']}, 05:31:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:31:23 INFO - 'ts_paint', 05:31:23 INFO - 'tpaint', 05:31:23 INFO - 'sessionrestore', 05:31:23 INFO - 'sessionrestore_no_auto_restore', 05:31:23 INFO - 'tabpaint']}, 05:31:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:31:23 INFO - 'tests': ['a11yr', 05:31:23 INFO - 'ts_paint', 05:31:23 INFO - 'tpaint', 05:31:23 INFO - 'sessionrestore', 05:31:23 INFO - 'sessionrestore_no_auto_restore', 05:31:23 INFO - 'tabpaint']}, 05:31:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:31:23 INFO - 'tests': ['a11yr', 05:31:23 INFO - 'ts_paint', 05:31:23 INFO - 'tpaint', 05:31:23 INFO - 'sessionrestore', 05:31:23 INFO - 'sessionrestore_no_auto_restore', 05:31:23 INFO - 'tabpaint']}, 05:31:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:31:23 INFO - 'tests': ['tsvgx', 05:31:23 INFO - 'tsvgr_opacity', 05:31:23 INFO - 'tart', 05:31:23 INFO - 'tscrollx', 05:31:23 INFO - 'cart', 05:31:23 INFO - 'tsvg_static']}, 05:31:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:31:23 INFO - 'tsvgr_opacity', 05:31:23 INFO - 'tart', 05:31:23 INFO - 'tscrollx', 05:31:23 INFO - 'cart', 05:31:23 INFO - 'tsvg_static']}, 05:31:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:31:23 INFO - 'talos_options': ['--disable-e10s'], 05:31:23 INFO - 'tests': ['tp5o']}, 05:31:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:31:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:31:23 INFO - 'talos_options': ['--disable-e10s', 05:31:23 INFO - '--xperf_path', 05:31:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:31:23 INFO - 'tests': ['tp5n']}, 05:31:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:31:23 INFO - 'talos_options': ['--xperf_path', 05:31:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:31:23 INFO - 'tests': ['tp5n']}}, 05:31:23 INFO - 'talos.zip': {'path': '', 05:31:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:31:23 INFO - Running post-action listener: _resource_record_post_action 05:31:23 INFO - [mozharness: 2017-03-22 12:31:23.611735Z] Finished populate-webroot step (success) 05:31:23 INFO - [mozharness: 2017-03-22 12:31:23.611869Z] Running create-virtualenv step. 05:31:23 INFO - Running pre-action listener: _resource_record_pre_action 05:31:23 INFO - Running main action method: create_virtualenv 05:31:23 INFO - Creating virtualenv /builds/slave/test/build/venv 05:31:23 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 05:31:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:31:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:31:23 INFO - Using real prefix '/tools/python27' 05:31:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:31:24 INFO - Installing distribute.............................................................................................................................................................................................done. 05:31:27 INFO - Installing pip.................done. 05:31:27 INFO - Return code: 0 05:31:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:31:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:31:27 INFO - Reading from file tmpfile_stdout 05:31:27 INFO - Output received: 05:31:27 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) 05:31:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:27 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 0x1011adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1e1dc3110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f8bd30>, '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 0x100eb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f80be8>, '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.H5kHGMDbtr/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.YEt39LeKTo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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 05:31:27 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 05:31:27 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 05:31:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5kHGMDbtr/Render', 05:31:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:27 INFO - 'HOME': '/Users/cltbld', 05:31:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:27 INFO - 'LOGNAME': 'cltbld', 05:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:27 INFO - 'MOZ_NO_REMOTE': '1', 05:31:27 INFO - 'NO_EM_RESTART': '1', 05:31:27 INFO - 'PAGER': '/bin/cat', 05:31:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:27 INFO - 'PWD': '/builds/slave/test', 05:31:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:27 INFO - 'SHELL': '/bin/bash', 05:31:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YEt39LeKTo/Listeners', 05:31:27 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 05:31:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:27 INFO - 'USER': 'cltbld', 05:31:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:27 INFO - 'XPC_FLAGS': '0x0', 05:31:27 INFO - 'XPC_SERVICE_NAME': '0', 05:31:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:27 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 05:31:27 INFO - Cleaning up... 05:31:27 INFO - Return code: 0 05:31:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:27 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 0x1011adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1e1dc3110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f8bd30>, '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 0x100eb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f80be8>, '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.H5kHGMDbtr/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.YEt39LeKTo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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 05:31:27 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 05:31:27 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 05:31:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5kHGMDbtr/Render', 05:31:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:27 INFO - 'HOME': '/Users/cltbld', 05:31:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:27 INFO - 'LOGNAME': 'cltbld', 05:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:27 INFO - 'MOZ_NO_REMOTE': '1', 05:31:27 INFO - 'NO_EM_RESTART': '1', 05:31:27 INFO - 'PAGER': '/bin/cat', 05:31:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:27 INFO - 'PWD': '/builds/slave/test', 05:31:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:27 INFO - 'SHELL': '/bin/bash', 05:31:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YEt39LeKTo/Listeners', 05:31:27 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 05:31:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:27 INFO - 'USER': 'cltbld', 05:31:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:27 INFO - 'XPC_FLAGS': '0x0', 05:31:27 INFO - 'XPC_SERVICE_NAME': '0', 05:31:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:28 INFO - Downloading/unpacking psutil>=3.1.1 05:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:31:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:31:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:31:31 INFO - Installing collected packages: psutil 05:31:31 INFO - Running setup.py install for psutil 05:31:31 INFO - building 'psutil._psutil_osx' extension 05:31:31 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 05:31:32 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 05:31:32 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 05:31:32 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 05:31:32 INFO - building 'psutil._psutil_posix' extension 05:31:32 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 05:31:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:31:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:31:32 INFO - ^ 05:31:32 INFO - 1 warning generated. 05:31:32 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 05:31:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:31:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:31:32 INFO - Successfully installed psutil 05:31:32 INFO - Cleaning up... 05:31:32 INFO - Return code: 0 05:31:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1011adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1e1dc3110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f8bd30>, '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 0x100eb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f80be8>, '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.H5kHGMDbtr/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.YEt39LeKTo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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 05:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:31:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5kHGMDbtr/Render', 05:31:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:32 INFO - 'HOME': '/Users/cltbld', 05:31:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:32 INFO - 'LOGNAME': 'cltbld', 05:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:32 INFO - 'MOZ_NO_REMOTE': '1', 05:31:32 INFO - 'NO_EM_RESTART': '1', 05:31:32 INFO - 'PAGER': '/bin/cat', 05:31:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:32 INFO - 'PWD': '/builds/slave/test', 05:31:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:32 INFO - 'SHELL': '/bin/bash', 05:31:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YEt39LeKTo/Listeners', 05:31:32 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 05:31:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:32 INFO - 'USER': 'cltbld', 05:31:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:32 INFO - 'XPC_FLAGS': '0x0', 05:31:32 INFO - 'XPC_SERVICE_NAME': '0', 05:31:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:31:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:31:35 INFO - Installing collected packages: mozsystemmonitor 05:31:35 INFO - Running setup.py install for mozsystemmonitor 05:31:35 INFO - Successfully installed mozsystemmonitor 05:31:35 INFO - Cleaning up... 05:31:35 INFO - Return code: 0 05:31:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:31:35 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')]} 05:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:35 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')]} 05:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:35 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 0x1011adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1e1dc3110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f8bd30>, '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 0x100eb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f80be8>, '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.H5kHGMDbtr/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.YEt39LeKTo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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 05:31:35 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 05:31:35 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 05:31:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5kHGMDbtr/Render', 05:31:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:35 INFO - 'HOME': '/Users/cltbld', 05:31:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:35 INFO - 'LOGNAME': 'cltbld', 05:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:35 INFO - 'MOZ_NO_REMOTE': '1', 05:31:35 INFO - 'NO_EM_RESTART': '1', 05:31:35 INFO - 'PAGER': '/bin/cat', 05:31:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:35 INFO - 'PWD': '/builds/slave/test', 05:31:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:35 INFO - 'SHELL': '/bin/bash', 05:31:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YEt39LeKTo/Listeners', 05:31:35 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 05:31:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:35 INFO - 'USER': 'cltbld', 05:31:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:35 INFO - 'XPC_FLAGS': '0x0', 05:31:35 INFO - 'XPC_SERVICE_NAME': '0', 05:31:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:36 INFO - Downloading/unpacking jsonschema==2.5.1 05:31:36 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 05:31:36 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 05:31:36 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 05:31:36 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 05:31:36 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 05:31:36 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 05:31:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:31:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:31: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 05:31: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 05:31: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 05:31: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 05:31: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 05:31: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 05:31:39 INFO - Downloading functools32-3.2.3-2.tar.gz 05:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:31:39 INFO - warning: no files found matching '*.txt' 05:31:39 INFO - no previously-included directories found matching 'build' 05:31:39 INFO - no previously-included directories found matching 'dist' 05:31:39 INFO - no previously-included directories found matching '.git*' 05:31:39 INFO - Installing collected packages: jsonschema, functools32 05:31:39 INFO - Running setup.py install for functools32 05:31:39 INFO - warning: no files found matching '*.txt' 05:31:39 INFO - no previously-included directories found matching 'build' 05:31:39 INFO - no previously-included directories found matching 'dist' 05:31:39 INFO - no previously-included directories found matching '.git*' 05:31:39 INFO - Successfully installed jsonschema functools32 05:31:39 INFO - Cleaning up... 05:31:39 INFO - Return code: 0 05:31:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1011adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1e1dc3110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f8bd30>, '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 0x100eb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f80be8>, '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.H5kHGMDbtr/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.YEt39LeKTo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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 05:31:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:31:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5kHGMDbtr/Render', 05:31:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:39 INFO - 'HOME': '/Users/cltbld', 05:31:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:39 INFO - 'LOGNAME': 'cltbld', 05:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:39 INFO - 'MOZ_NO_REMOTE': '1', 05:31:39 INFO - 'NO_EM_RESTART': '1', 05:31:39 INFO - 'PAGER': '/bin/cat', 05:31:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:39 INFO - 'PWD': '/builds/slave/test', 05:31:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:39 INFO - 'SHELL': '/bin/bash', 05:31:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YEt39LeKTo/Listeners', 05:31:39 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 05:31:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:39 INFO - 'USER': 'cltbld', 05:31:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:39 INFO - 'XPC_FLAGS': '0x0', 05:31:39 INFO - 'XPC_SERVICE_NAME': '0', 05:31:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:31:39 INFO - Cleaning up... 05:31:39 INFO - Return code: 0 05:31:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1011adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1e1dc3110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f8bd30>, '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 0x100eb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f80be8>, '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.H5kHGMDbtr/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.YEt39LeKTo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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 05:31:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:31:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5kHGMDbtr/Render', 05:31:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:39 INFO - 'HOME': '/Users/cltbld', 05:31:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:39 INFO - 'LOGNAME': 'cltbld', 05:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:39 INFO - 'MOZ_NO_REMOTE': '1', 05:31:39 INFO - 'NO_EM_RESTART': '1', 05:31:39 INFO - 'PAGER': '/bin/cat', 05:31:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:39 INFO - 'PWD': '/builds/slave/test', 05:31:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:39 INFO - 'SHELL': '/bin/bash', 05:31:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YEt39LeKTo/Listeners', 05:31:39 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 05:31:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:39 INFO - 'USER': 'cltbld', 05:31:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:39 INFO - 'XPC_FLAGS': '0x0', 05:31:39 INFO - 'XPC_SERVICE_NAME': '0', 05:31:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:40 INFO - Downloading/unpacking blobuploader==1.2.4 05:31:40 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 05:31:40 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 05:31:40 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 05:31:40 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 05:31:40 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 05:31:40 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 05:31:42 INFO - Downloading blobuploader-1.2.4.tar.gz 05:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:31:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:31:42 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 05:31:42 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 05:31:42 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 05:31:42 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 05:31:42 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 05:31:42 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 05:31:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:31:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:43 INFO - Downloading docopt-0.6.1.tar.gz 05:31:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:31:43 INFO - Installing collected packages: blobuploader, requests, docopt 05:31:43 INFO - Running setup.py install for blobuploader 05:31:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:31:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:31:44 INFO - Running setup.py install for requests 05:31:44 INFO - Running setup.py install for docopt 05:31:44 INFO - Successfully installed blobuploader requests docopt 05:31:44 INFO - Cleaning up... 05:31:44 INFO - Return code: 0 05:31:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:31:44 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')]} 05:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:44 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')]} 05:31:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:44 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 0x1011adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1e1dc3110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f8bd30>, '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 0x100eb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f80be8>, '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.H5kHGMDbtr/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.YEt39LeKTo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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 05:31:44 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 05:31:44 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 05:31:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5kHGMDbtr/Render', 05:31:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:44 INFO - 'HOME': '/Users/cltbld', 05:31:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:44 INFO - 'LOGNAME': 'cltbld', 05:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:44 INFO - 'MOZ_NO_REMOTE': '1', 05:31:44 INFO - 'NO_EM_RESTART': '1', 05:31:44 INFO - 'PAGER': '/bin/cat', 05:31:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:44 INFO - 'PWD': '/builds/slave/test', 05:31:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:44 INFO - 'SHELL': '/bin/bash', 05:31:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YEt39LeKTo/Listeners', 05:31:44 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 05:31:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:44 INFO - 'USER': 'cltbld', 05:31:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:44 INFO - 'XPC_FLAGS': '0x0', 05:31:44 INFO - 'XPC_SERVICE_NAME': '0', 05:31:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:31:45 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-hHLqL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:31:45 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-h6xcLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:31:45 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-f6cKU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:31:45 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-MdHiv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:31:45 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-FoTUCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:31:45 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-A4HGH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:31:45 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-a4relT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:31:45 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-JyzBY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:31:45 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-5W4QaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:31:46 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-_a5UpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:31:46 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-XbpyDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:31:46 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-UoPkvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:31:46 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-B0V4kp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:31:46 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-Wo8gpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:31:46 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-xaFD0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:31:46 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-oWzo53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:31:46 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-YHeG4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:31:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:31:46 INFO - Running setup.py install for manifestparser 05:31:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:31:47 INFO - Running setup.py install for mozcrash 05:31:47 INFO - Running setup.py install for mozdebug 05:31:47 INFO - Running setup.py install for mozdevice 05:31:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:31:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:31:47 INFO - Running setup.py install for mozfile 05:31:47 INFO - Running setup.py install for mozhttpd 05:31:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:31:47 INFO - Running setup.py install for mozinfo 05:31:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:31:47 INFO - Running setup.py install for mozInstall 05:31:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:31:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:31:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:31:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:31:48 INFO - Running setup.py install for mozleak 05:31:48 INFO - Running setup.py install for mozlog 05:31:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:31:48 INFO - Running setup.py install for moznetwork 05:31:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:31:48 INFO - Running setup.py install for mozprocess 05:31:48 INFO - Running setup.py install for mozprofile 05:31:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:31:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:31:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:31:48 INFO - Running setup.py install for mozrunner 05:31:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:31:48 INFO - Running setup.py install for mozscreenshot 05:31:49 INFO - Running setup.py install for moztest 05:31:49 INFO - Running setup.py install for mozversion 05:31:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:31:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:31:49 INFO - Cleaning up... 05:31:49 INFO - Return code: 0 05:31:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:31: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')]} 05:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31: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')]} 05:31:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:49 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 0x1011adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1e1dc3110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f8bd30>, '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 0x100eb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f80be8>, '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.H5kHGMDbtr/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.YEt39LeKTo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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 05:31:49 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 05:31:49 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 05:31:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5kHGMDbtr/Render', 05:31:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:49 INFO - 'HOME': '/Users/cltbld', 05:31:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:49 INFO - 'LOGNAME': 'cltbld', 05:31:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:49 INFO - 'MOZ_NO_REMOTE': '1', 05:31:49 INFO - 'NO_EM_RESTART': '1', 05:31:49 INFO - 'PAGER': '/bin/cat', 05:31:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:49 INFO - 'PWD': '/builds/slave/test', 05:31:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:49 INFO - 'SHELL': '/bin/bash', 05:31:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YEt39LeKTo/Listeners', 05:31:49 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 05:31:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:49 INFO - 'USER': 'cltbld', 05:31:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:49 INFO - 'XPC_FLAGS': '0x0', 05:31:49 INFO - 'XPC_SERVICE_NAME': '0', 05:31:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:31:49 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-3VHiaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:31:49 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)) 05:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:31:49 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-55gZQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:31:49 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)) 05:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:31:49 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-kTb6Fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:31:50 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)) 05:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:31:50 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-ilFDBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:31:50 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-Dscs1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:31:50 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)) 05:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:31:50 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-ldba1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:31:50 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)) 05:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:31:50 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-utPG7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:31:50 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)) 05:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:31:50 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-8uHnMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:31:50 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)) 05:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:31:50 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-3SwY_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:31:50 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)) 05:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:31:50 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-E_hpq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:31:50 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)) 05:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:31:50 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-JX4viv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:31:50 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)) 05:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:31:50 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-TYbd10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:31:50 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-e3r58Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:31:51 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)) 05:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:31:51 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-Uj69X2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:31:51 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)) 05:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:31:51 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-QotfTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:31:51 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)) 05:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:31:51 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-Q9GOE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:31:51 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)) 05:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:31:51 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-839MQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:31:51 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)) 05:31:51 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)) 05:31:51 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)) 05:31:51 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)) 05:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:31:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:31:51 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 05:31:51 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 05:31:51 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 05:31:51 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 05:31:51 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 05:31:51 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 05:31:54 INFO - Downloading blessings-1.6.tar.gz 05:31:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:31:54 INFO - Installing collected packages: blessings 05:31:54 INFO - Running setup.py install for blessings 05:31:54 INFO - Successfully installed blessings 05:31:54 INFO - Cleaning up... 05:31:54 INFO - Return code: 0 05:31:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:31:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:31:54 INFO - Reading from file tmpfile_stdout 05:31:54 INFO - Current package versions: 05:31:54 INFO - blessings == 1.6 05:31:54 INFO - blobuploader == 1.2.4 05:31:54 INFO - docopt == 0.6.1 05:31:54 INFO - functools32 == 3.2.3-2 05:31:54 INFO - jsonschema == 2.5.1 05:31:54 INFO - manifestparser == 1.1 05:31:54 INFO - mozInstall == 1.12 05:31:54 INFO - mozcrash == 1.0 05:31:54 INFO - mozdebug == 0.1 05:31:54 INFO - mozdevice == 0.49 05:31:54 INFO - mozfile == 1.2 05:31:54 INFO - mozhttpd == 0.7 05:31:54 INFO - mozinfo == 0.9 05:31:54 INFO - mozleak == 0.1 05:31:54 INFO - mozlog == 3.4 05:31:54 INFO - moznetwork == 0.27 05:31:54 INFO - mozprocess == 0.24 05:31:54 INFO - mozprofile == 0.28 05:31:54 INFO - mozrunner == 6.13 05:31:54 INFO - mozscreenshot == 0.1 05:31:54 INFO - mozsystemmonitor == 0.3 05:31:54 INFO - moztest == 0.8 05:31:54 INFO - mozversion == 1.4 05:31:54 INFO - psutil == 3.1.1 05:31:54 INFO - requests == 1.2.3 05:31:54 INFO - wsgiref == 0.1.2 05:31:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:54 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 0x1011adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1e1dc3110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f8bd30>, '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 0x100eb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f80be8>, '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.H5kHGMDbtr/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.YEt39LeKTo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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 05:31:54 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 05:31:54 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 05:31:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5kHGMDbtr/Render', 05:31:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:54 INFO - 'HOME': '/Users/cltbld', 05:31:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:54 INFO - 'LOGNAME': 'cltbld', 05:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:54 INFO - 'MOZ_NO_REMOTE': '1', 05:31:54 INFO - 'NO_EM_RESTART': '1', 05:31:54 INFO - 'PAGER': '/bin/cat', 05:31:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:54 INFO - 'PWD': '/builds/slave/test', 05:31:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:54 INFO - 'SHELL': '/bin/bash', 05:31:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YEt39LeKTo/Listeners', 05:31:54 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 05:31:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:54 INFO - 'USER': 'cltbld', 05:31:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:54 INFO - 'XPC_FLAGS': '0x0', 05:31:54 INFO - 'XPC_SERVICE_NAME': '0', 05:31:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:55 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)) 05:31:55 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)) 05:31:55 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)) 05:31:55 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)) 05:31:55 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)) 05:31:55 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)) 05:31:55 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)) 05:31:55 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)) 05:31:55 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)) 05:31:55 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)) 05:31:55 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)) 05:31:55 INFO - Cleaning up... 05:31:55 INFO - Return code: 0 05:31:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1011adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1e1dc3110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f8bd30>, '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 0x100eb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f80be8>, '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.H5kHGMDbtr/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.YEt39LeKTo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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 05:31:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:31:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:31:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5kHGMDbtr/Render', 05:31:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:55 INFO - 'HOME': '/Users/cltbld', 05:31:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:55 INFO - 'LOGNAME': 'cltbld', 05:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:55 INFO - 'MOZ_NO_REMOTE': '1', 05:31:55 INFO - 'NO_EM_RESTART': '1', 05:31:55 INFO - 'PAGER': '/bin/cat', 05:31:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:55 INFO - 'PWD': '/builds/slave/test', 05:31:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:55 INFO - 'SHELL': '/bin/bash', 05:31:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YEt39LeKTo/Listeners', 05:31:55 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 05:31:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:55 INFO - 'USER': 'cltbld', 05:31:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:55 INFO - 'XPC_FLAGS': '0x0', 05:31:55 INFO - 'XPC_SERVICE_NAME': '0', 05:31:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:31:55 INFO - Cleaning up... 05:31:55 INFO - Return code: 0 05:31:55 INFO - Running post-action listener: _resource_record_post_action 05:31:55 INFO - Running post-action listener: _start_resource_monitoring 05:31:55 INFO - Starting resource monitoring. 05:31:55 INFO - [mozharness: 2017-03-22 12:31:55.482893Z] Finished create-virtualenv step (success) 05:31:55 INFO - [mozharness: 2017-03-22 12:31:55.483812Z] Running install step. 05:31:55 INFO - Running pre-action listener: _resource_record_pre_action 05:31:55 INFO - Running main action method: install 05:31:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:31:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:31:55 INFO - Reading from file tmpfile_stdout 05:31:55 INFO - Detecting whether we're running mozinstall >=1.0... 05:31:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:31:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:31:55 INFO - Reading from file tmpfile_stdout 05:31:55 INFO - Output received: 05:31:55 INFO - Usage: mozinstall [options] installer 05:31:55 INFO - Options: 05:31:55 INFO - -h, --help show this help message and exit 05:31:55 INFO - -d DEST, --destination=DEST 05:31:55 INFO - Directory to install application into. [default: 05:31:55 INFO - "/builds/slave/test"] 05:31:55 INFO - --app=APP Application being installed. [default: firefox] 05:31:55 INFO - mkdir: /builds/slave/test/build/application 05:31:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:31:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 05:32:10 INFO - Reading from file tmpfile_stdout 05:32:10 INFO - Output received: 05:32:10 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 05:32:10 INFO - Running post-action listener: _resource_record_post_action 05:32:10 INFO - [mozharness: 2017-03-22 12:32:10.403723Z] Finished install step (success) 05:32:10 INFO - [mozharness: 2017-03-22 12:32:10.403874Z] Running run-tests step. 05:32:10 INFO - Running pre-action listener: _resource_record_pre_action 05:32:10 INFO - Running main action method: run_tests 05:32:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:32:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:32:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:32:10 INFO - 2017-03-22 05:32:10.418 screenresolution[1624:7365] starting screenresolution argv=screenresolution get 05:32:10 INFO - 2017-03-22 05:32:10.421 screenresolution[1624:7365] Display 0: 1600x1200x32@60 05:32:10 INFO - 2017-03-22 05:32:10.426 screenresolution[1625:7367] starting screenresolution argv=screenresolution list 05:32:10 INFO - Available Modes on Display 0 05:32:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:32:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:32:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:32:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:32:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:32:10 INFO - Intel Iris: 05:32:10 INFO - Chipset Model: Intel Iris 05:32:10 INFO - Type: GPU 05:32:10 INFO - Bus: Built-In 05:32:10 INFO - VRAM (Dynamic, Max): 1536 MB 05:32:10 INFO - Vendor: Intel (0x8086) 05:32:10 INFO - Device ID: 0x0a2e 05:32:10 INFO - Revision ID: 0x0009 05:32:10 INFO - Displays: 05:32:10 INFO - Display: 05:32:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:32:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:32:10 INFO - Display Serial Number: 1600x1200 60 05:32:10 INFO - Main Display: Yes 05:32:10 INFO - Mirror: Off 05:32:10 INFO - Online: Yes 05:32:10 INFO - Rotation: Supported 05:32:10 INFO - Return code: 0 05:32:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:32:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:32:10 INFO - Python 2.7.3 05:32:10 INFO - Return code: 0 05:32:10 INFO - grabbing minidump binary from tooltool 05:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:10 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 0x100f8bd30>, '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 0x100eb2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f80be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:32:10 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 05:32:10 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 05:32:10 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 05:32:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:32:10 INFO - Return code: 0 05:32:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:32:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:32:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:32:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:32:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:32:10 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/Ado8egYdSrSP6BkrxWwfQA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0325', '--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 05:32:10 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/Ado8egYdSrSP6BkrxWwfQA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0325 --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 05:32:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5kHGMDbtr/Render', 05:32:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:10 INFO - 'HOME': '/Users/cltbld', 05:32:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:10 INFO - 'LOGNAME': 'cltbld', 05:32:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:32:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:10 INFO - 'MOZ_NO_REMOTE': '1', 05:32:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:32:10 INFO - 'NO_EM_RESTART': '1', 05:32:10 INFO - 'PAGER': '/bin/cat', 05:32:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:10 INFO - 'PWD': '/builds/slave/test', 05:32:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:32:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:10 INFO - 'SHELL': '/bin/bash', 05:32:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YEt39LeKTo/Listeners', 05:32:10 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 05:32:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:10 INFO - 'USER': 'cltbld', 05:32:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:10 INFO - 'XPC_FLAGS': '0x0', 05:32:10 INFO - 'XPC_SERVICE_NAME': '0', 05:32:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:10 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/Ado8egYdSrSP6BkrxWwfQA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0325', '--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 05:32:11 INFO - mozversion application_buildid: 20170322040835 05:32:11 INFO - mozversion application_changeset: ccd778892fcf082fac94b499d0fada57dd2b712a 05:32:11 INFO - mozversion application_display_name: Firefox 05:32:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:32:11 INFO - mozversion application_name: Firefox 05:32:11 INFO - mozversion application_remotingname: firefox 05:32:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:32:11 INFO - mozversion application_vendor: Mozilla 05:32:11 INFO - mozversion application_version: 53.0 05:32:11 INFO - mozversion platform_buildid: 20170322040835 05:32:11 INFO - mozversion platform_changeset: ccd778892fcf082fac94b499d0fada57dd2b712a 05:32:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:32:11 INFO - mozversion platform_version: 53.0 05:32:11 INFO - using testdate: 1490185931 05:32:11 INFO - actual date: 1490185931 05:32:11 INFO - starting webserver on 'localhost:49250' 05:32:11 INFO - SUITE-START | Running 2 tests 05:32:11 INFO - TEST-START | dromaeo_css 05:32:11 INFO - operating with platform_type : mac_ 05:32:11 INFO - Initialising browser for dromaeo_css test... 05:32:11 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/tmp8dhUZY/profile http://localhost:49250/getInfo.html) 05:32:13 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 05:32:13 INFO - PROCESS | 1635 | colorDepth:24 05:32:13 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 05:32:13 INFO - PROCESS | 1635 | __metrics 05:32:13 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" 05:32:13 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:32:14 INFO - TEST-INFO | 1635: exit 0 05:32:14 INFO - Browser initialized. 05:32:14 INFO - Running cycle 1/1 for dromaeo_css test... 05:32:14 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/tmp8dhUZY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:32:26 INFO - PROCESS | 1638 | RSS: Main: 167153664 05:32:26 INFO - PROCESS | 1638 | 05:35:28 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49250/tests/dromaeo/cssquery-ext.html) 05:35:30 INFO - PROCESS | 1638 | RSS: Main: 368398336 05:35:30 INFO - PROCESS | 1638 | 05:38:33 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-ext.html (next: http://localhost:49250/tests/dromaeo/cssquery-jquery.html) 05:38:33 INFO - PROCESS | 1638 | RSS: Main: 308518912 05:38:33 INFO - PROCESS | 1638 | 05:41:36 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49250/tests/dromaeo/cssquery-mootools.html) 05:41:36 INFO - PROCESS | 1638 | RSS: Main: 273948672 05:41:36 INFO - PROCESS | 1638 | 05:44:39 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49250/tests/dromaeo/cssquery-prototype.html) 05:44:39 INFO - PROCESS | 1638 | RSS: Main: 279207936 05:44:39 INFO - PROCESS | 1638 | 05:47:42 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49250/tests/dromaeo/cssquery-yui.html) 05:47:43 INFO - PROCESS | 1638 | RSS: Main: 267808768 05:47:43 INFO - PROCESS | 1638 | 05:50:46 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-yui.html (next: http://localhost:49250/tests/dromaeo/cssquery-dojo.html) 05:50:47 INFO - PROCESS | 1638 | RSS: Main: 418185216 05:50:47 INFO - PROCESS | 1638 | 05:50:47 INFO - PROCESS | 1638 | __start_tp_report 05:50:47 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 05:50:47 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 05:50:47 INFO - PROCESS | 1638 | |i|pagename|runs| 05:50:47 INFO - PROCESS | 1638 | |0;dojo.html;3388.8983330500077;3399.4051041067805;3438.5014172944925;3440.2259491614404;3476.2699833035063;5683.488486036256;5698.829035128942;5719.742611582478;5732.254806875111;5737.282839645044;5678.48893599576;5748.453896879801;5758.856028599287;5762.510186634141;5764;5187.299714538536;5242.947570524303;5243.4232234454175;5268.657537260085;5307.840764777063;5188.92216616751;5191.714455704935;5210.687358758468;5325.4940780625775;5329.200619907026;3736.8878933632036;4993.151164302078;5152.02111598795;5278.577713782888;5337.572994160477;4330.5669433056755;5329.680219186861;5334.986352592995;5355.98236335095;5369.758360873731;5187.195984622352;5249.396319423277;5264.368275806928;5283.365996080456;5289.920651190235;4620;5597.888042239132;5638.013347664183;5667.064934285838;5669.40471250521;6272.090546870678;6317.399847014526;6321.209848768904;6321.968390158066;6351.555391122623;6312.368763123697;6364;6373.139626150457;6377.904331435032;6382.936170638327;5738.626989245686;5773.076307790733;5815.302163740336;5880.088586269135;5882;6251.031090181029;6280.371962803683;6293.118963345135;6323.36766323364;6326.2092238470195;6248.562600618004;6254.249490061131;6254.249490061222;6257.499400047986;6267.561270711007;6288.779892703734;6290.748370065237;6348.047792831112;6358.904616430757;6366.649834259068;6055.909161362583;6105.145279660851;6109.75560977556;6122.76426410708;6165.920963831311;6223.502119830403;6240.251169859646;6240.469560087444;6254.21822272216;6265.655388953652;4955.306257124005;4986.750662466862;4991.251312303184;4998.825041123543;5004.449510553836;3650.233450975272;4432.800523976429;4464.732116073046;4471.150481408587;4471.418715566955;5886.94113058864;5929.881402371929;5950.285965684146;5952.702364881825;5981.940180598225;6317.96841015792;6347.492200623939;6351.809445716636;6358;6367.235931688135;5123.001014802077;5942.732577033958;5971.104334349882;5979.730912108966;5981.641101533922;4094.467719196485;5450.4549545045975;5456.127019676833;5458.181272809111;5475.06923822951;5285.101532739443;6300.716467758962;6322.241331040213;6327.050942358683;6337.714802833976;6280.8429789253805;6295.842603934755;6312.337204593451;6364.427201551883;6383.808485745435;5735.225744524602;5912.46787789101;6357.523185761179;6376.904346434714;6379.489640828815;6094.75620975156;6143.60399444226;6257.56197066201;6272.780452684134;6274.121622972879;6266.592671476339;6269.435750782452;6272.843178920563;6279.874402512016;6298;6116.480099191441;6125.203723515914;6142.40669208518;6193.969030154821;6196.411340922605;5807.390224026585;6184.567080304336;6185;6189.412005859436;6205.317415084427;6013.488853447506;6016.849578760391;6020.307664618625;6020.969895150496;6026.849328766641;6018.969905150446;6019.337872833898;6077.939220607915;6083.756649733961;6152.600080994721;5855;5886.293644762656;5920.851978700567;5920.970395147997;5944.464998150187 05:50:47 INFO - PROCESS | 1638 | |1;ext.html;503.34062378284426;521.6244304101048;528.0732314787547;558.7876606889382;632.6014610795196;42106;43696.56303436965;43973.12053758923;45709.857253568676;45738.771306143426;45318.773406132925;45755.54244457563;45864.770676146574;45886;45945.77027114868;9032.322575806807;9501.572429240683;9702.22382209425;9705.466199359033;9712.902870971306;9016.459012459241;9172;9176.908230917705;9201.95399023004;11721.238119522246;11801.586944456945;11988.40057997101;11990.520379184865;11997.40012999351;11998.94000529996;9962.551685174185;11773;11862.169648124634;11875.584354547636;11909.285442873368;11728.237664551776;11782.587609433715;11787.705307367298;11790.587329443513;11805.94097029518;42194.36708449376;42543;42554.78722606367;42734.35898461525;42752.57247427517;4035.068558436021;4091.631753142202;4092.9386059208837;4105.404716316118;4106.691998100125;30177.547336789965;30422.239444014078;31794.364112717616;32625.8580949668;32726.181845454055;3272.787268827519;3294.7199488043307;3400.659934006604;3431.4681224410256;3462.809545474998;382157;385232.0738396318;385351;385373;385479;64171.67914160399;64879.67560162169;64888.70222595616;65058.67470662617;65133.67433162804;68087.27650893909;68179.63640727158;68229;68291.31708682948;68357.31642683609;17075.573110672085;17760.55598610045;17765.934043957404;17809.643807124045;17827.286908523773;13649.249291289074;13743.312834358243;13765.931170344084;13771.655708607364;13810.37853296604;15210;15546.9222653886;15571.766423503657;15608.531744047697;16521.83478165227;6724.798256052326;7653.3494652954005;7656.157822639505;7690.615469226516;7722.266384693445;889.9644014239487;890.8218356328631;893.9061398553189;924.8196601662746;929.990700093004;30610.84694576513;31014.22464438362;31086.22284442907;31750;31822.522662160085;1087.7545210733665;1090.2477290669412;1124.516457923101;1130.9660710178707;1235.4008305971597;15646.843531564766;16035.759463608056;16041.278142483383;16112.355505779871;16389.754153687703;620433;626522;627776;629401;629574;53954.46045539495;55367.72316138393;55445.44554554483;61850.38149618446;63831;1422.2746399336413;1471.6320919770058;1473.9631509212356;1477.0768269831356;1498.8501149884924;30716;32435.18912027124;32466.513002305455;32519.837400812845;33358.33283334368;52128.95742085061;52769.736151319;52816;52838;52952.47047529475;569395.1530242322;575630;593087;603981;616284;32202.516962245118;38989;39627.80186099051;39945.00137496586;40094.39858402068;47506.52493475021;47936.7603161982;48234.517654824405;48392.75803620959;48465.75767121142;37937.672181473514;38684.41973370346;40076.62835249019;40587.797061014506;40640.79679601701;38478.845634631005;39066.60933390629;39716.60283397244;39729.80810575687;40148.59479918189;37536;37873;38521.807390962866;38679;38830.61169388383;32410.189745256557;34094.48858267078;34253.479722516066;34502.96491105271;35626.8218658905;18245.726314105035;25073.24780256595;25231.341455488484;25527.48945021052;25691.871540642176 05:50:47 INFO - PROCESS | 1638 | |2;jquery.html;404.80973942247135;409.375702054367;410.3475473996345;421.74905930971073;440.854518009057;20709.275175368864;21201.787982120175;22451.887740561295;22540;22616.660750088762;21833.01751421186;21945;22839.200627978025;23143.727095009766;23213.535729285402;5350;5570.637908535932;5571.0807716726695;5575.553955683536;5580.4698553637545;5479.561635069185;5827.592068555182;6219.502439804827;6253.968730156343;6278.152449419315;6226.533010024244;6242.906356404657;6243.282022567418;6245.344238854923;6248.718807653667;5971;6230.501559875222;6315.8736825263695;6356.0465930110395;6359.42765151134;5997.700114994276;6078.3921607838865;6169.722362493699;6224.221972253468;6248.87502249957;11399.202055856093;13939.512117075854;13977.833435817465;14180.92909535456;14187.645308867257;2617.515759584483;2937.5593660951026;3114.704103110201;3136.592243008417;3157.0055432538675;9673.322867399285;10340.586376544928;10581.470926453723;10823.567057317698;10865.076468500187;1864.9067546622614;1907.198976429889;1913.818187272221;1918.2518817661123;1931.8551108666907;102297.46553801699;137875;143545;145232;146552.26723866313;10024.54889529973;12032.39838008096;12311.015118790476;12432.564860229848;12493.812592811115;16364.263608137662;16495.91752041256;16636.750448743278;16694;16710.83289167093;7017.92982070183;7125.714971401189;9007.189352958265;9248;9452.763680908032;8794.648214071494;9010.504422256708;9159.587818548182;9253.259739220846;9276;4862.440819305754;4962.181240095416;4981.526754958273;5002.824901128516;5018.623603229772;2030.8578399512187;2081.698153767695;2082.3648787120073;2085.113826623679;2087.1755656515593;922.4327038871046;1011.6105299459614;1062.8149613181401;1067.8665166854144;1091.9945400272948;22141.778582214294;22628.547429051327;23035.424114396938;23060.4234894129;23190.42023949381;962.7256231973854;989.5794287427815;1072.5012869015789;1087.1900434176432;1092.7377429417043;10924.617638382619;11803.468843902045;11807.23252988553;11819.290842549475;11885.346305953082;743624;755583;767122;771247;798459;108930.45534772276;137804;157758;160308;162269;1013.6857574152036;1026.3636545341787;1049.4700176411015;1049.8372752223418;1051.0225490293947;19073.523161920508;19864.60270794605;19955.301564445756;20184.49538761543;20189.697154542988;56591.71704141453;61173;63300;64625.384365389364;64840.675796620715;91986;92189.07810921806;92559.53720231356;93498.06501934894;93892;6446.484281257582;6918.679034063577;8540.786480338042;8923.323003098914;9027.916650002042;12750.362481876055;13191.736165276448;13226.272555009182;13561.321933903462;13821.308934553434;11304.43477826089;11657.766844663229;11754.823677644672;12027.879721202677;12045.81931271014;11440.542378304775;11656.18406711522;11841.5855445059;12045.156839021185;12104.394780261127;11477.942610286895;11571.421428928688;11882.10884183707;11931.880681193077;12181.573644922386;7528.661210245662;7928.088269849041;8481.363897707573;8602.39783215169;8728.908886389201;11190.552377904793;11552.249103808226;11642.359670218219;11981.460834262305;11986.160968732105 05:50:47 INFO - PROCESS | 1638 | |3;mootools.html;1294.2752058847047;1365.1194979238398;1456.3373664982435;1482.2736858939122;1486.9851301486985;7689.846203075942;8071.838563228739;8408.83182336353;8638.697645582406;8657.567121643908;8547.871781923277;8606.784830379243;8609.655613775458;8610.956945215265;8614.396992210548;1975.565375617362;2420.1529464687305;2427.8057755379527;2431.57447446697;2433.1119141513395;2142.882141482218;2233.765454627265;2345.5308938212343;2433.8783060846977;2438.5610590093775;2391.390195500154;2400.5198960208027;2402.423418379594;2402.8077753779658;2405.1461731085474;2374.0741110966737;2404.759524047599;2406.061635961976;2407.783299503053;2409.6144616861393;2364.0780095762493;2367.195153647768;2441.292025312657;2441.962166079427;2446.1805295226122;8583.785405364853;8639.827203455896;8655.740327790176;8659.090795466449;8669.783255418602;5182.2485739567555;5328.520433160996;5330.200469929541;5336.546393556514;5345.786168553253;2788.6653601567737;3511.122219445139;3520.806355650438;3578.177019285579;3600.9279814403567;1203.211896207985;1242.6520574239228;1243.8009918413102;1290.2967882504058;1301.4143635364123;11243.325400475998;11320.943395283053;11324.094072474183;11329.886701132966;11330.263532870336;4516.187086324493;4762.78567464465;4788.209945358977;4833.734144622009;4843.104025755247;9692.9030709692;9703.223742100616;9716.514174291256;9720.805583888283;9722.368046076983;5401.7299135043095;5402.540784033323;5407.297051383295;5410.945890541044;5413.566914646819;4485.147821913826;4759.952400476021;4848.248521479177;4923.803047878045;4931.827386041471;3688.907777305535;3803.201327721154;3933.2330195612153;3999.6600288975765;4006.719529632898;1154.8845115488384;1215.7659975125255;1269.289198049077;1274.4710944957924;1294.7475242327844;845.3828705045352;868.4745728834091;870.1863757386864;888.9911100889037;890.7105190813012;5667.404922483162;5722.713864306768;5775.509081728016;5836.2412886325355;5958.523318134538;1017.3844823881593;1019.9031092046243;1020.9387436753818;1023;1061.8566493523276;3629.0020244432994;3794.354959656865;3859.8842034739005;3890.708196885245;3924.7645141291614;9219.861702074475;9528.047195280555;9895.356801807859;10270.948645256725;10283.53724082418;9702.27232957531;10174.898251017543;10175.491225438847;10263;10288.897111028793;7806.375489960789;8126.674933002732;8141.918580814235;8142.470739402039;8153.8369232616205;5460.918086228789;5660.122680984454;5767.2502574666705;5782.508486778671;5975.40245975399;9412.294077944045;9513.619455221713;9520.428774273289;9528.333016688764;9567.043295670377;9129.817403652023;9471.621135154517;9483.430994140374;9525.904740952501;9627;7274.199838017919;7381.926180738124;7388.630568471663;7396.223396543285;7401.222871598405;7197.856042879218;7417.332440080419;7536.944827724233;7562.432817538816;7989.3209077229085;7126.465515086493;7201.0278612386655;7262.96368518154;7267.963660181666;7412.62936853166;7163.6060016699585;7174.605396703023;7183.425325973805;7199.892001619875;7255.782326530212;6475.417212450902;6498.317676644074;6513.8697226056165;6560.114384558024;6589.670516474253;4947.975260123676;4963.801447942186;4977.676451030671;5043.84868453947;5092.592592592509;4966.428860681068;5046.873828154326;5068.087744206078;5151.665141765923;5163.251328557413 05:50:47 INFO - PROCESS | 1638 | |4;prototype.html;376.58387481832574;380.40656575741843;385.49885149305896;394.11521135051794;397.6699339548175;4725.935695302038;5016.993202718914;5139.640225184238;5166.199239117938;5321.115585622493;4933.360652051153;4961.3798275215595;5021.121303771834;5170.974145129278;5198.194279886624;3381.6449272826367;3426.914327141829;4115.238680844046;4155.522114956789;4198.8530401435955;3960.603939606031;4143.627073563379;4176.937345939798;4199.853005144821;4206.843118142505;3635.618260082693;3890.0080479477692;4056.614621610957;4100.917981640366;4168.478940132483;3643.744937854351;3703.8703195525354;3866.8592765134354;4135.855245066408;4164.646005089556;3686.8525258989607;3704.629537046301;3712.962870371289;3714.4428335749585;3718.2074284230202;5007.2489126630935;5127.846234597186;5143.8456846294675;5151.639385242997;5183.974080129613;3632.527771389729;4285.357196420562;4455.955440445587;4733.431988161443;4796.856094317176;5499.945000550023;5518.806841760519;5571.888562228733;5574.721263936787;5579.6652200867675;3562.4834399011997;3976.224636195943;4066.532348779869;4088.8160032798596;4093.2427500912127;5737.655740655574;5813.035351970483;5833.533317334603;5838.795642152504;5841.970790146022;3993.221321842213;4173.227952828736;4184.91630167401;4190.28765109932;4193.748375097504;4019.959800402017;4276.18752437036;4285.400043993844;4303.849365272201;4318.265894797892;4252.4259225004225;4441;4495.707778994355;4496.145732310851;4531.954680453153;5018.548330650259;5154.603109554076;5179.135511215959;5427.891442171134;5511.283533140666;1065.5258410007627;1185.229600759496;1235.5243231355992;1249.2129958126322;1272.8607895933087;841.8148007438353;849.0193826130828;863.9956800215958;874.9413210015952;885.7874110213631;4092.6521245693853;4219.430376899079;4756.762161891892;4962.082014827269;4975.751212439363;4737.431508219036;5190.37715474138;5276.098146019751;5312.946870531246;5410.97294513525;4404.471463424409;4729.43928503593;4876.731779752147;4909.87725306863;4928.704277743347;2403.531311394296;2617.7147679661903;2702.6216329713857;2813.38105616764;2846.4164846206477;5580.967521008626;5593.328800543961;5593.720313984284;5595.608307418442;5628.437156284421;4783.7129772213775;5132.2534549778875;5159.638825282269;5204.76578553966;5242.554382877498;4656.557627025427;5116.855347168806;5203.81786637481;5246.868828279247;5583.274174357308;5125.666831655931;5174.844754657366;5335.959487899978;5361.203996661162;5383.7308134593895;5397.892042159214;5491.7254137292175;5574.442555744393;5593.972030139823;5602.85992850182;5287.75270510024;5295.894082118413;5791.073428251628;5844.47399734026;5871.794487192928;3622.873199438007;3816.637419445148;3826.789526576065;3829.9467646397466;3837.1558257183374;4542.613877820422;4861.260271235658;4920.76105372062;5391.7034563099405;5615.764531802997;5490.474381784424;5500.4224556420995;5503.3120859892515;5505.972470137784;5521.2270282161335;4610.2854057621125;4821.011692602938;5252.9737351314525;5459.235707000944;5569.6936668482;4479.3426432220285;5183.50756678115;5367.651102678314;5393.487618676219;5427.945720542902;4320.4383430153875;5100.336956195671;5297.5232229099565;5383.757730902041;5435.619506634498;5306.814261500829;5346.812861549827;5390.434004429479;5434.5652347812875;5459.69971651563 05:50:47 INFO - PROCESS | 1638 | |5;yui.html;715.3700378024945;746.6266866566716;765.877459606463;866.5840396609627;881.154092071611;15392.615184620376;15575.454859079935;15604.687906241898;15612.141332226724;15634.765478517831;14612.707745845077;14621.780673289883;14659.92670036651;14667.92666036671;14740.33668484918;721;750.3059669805408;752.1049950558845;893.7497500699815;918.5177781664613;912.4616476278994;925.2967744514184;927.6938610258633;928.401181238101;929.0570071377557;976.1214906584061;981.9852702209473;982.6118683120163;982.7002764156929;986.1223511075149;972.5866506734609;974.4202199691208;975;975.0006243600367;975.7072878136566;729.2488736601309;731.9780406587811;733.6808488307549;734.6877577029794;739.1093732052864;15396.23018849053;15584.298706558233;15768.211589420484;15810.920945395314;15977.440789572309;14904.254787260703;15083.396664133421;15286.706993950886;15293.923530382277;15333.23333833315;11773.470193841298;11805.763884722342;12021.459034343476;12037.337946412943;12154.966827819646;3785.6025117362556;3883.5533913600016;3967.1272320089533;3998.8800335989968;4094.897627559305;67915;91189;93043.53478232566;101527.49236253771;102786;11421.143414243965;11502.858766468353;11523.654290371302;11751.177417580859;11850.407479625985;23212.18757343485;23688.763112368655;23950;23951.922163502684;23978.04087836502;8228.83542329162;8239.588020599065;8320.542370169578;8327.250547450758;8444.408891377545;4389.297712366006;4477.238869392146;4496.235639941217;4647.930281045787;4713.222318317507;3677.2645470905927;3730.216654502585;3783.0164157319296;3786.981065094657;3976.840926362971;739.5858319341186;742.9628518574158;743.8214828441135;756.5725365168662;757.9242075792376;685.2017399729359;705.7424040225384;718.1346477494711;734.6069852628818;766.3677466090497;10225.539850706737;10322.174226061898;10362.430066346273;10696.732581685364;10786.946065269623;717.1465955512923;735.2647352647352;740.6852087862637;748.5747907303266;761.6039659377093;5020.3724534433195;5180;5199.636025478256;5202.167653175474;5203.453637368098;73379.63310183414;84356;84686.576567118;87932;91506.54246728723;81342.59328703319;81447.59276203699;81485;81811;83339.16660833314;71551.92672109818;72484.63757681177;73607.26392736111;73691.99999999892;73813.89279160817;9934.304598678023;10765.461726913467;10995.395253261147;11151.275167114112;11296.887031129583;46357.07285854332;47181.528184719085;47550.84931835055;48377;49166;61758;63391.0491342621;64861;65152.37119072061;65930.67034664987;13292.468301267842;13377.464901403835;13409.195448273134;13412.463501459832;13759.036867419185;14794.556163315117;14795.704085918005;15244.923775381052;15256.542303730906;15655.921720391325;10895.836562451412;13571.38928748189;14137.293135343398;14152.221627810157;14210.07634503754;13016.414261358072;13839.654008649462;13905.304734763424;14014.719705606034;14152.929235353757;13642;13700.24648644334;13912.567490234213;13951.790723138958;14341.211233382264;10585.417802020655;10911.454427278446;11163.944180279046;11362;11618.360990145286;10426.530806113591;11126.888731112585;11156.881234800929;11465.254758440675;11479.770404592029 05:50:47 INFO - PROCESS | 1638 | __end_tp_report 05:50:47 INFO - PROCESS | 1638 | __start_cc_report 05:50:47 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,2218 05:50:47 INFO - PROCESS | 1638 | __end_cc_report 05:50:47 INFO - PROCESS | 1638 | __startTimestamp1490187047040__endTimestamp 05:50:47 INFO - PROCESS | 1638 | 05:50:47 INFO - PROCESS | 1638 | ------- Summary: start ------- 05:50:47 INFO - PROCESS | 1638 | Number of tests: 6 05:50:47 INFO - PROCESS | 1638 | 05:50:47 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5750.40 Median:5981.64 stddev:694.32 (11.6%) stddev-sans-first:671.28 05:50:47 INFO - PROCESS | 1638 | Values: 3388.9 3399.4 3438.5 3440.2 3476.3 5683.5 5698.8 5719.7 5732.3 5737.3 5678.5 5748.5 5758.9 5762.5 5764.0 5187.3 5242.9 5243.4 5268.7 5307.8 5188.9 5191.7 5210.7 5325.5 5329.2 3736.9 4993.2 5152.0 5278.6 5337.6 4330.6 5329.7 5335.0 5356.0 5369.8 5187.2 5249.4 5264.4 5283.4 5289.9 4620.0 5597.9 5638.0 5667.1 5669.4 6272.1 6317.4 6321.2 6322.0 6351.6 6312.4 6364.0 6373.1 6377.9 6382.9 5738.6 5773.1 5815.3 5880.1 5882.0 6251.0 6280.4 6293.1 6323.4 6326.2 6248.6 6254.2 6254.2 6257.5 6267.6 6288.8 6290.7 6348.0 6358.9 6366.6 6055.9 6105.1 6109.8 6122.8 6165.9 6223.5 6240.3 6240.5 6254.2 6265.7 4955.3 4986.8 4991.3 4998.8 5004.4 3650.2 4432.8 4464.7 4471.2 4471.4 5886.9 5929.9 5950.3 5952.7 5981.9 6318.0 6347.5 6351.8 6358.0 6367.2 5123.0 5942.7 5971.1 5979.7 5981.6 4094.5 5450.5 5456.1 5458.2 5475.1 5285.1 6300.7 6322.2 6327.1 6337.7 6280.8 6295.8 6312.3 6364.4 6383.8 5735.2 5912.5 6357.5 6376.9 6379.5 6094.8 6143.6 6257.6 6272.8 6274.1 6266.6 6269.4 6272.8 6279.9 6298.0 6116.5 6125.2 6142.4 6194.0 6196.4 5807.4 6184.6 6185.0 6189.4 6205.3 6013.5 6016.8 6020.3 6021.0 6026.8 6019.0 6019.3 6077.9 6083.8 6152.6 5855.0 5886.3 5920.9 5921.0 5944.5 05:50:47 INFO - PROCESS | 1638 | 05:50:47 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:68691.43 Median:39347.21 stddev:145420.05 (369.6%) stddev-sans-first:145737.87 05:50:47 INFO - PROCESS | 1638 | Values: 503.3 521.6 528.1 558.8 632.6 42106.0 43696.6 43973.1 45709.9 45738.8 45318.8 45755.5 45864.8 45886.0 45945.8 9032.3 9501.6 9702.2 9705.5 9712.9 9016.5 9172.0 9176.9 9202.0 11721.2 11801.6 11988.4 11990.5 11997.4 11998.9 9962.6 11773.0 11862.2 11875.6 11909.3 11728.2 11782.6 11787.7 11790.6 11805.9 42194.4 42543.0 42554.8 42734.4 42752.6 4035.1 4091.6 4092.9 4105.4 4106.7 30177.5 30422.2 31794.4 32625.9 32726.2 3272.8 3294.7 3400.7 3431.5 3462.8 382157.0 385232.1 385351.0 385373.0 385479.0 64171.7 64879.7 64888.7 65058.7 65133.7 68087.3 68179.6 68229.0 68291.3 68357.3 17075.6 17760.6 17765.9 17809.6 17827.3 13649.2 13743.3 13765.9 13771.7 13810.4 15210.0 15546.9 15571.8 15608.5 16521.8 6724.8 7653.3 7656.2 7690.6 7722.3 890.0 890.8 893.9 924.8 930.0 30610.8 31014.2 31086.2 31750.0 31822.5 1087.8 1090.2 1124.5 1131.0 1235.4 15646.8 16035.8 16041.3 16112.4 16389.8 620433.0 626522.0 627776.0 629401.0 629574.0 53954.5 55367.7 55445.4 61850.4 63831.0 1422.3 1471.6 1474.0 1477.1 1498.9 30716.0 32435.2 32466.5 32519.8 33358.3 52129.0 52769.7 52816.0 52838.0 52952.5 569395.2 575630.0 593087.0 603981.0 616284.0 32202.5 38989.0 39627.8 39945.0 40094.4 47506.5 47936.8 48234.5 48392.8 48465.8 37937.7 38684.4 40076.6 40587.8 40640.8 38478.8 39066.6 39716.6 39729.8 40148.6 37536.0 37873.0 38521.8 38679.0 38830.6 32410.2 34094.5 34253.5 34503.0 35626.8 18245.7 25073.2 25231.3 25527.5 25691.9 05:50:47 INFO - PROCESS | 1638 | 05:50:47 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:41488.79 Median:22296.83 stddev:127671.67 (572.6%) stddev-sans-first:127992.55 05:50:47 INFO - PROCESS | 1638 | Values: 404.8 409.4 410.3 421.7 440.9 20709.3 21201.8 22451.9 22540.0 22616.7 21833.0 21945.0 22839.2 23143.7 23213.5 5350.0 5570.6 5571.1 5575.6 5580.5 5479.6 5827.6 6219.5 6254.0 6278.2 6226.5 6242.9 6243.3 6245.3 6248.7 5971.0 6230.5 6315.9 6356.0 6359.4 5997.7 6078.4 6169.7 6224.2 6248.9 11399.2 13939.5 13977.8 14180.9 14187.6 2617.5 2937.6 3114.7 3136.6 3157.0 9673.3 10340.6 10581.5 10823.6 10865.1 1864.9 1907.2 1913.8 1918.3 1931.9 102297.5 137875.0 143545.0 145232.0 146552.3 10024.5 12032.4 12311.0 12432.6 12493.8 16364.3 16495.9 16636.8 16694.0 16710.8 7017.9 7125.7 9007.2 9248.0 9452.8 8794.6 9010.5 9159.6 9253.3 9276.0 4862.4 4962.2 4981.5 5002.8 5018.6 2030.9 2081.7 2082.4 2085.1 2087.2 922.4 1011.6 1062.8 1067.9 1092.0 22141.8 22628.5 23035.4 23060.4 23190.4 962.7 989.6 1072.5 1087.2 1092.7 10924.6 11803.5 11807.2 11819.3 11885.3 743624.0 755583.0 767122.0 771247.0 798459.0 108930.5 137804.0 157758.0 160308.0 162269.0 1013.7 1026.4 1049.5 1049.8 1051.0 19073.5 19864.6 19955.3 20184.5 20189.7 56591.7 61173.0 63300.0 64625.4 64840.7 91986.0 92189.1 92559.5 93498.1 93892.0 6446.5 6918.7 8540.8 8923.3 9027.9 12750.4 13191.7 13226.3 13561.3 13821.3 11304.4 11657.8 11754.8 12027.9 12045.8 11440.5 11656.2 11841.6 12045.2 12104.4 11477.9 11571.4 11882.1 11931.9 12181.6 7528.7 7928.1 8481.4 8602.4 8728.9 11190.6 11552.2 11642.4 11981.5 11986.2 05:50:47 INFO - PROCESS | 1638 | 05:50:47 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5557.75 Median:5172.75 stddev:3022.81 (58.4%) stddev-sans-first:3014.30 05:50:47 INFO - PROCESS | 1638 | Values: 1294.3 1365.1 1456.3 1482.3 1487.0 7689.8 8071.8 8408.8 8638.7 8657.6 8547.9 8606.8 8609.7 8611.0 8614.4 1975.6 2420.2 2427.8 2431.6 2433.1 2142.9 2233.8 2345.5 2433.9 2438.6 2391.4 2400.5 2402.4 2402.8 2405.1 2374.1 2404.8 2406.1 2407.8 2409.6 2364.1 2367.2 2441.3 2442.0 2446.2 8583.8 8639.8 8655.7 8659.1 8669.8 5182.2 5328.5 5330.2 5336.5 5345.8 2788.7 3511.1 3520.8 3578.2 3600.9 1203.2 1242.7 1243.8 1290.3 1301.4 11243.3 11320.9 11324.1 11329.9 11330.3 4516.2 4762.8 4788.2 4833.7 4843.1 9692.9 9703.2 9716.5 9720.8 9722.4 5401.7 5402.5 5407.3 5410.9 5413.6 4485.1 4760.0 4848.2 4923.8 4931.8 3688.9 3803.2 3933.2 3999.7 4006.7 1154.9 1215.8 1269.3 1274.5 1294.7 845.4 868.5 870.2 889.0 890.7 5667.4 5722.7 5775.5 5836.2 5958.5 1017.4 1019.9 1020.9 1023.0 1061.9 3629.0 3794.4 3859.9 3890.7 3924.8 9219.9 9528.0 9895.4 10270.9 10283.5 9702.3 10174.9 10175.5 10263.0 10288.9 7806.4 8126.7 8141.9 8142.5 8153.8 5460.9 5660.1 5767.3 5782.5 5975.4 9412.3 9513.6 9520.4 9528.3 9567.0 9129.8 9471.6 9483.4 9525.9 9627.0 7274.2 7381.9 7388.6 7396.2 7401.2 7197.9 7417.3 7536.9 7562.4 7989.3 7126.5 7201.0 7263.0 7268.0 7412.6 7163.6 7174.6 7183.4 7199.9 7255.8 6475.4 6498.3 6513.9 6560.1 6589.7 4948.0 4963.8 4977.7 5043.8 5092.6 4966.4 5046.9 5068.1 5151.7 5163.3 05:50:47 INFO - PROCESS | 1638 | 05:50:47 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4437.76 Median:4961.73 stddev:1315.06 (26.5%) stddev-sans-first:1282.93 05:50:47 INFO - PROCESS | 1638 | Values: 376.6 380.4 385.5 394.1 397.7 4725.9 5017.0 5139.6 5166.2 5321.1 4933.4 4961.4 5021.1 5171.0 5198.2 3381.6 3426.9 4115.2 4155.5 4198.9 3960.6 4143.6 4176.9 4199.9 4206.8 3635.6 3890.0 4056.6 4100.9 4168.5 3643.7 3703.9 3866.9 4135.9 4164.6 3686.9 3704.6 3713.0 3714.4 3718.2 5007.2 5127.8 5143.8 5151.6 5184.0 3632.5 4285.4 4456.0 4733.4 4796.9 5499.9 5518.8 5571.9 5574.7 5579.7 3562.5 3976.2 4066.5 4088.8 4093.2 5737.7 5813.0 5833.5 5838.8 5842.0 3993.2 4173.2 4184.9 4190.3 4193.7 4020.0 4276.2 4285.4 4303.8 4318.3 4252.4 4441.0 4495.7 4496.1 4532.0 5018.5 5154.6 5179.1 5427.9 5511.3 1065.5 1185.2 1235.5 1249.2 1272.9 841.8 849.0 864.0 874.9 885.8 4092.7 4219.4 4756.8 4962.1 4975.8 4737.4 5190.4 5276.1 5312.9 5411.0 4404.5 4729.4 4876.7 4909.9 4928.7 2403.5 2617.7 2702.6 2813.4 2846.4 5581.0 5593.3 5593.7 5595.6 5628.4 4783.7 5132.3 5159.6 5204.8 5242.6 4656.6 5116.9 5203.8 5246.9 5583.3 5125.7 5174.8 5336.0 5361.2 5383.7 5397.9 5491.7 5574.4 5594.0 5602.9 5287.8 5295.9 5791.1 5844.5 5871.8 3622.9 3816.6 3826.8 3829.9 3837.2 4542.6 4861.3 4920.8 5391.7 5615.8 5490.5 5500.4 5503.3 5506.0 5521.2 4610.3 4821.0 5253.0 5459.2 5569.7 4479.3 5183.5 5367.7 5393.5 5427.9 4320.4 5100.3 5297.5 5383.8 5435.6 5306.8 5346.8 5390.4 5434.6 5459.7 05:50:47 INFO - PROCESS | 1638 | 05:50:47 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:19372.20 Median:4242.10 stddev:25871.27 (609.9%) stddev-sans-first:25905.91 05:50:47 INFO - PROCESS | 1638 | Values: 715.4 746.6 765.9 866.6 881.2 15392.6 15575.5 15604.7 15612.1 15634.8 14612.7 14621.8 14659.9 14667.9 14740.3 721.0 750.3 752.1 893.7 918.5 912.5 925.3 927.7 928.4 929.1 976.1 982.0 982.6 982.7 986.1 972.6 974.4 975.0 975.0 975.7 729.2 732.0 733.7 734.7 739.1 15396.2 15584.3 15768.2 15810.9 15977.4 14904.3 15083.4 15286.7 15293.9 15333.2 11773.5 11805.8 12021.5 12037.3 12155.0 3785.6 3883.6 3967.1 3998.9 4094.9 67915.0 91189.0 93043.5 101527.5 102786.0 11421.1 11502.9 11523.7 11751.2 11850.4 23212.2 23688.8 23950.0 23951.9 23978.0 8228.8 8239.6 8320.5 8327.3 8444.4 4389.3 4477.2 4496.2 4647.9 4713.2 3677.3 3730.2 3783.0 3787.0 3976.8 739.6 743.0 743.8 756.6 757.9 685.2 705.7 718.1 734.6 766.4 10225.5 10322.2 10362.4 10696.7 10786.9 717.1 735.3 740.7 748.6 761.6 5020.4 5180.0 5199.6 5202.2 5203.5 73379.6 84356.0 84686.6 87932.0 91506.5 81342.6 81447.6 81485.0 81811.0 83339.2 71551.9 72484.6 73607.3 73692.0 73813.9 9934.3 10765.5 10995.4 11151.3 11296.9 46357.1 47181.5 47550.8 48377.0 49166.0 61758.0 63391.0 64861.0 65152.4 65930.7 13292.5 13377.5 13409.2 13412.5 13759.0 14794.6 14795.7 15244.9 15256.5 15655.9 10895.8 13571.4 14137.3 14152.2 14210.1 13016.4 13839.7 13905.3 14014.7 14152.9 13642.0 13700.2 13912.6 13951.8 14341.2 10585.4 10911.5 11163.9 11362.0 11618.4 10426.5 11126.9 11156.9 11465.3 11479.8 05:50:47 INFO - PROCESS | 1638 | -------- Summary: end -------- 05:50:47 INFO - PROCESS | 1638 | 05:50:47 INFO - TEST-INFO | 1638: exit 0 05:50:47 INFO - TEST-OK | dromaeo_css | took 1116634ms 05:50:47 INFO - TEST-START | kraken 05:50:47 INFO - operating with platform_type : mac_ 05:50:47 INFO - Initialising browser for kraken test... 05:50:47 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/tmp9COtvk/profile http://localhost:49250/getInfo.html) 05:50:49 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 05:50:49 INFO - PROCESS | 1647 | colorDepth:24 05:50:49 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 05:50:49 INFO - PROCESS | 1647 | __metrics 05:50:49 INFO - PROCESS | 1647 | 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" 05:50:49 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:50:50 INFO - TEST-INFO | 1647: exit 0 05:50:50 INFO - Browser initialized. 05:50:50 INFO - Running cycle 1/1 for kraken test... 05:50:50 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/tmp9COtvk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:51:02 INFO - PROCESS | 1649 | RSS: Main: 163598336 05:51:02 INFO - PROCESS | 1649 | 05:51:05 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection) 05:51:06 INFO - PROCESS | 1649 | RSS: Main: 213966848 05:51:06 INFO - PROCESS | 1649 | 05:51:08 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-dft) 05:51:09 INFO - PROCESS | 1649 | RSS: Main: 229330944 05:51:09 INFO - PROCESS | 1649 | 05:51:12 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-fft) 05:51:12 INFO - PROCESS | 1649 | RSS: Main: 327311360 05:51:12 INFO - PROCESS | 1649 | 05:51:14 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator) 05:51:15 INFO - PROCESS | 1649 | RSS: Main: 229912576 05:51:15 INFO - PROCESS | 1649 | 05:51:17 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:51:17 INFO - PROCESS | 1649 | RSS: Main: 231243776 05:51:17 INFO - PROCESS | 1649 | 05:51:20 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom) 05:51:21 INFO - PROCESS | 1649 | RSS: Main: 271388672 05:51:21 INFO - PROCESS | 1649 | 05:51:24 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate) 05:51:24 INFO - PROCESS | 1649 | RSS: Main: 270610432 05:51:24 INFO - PROCESS | 1649 | 05:51:27 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial) 05:51:28 INFO - PROCESS | 1649 | RSS: Main: 266977280 05:51:28 INFO - PROCESS | 1649 | 05:51:29 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:51:30 INFO - PROCESS | 1649 | RSS: Main: 244387840 05:51:30 INFO - PROCESS | 1649 | 05:51:32 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:51:32 INFO - PROCESS | 1649 | RSS: Main: 247164928 05:51:32 INFO - PROCESS | 1649 | 05:51:34 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:51:35 INFO - PROCESS | 1649 | RSS: Main: 257302528 05:51:35 INFO - PROCESS | 1649 | 05:51:38 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:51:39 INFO - PROCESS | 1649 | RSS: Main: 268754944 05:51:39 INFO - PROCESS | 1649 | 05:51:41 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:51:42 INFO - PROCESS | 1649 | RSS: Main: 262995968 05:51:42 INFO - PROCESS | 1649 | 05:51:44 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49250/tests/kraken/driver.html?testName=ai-astar) 05:51:44 INFO - PROCESS | 1649 | RSS: Main: 307646464 05:51:44 INFO - PROCESS | 1649 | 05:51:44 INFO - PROCESS | 1649 | __start_tp_report 05:51:44 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 05:51:44 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 05:51:44 INFO - PROCESS | 1649 | |i|pagename|runs| 05:51:44 INFO - PROCESS | 1649 | |0;ai-astar;103;113;114;113;110;115;113;112;113;113 05:51:44 INFO - PROCESS | 1649 | |1;audio-beat-detection;142;106;109;144;107;105;108;118;128;108 05:51:44 INFO - PROCESS | 1649 | |2;audio-dft;184;182;182;184;181;179;182;182;183;182 05:51:44 INFO - PROCESS | 1649 | |3;audio-fft;80;59;58;88;61;57;57;58;72;69 05:51:44 INFO - PROCESS | 1649 | |4;audio-oscillator;83;69;85;68;67;69;79;66;69;82 05:51:44 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;87;83;86;83;86;84;87;83;86;83 05:51:44 INFO - PROCESS | 1649 | |6;imaging-darkroom;93;95;94;95;94;94;95;94;94;95 05:51:44 INFO - PROCESS | 1649 | |7;imaging-desaturate;85;84;83;88;84;85;85;83;85;86 05:51:44 INFO - PROCESS | 1649 | |8;json-parse-financial;53;53;54;55;57;57;54;56;56;54 05:51:44 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;63;71;73;72;69;68;69;73;69;69 05:51:44 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;85;84;80;98;100;82;81;83;87;88 05:51:44 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;130;143;121;140;135;148;143;134;178;133 05:51:44 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;163;164;161;159;161;163;157;161;163;165 05:51:44 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;65;63;65;64;63;64;63;63;63;63 05:51:44 INFO - PROCESS | 1649 | __end_tp_report 05:51:44 INFO - PROCESS | 1649 | __start_cc_report 05:51:44 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,1908 05:51:44 INFO - PROCESS | 1649 | __end_cc_report 05:51:44 INFO - PROCESS | 1649 | __startTimestamp1490187104357__endTimestamp 05:51:44 INFO - PROCESS | 1649 | 05:51:44 INFO - PROCESS | 1649 | ------- Summary: start ------- 05:51:44 INFO - PROCESS | 1649 | Number of tests: 14 05:51:44 INFO - PROCESS | 1649 | 05:51:44 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:3.38 (3.0%) stddev-sans-first:1.36 05:51:44 INFO - PROCESS | 1649 | Values: 103.0 113.0 114.0 113.0 110.0 115.0 113.0 112.0 113.0 113.0 05:51:44 INFO - PROCESS | 1649 | 05:51:44 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:117.50 Median:113.50 stddev:15.15 (13.3%) stddev-sans-first:13.22 05:51:44 INFO - PROCESS | 1649 | Values: 142.0 106.0 109.0 144.0 107.0 105.0 108.0 118.0 128.0 108.0 05:51:44 INFO - PROCESS | 1649 | 05:51:44 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:182.10 Median:182.00 stddev:1.45 (0.8%) stddev-sans-first:1.36 05:51:44 INFO - PROCESS | 1649 | Values: 184.0 182.0 182.0 184.0 181.0 179.0 182.0 182.0 183.0 182.0 05:51:44 INFO - PROCESS | 1649 | 05:51:44 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:65.90 Median:65.00 stddev:11.00 (16.9%) stddev-sans-first:10.42 05:51:44 INFO - PROCESS | 1649 | Values: 80.0 59.0 58.0 88.0 61.0 57.0 57.0 58.0 72.0 69.0 05:51:44 INFO - PROCESS | 1649 | 05:51:44 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:73.70 Median:74.00 stddev:7.56 (10.2%) stddev-sans-first:7.23 05:51:44 INFO - PROCESS | 1649 | Values: 83.0 69.0 85.0 68.0 67.0 69.0 79.0 66.0 69.0 82.0 05:51:44 INFO - PROCESS | 1649 | 05:51:44 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:84.80 Median:86.00 stddev:1.75 (2.0%) stddev-sans-first:1.67 05:51:44 INFO - PROCESS | 1649 | Values: 87.0 83.0 86.0 83.0 86.0 84.0 87.0 83.0 86.0 83.0 05:51:44 INFO - PROCESS | 1649 | 05:51:44 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.50 stddev:0.67 (0.7%) stddev-sans-first:0.53 05:51:44 INFO - PROCESS | 1649 | Values: 93.0 95.0 94.0 95.0 94.0 94.0 95.0 94.0 94.0 95.0 05:51:44 INFO - PROCESS | 1649 | 05:51:44 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:1.48 (1.7%) stddev-sans-first:1.56 05:51:44 INFO - PROCESS | 1649 | Values: 85.0 84.0 83.0 88.0 84.0 85.0 85.0 83.0 85.0 86.0 05:51:44 INFO - PROCESS | 1649 | 05:51:44 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.50 stddev:1.52 (2.7%) stddev-sans-first:1.45 05:51:44 INFO - PROCESS | 1649 | Values: 53.0 53.0 54.0 55.0 57.0 57.0 54.0 56.0 56.0 54.0 05:51:44 INFO - PROCESS | 1649 | 05:51:44 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:2.95 (4.2%) stddev-sans-first:1.94 05:51:44 INFO - PROCESS | 1649 | Values: 63.0 71.0 73.0 72.0 69.0 68.0 69.0 73.0 69.0 69.0 05:51:44 INFO - PROCESS | 1649 | 05:51:44 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:84.50 stddev:6.91 (8.2%) stddev-sans-first:7.30 05:51:44 INFO - PROCESS | 1649 | Values: 85.0 84.0 80.0 98.0 100.0 82.0 81.0 83.0 87.0 88.0 05:51:44 INFO - PROCESS | 1649 | 05:51:44 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:140.50 Median:141.50 stddev:15.26 (10.8%) stddev-sans-first:15.70 05:51:44 INFO - PROCESS | 1649 | Values: 130.0 143.0 121.0 140.0 135.0 148.0 143.0 134.0 178.0 133.0 05:51:44 INFO - PROCESS | 1649 | 05:51:44 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:163.00 stddev:2.41 (1.5%) stddev-sans-first:2.51 05:51:44 INFO - PROCESS | 1649 | Values: 163.0 164.0 161.0 159.0 161.0 163.0 157.0 161.0 163.0 165.0 05:51:44 INFO - PROCESS | 1649 | 05:51:44 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.50 stddev:0.84 (1.3%) stddev-sans-first:0.73 05:51:44 INFO - PROCESS | 1649 | Values: 65.0 63.0 65.0 64.0 63.0 64.0 63.0 63.0 63.0 63.0 05:51:44 INFO - PROCESS | 1649 | -------- Summary: end -------- 05:51:44 INFO - PROCESS | 1649 | 05:51:45 INFO - TEST-INFO | 1649: exit 0 05:51:45 INFO - TEST-OK | kraken | took 57556ms 05:51:45 INFO - SUITE-END | took 1174s 05:51:45 INFO - Completed test suite (00:19:34) 05:51:45 INFO - javascript benchmark 05:51:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3388.8983330500077, 3399.4051041067805, 3438.5014172944925, 3440.2259491614404, 3476.2699833035063, 5683.488486036256, 5698.829035128942, 5719.742611582478, 5732.254806875111, 5737.282839645044, 5678.48893599576, 5748.453896879801, 5758.856028599287, 5762.510186634141, 5764.0, 5187.299714538536, 5242.947570524303, 5243.4232234454175, 5268.657537260085, 5307.840764777063, 5188.92216616751, 5191.714455704935, 5210.687358758468, 5325.4940780625775, 5329.200619907026, 3736.8878933632036, 4993.151164302078, 5152.02111598795, 5278.577713782888, 5337.572994160477, 4330.5669433056755, 5329.680219186861, 5334.986352592995, 5355.98236335095, 5369.758360873731, 5187.195984622352, 5249.396319423277, 5264.368275806928, 5283.365996080456, 5289.920651190235, 4620.0, 5597.888042239132, 5638.013347664183, 5667.064934285838, 5669.40471250521, 6272.090546870678, 6317.399847014526, 6321.209848768904, 6321.968390158066, 6351.555391122623, 6312.368763123697, 6364.0, 6373.139626150457, 6377.904331435032, 6382.936170638327, 5738.626989245686, 5773.076307790733, 5815.302163740336, 5880.088586269135, 5882.0, 6251.031090181029, 6280.371962803683, 6293.118963345135, 6323.36766323364, 6326.2092238470195, 6248.562600618004, 6254.249490061131, 6254.249490061222, 6257.499400047986, 6267.561270711007, 6288.779892703734, 6290.748370065237, 6348.047792831112, 6358.904616430757, 6366.649834259068, 6055.909161362583, 6105.145279660851, 6109.75560977556, 6122.76426410708, 6165.920963831311, 6223.502119830403, 6240.251169859646, 6240.469560087444, 6254.21822272216, 6265.655388953652, 4955.306257124005, 4986.750662466862, 4991.251312303184, 4998.825041123543, 5004.449510553836, 3650.233450975272, 4432.800523976429, 4464.732116073046, 4471.150481408587, 4471.418715566955, 5886.94113058864, 5929.881402371929, 5950.285965684146, 5952.702364881825, 5981.940180598225, 6317.96841015792, 6347.492200623939, 6351.809445716636, 6358.0, 6367.235931688135, 5123.001014802077, 5942.732577033958, 5971.104334349882, 5979.730912108966, 5981.641101533922, 4094.467719196485, 5450.4549545045975, 5456.127019676833, 5458.181272809111, 5475.06923822951, 5285.101532739443, 6300.716467758962, 6322.241331040213, 6327.050942358683, 6337.714802833976, 6280.8429789253805, 6295.842603934755, 6312.337204593451, 6364.427201551883, 6383.808485745435, 5735.225744524602, 5912.46787789101, 6357.523185761179, 6376.904346434714, 6379.489640828815, 6094.75620975156, 6143.60399444226, 6257.56197066201, 6272.780452684134, 6274.121622972879, 6266.592671476339, 6269.435750782452, 6272.843178920563, 6279.874402512016, 6298.0, 6116.480099191441, 6125.203723515914, 6142.40669208518, 6193.969030154821, 6196.411340922605, 5807.390224026585, 6184.567080304336, 6185.0, 6189.412005859436, 6205.317415084427, 6013.488853447506, 6016.849578760391, 6020.307664618625, 6020.969895150496, 6026.849328766641, 6018.969905150446, 6019.337872833898, 6077.939220607915, 6083.756649733961, 6152.600080994721, 5855.0, 5886.293644762656, 5920.851978700567, 5920.970395147997, 5944.464998150187], "value": 5706.121864769191, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.34062378284426, 521.6244304101048, 528.0732314787547, 558.7876606889382, 632.6014610795196, 42106.0, 43696.56303436965, 43973.12053758923, 45709.857253568676, 45738.771306143426, 45318.773406132925, 45755.54244457563, 45864.770676146574, 45886.0, 45945.77027114868, 9032.322575806807, 9501.572429240683, 9702.22382209425, 9705.466199359033, 9712.902870971306, 9016.459012459241, 9172.0, 9176.908230917705, 9201.95399023004, 11721.238119522246, 11801.586944456945, 11988.40057997101, 11990.520379184865, 11997.40012999351, 11998.94000529996, 9962.551685174185, 11773.0, 11862.169648124634, 11875.584354547636, 11909.285442873368, 11728.237664551776, 11782.587609433715, 11787.705307367298, 11790.587329443513, 11805.94097029518, 42194.36708449376, 42543.0, 42554.78722606367, 42734.35898461525, 42752.57247427517, 4035.068558436021, 4091.631753142202, 4092.9386059208837, 4105.404716316118, 4106.691998100125, 30177.547336789965, 30422.239444014078, 31794.364112717616, 32625.8580949668, 32726.181845454055, 3272.787268827519, 3294.7199488043307, 3400.659934006604, 3431.4681224410256, 3462.809545474998, 382157.0, 385232.0738396318, 385351.0, 385373.0, 385479.0, 64171.67914160399, 64879.67560162169, 64888.70222595616, 65058.67470662617, 65133.67433162804, 68087.27650893909, 68179.63640727158, 68229.0, 68291.31708682948, 68357.31642683609, 17075.573110672085, 17760.55598610045, 17765.934043957404, 17809.643807124045, 17827.286908523773, 13649.249291289074, 13743.312834358243, 13765.931170344084, 13771.655708607364, 13810.37853296604, 15210.0, 15546.9222653886, 15571.766423503657, 15608.531744047697, 16521.83478165227, 6724.798256052326, 7653.3494652954005, 7656.157822639505, 7690.615469226516, 7722.266384693445, 889.9644014239487, 890.8218356328631, 893.9061398553189, 924.8196601662746, 929.990700093004, 30610.84694576513, 31014.22464438362, 31086.22284442907, 31750.0, 31822.522662160085, 1087.7545210733665, 1090.2477290669412, 1124.516457923101, 1130.9660710178707, 1235.4008305971597, 15646.843531564766, 16035.759463608056, 16041.278142483383, 16112.355505779871, 16389.754153687703, 620433.0, 626522.0, 627776.0, 629401.0, 629574.0, 53954.46045539495, 55367.72316138393, 55445.44554554483, 61850.38149618446, 63831.0, 1422.2746399336413, 1471.6320919770058, 1473.9631509212356, 1477.0768269831356, 1498.8501149884924, 30716.0, 32435.18912027124, 32466.513002305455, 32519.837400812845, 33358.33283334368, 52128.95742085061, 52769.736151319, 52816.0, 52838.0, 52952.47047529475, 569395.1530242322, 575630.0, 593087.0, 603981.0, 616284.0, 32202.516962245118, 38989.0, 39627.80186099051, 39945.00137496586, 40094.39858402068, 47506.52493475021, 47936.7603161982, 48234.517654824405, 48392.75803620959, 48465.75767121142, 37937.672181473514, 38684.41973370346, 40076.62835249019, 40587.797061014506, 40640.79679601701, 38478.845634631005, 39066.60933390629, 39716.60283397244, 39729.80810575687, 40148.59479918189, 37536.0, 37873.0, 38521.807390962866, 38679.0, 38830.61169388383, 32410.189745256557, 34094.48858267078, 34253.479722516066, 34502.96491105271, 35626.8218658905, 18245.726314105035, 25073.24780256595, 25231.341455488484, 25527.48945021052, 25691.871540642176], "value": 20959.910108654112, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.80973942247135, 409.375702054367, 410.3475473996345, 421.74905930971073, 440.854518009057, 20709.275175368864, 21201.787982120175, 22451.887740561295, 22540.0, 22616.660750088762, 21833.01751421186, 21945.0, 22839.200627978025, 23143.727095009766, 23213.535729285402, 5350.0, 5570.637908535932, 5571.0807716726695, 5575.553955683536, 5580.4698553637545, 5479.561635069185, 5827.592068555182, 6219.502439804827, 6253.968730156343, 6278.152449419315, 6226.533010024244, 6242.906356404657, 6243.282022567418, 6245.344238854923, 6248.718807653667, 5971.0, 6230.501559875222, 6315.8736825263695, 6356.0465930110395, 6359.42765151134, 5997.700114994276, 6078.3921607838865, 6169.722362493699, 6224.221972253468, 6248.87502249957, 11399.202055856093, 13939.512117075854, 13977.833435817465, 14180.92909535456, 14187.645308867257, 2617.515759584483, 2937.5593660951026, 3114.704103110201, 3136.592243008417, 3157.0055432538675, 9673.322867399285, 10340.586376544928, 10581.470926453723, 10823.567057317698, 10865.076468500187, 1864.9067546622614, 1907.198976429889, 1913.818187272221, 1918.2518817661123, 1931.8551108666907, 102297.46553801699, 137875.0, 143545.0, 145232.0, 146552.26723866313, 10024.54889529973, 12032.39838008096, 12311.015118790476, 12432.564860229848, 12493.812592811115, 16364.263608137662, 16495.91752041256, 16636.750448743278, 16694.0, 16710.83289167093, 7017.92982070183, 7125.714971401189, 9007.189352958265, 9248.0, 9452.763680908032, 8794.648214071494, 9010.504422256708, 9159.587818548182, 9253.259739220846, 9276.0, 4862.440819305754, 4962.181240095416, 4981.526754958273, 5002.824901128516, 5018.623603229772, 2030.8578399512187, 2081.698153767695, 2082.3648787120073, 2085.113826623679, 2087.1755656515593, 922.4327038871046, 1011.6105299459614, 1062.8149613181401, 1067.8665166854144, 1091.9945400272948, 22141.778582214294, 22628.547429051327, 23035.424114396938, 23060.4234894129, 23190.42023949381, 962.7256231973854, 989.5794287427815, 1072.5012869015789, 1087.1900434176432, 1092.7377429417043, 10924.617638382619, 11803.468843902045, 11807.23252988553, 11819.290842549475, 11885.346305953082, 743624.0, 755583.0, 767122.0, 771247.0, 798459.0, 108930.45534772276, 137804.0, 157758.0, 160308.0, 162269.0, 1013.6857574152036, 1026.3636545341787, 1049.4700176411015, 1049.8372752223418, 1051.0225490293947, 19073.523161920508, 19864.60270794605, 19955.301564445756, 20184.49538761543, 20189.697154542988, 56591.71704141453, 61173.0, 63300.0, 64625.384365389364, 64840.675796620715, 91986.0, 92189.07810921806, 92559.53720231356, 93498.06501934894, 93892.0, 6446.484281257582, 6918.679034063577, 8540.786480338042, 8923.323003098914, 9027.916650002042, 12750.362481876055, 13191.736165276448, 13226.272555009182, 13561.321933903462, 13821.308934553434, 11304.43477826089, 11657.766844663229, 11754.823677644672, 12027.879721202677, 12045.81931271014, 11440.542378304775, 11656.18406711522, 11841.5855445059, 12045.156839021185, 12104.394780261127, 11477.942610286895, 11571.421428928688, 11882.10884183707, 11931.880681193077, 12181.573644922386, 7528.661210245662, 7928.088269849041, 8481.363897707573, 8602.39783215169, 8728.908886389201, 11190.552377904793, 11552.249103808226, 11642.359670218219, 11981.460834262305, 11986.160968732105], "value": 10159.12736248229, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1294.2752058847047, 1365.1194979238398, 1456.3373664982435, 1482.2736858939122, 1486.9851301486985, 7689.846203075942, 8071.838563228739, 8408.83182336353, 8638.697645582406, 8657.567121643908, 8547.871781923277, 8606.784830379243, 8609.655613775458, 8610.956945215265, 8614.396992210548, 1975.565375617362, 2420.1529464687305, 2427.8057755379527, 2431.57447446697, 2433.1119141513395, 2142.882141482218, 2233.765454627265, 2345.5308938212343, 2433.8783060846977, 2438.5610590093775, 2391.390195500154, 2400.5198960208027, 2402.423418379594, 2402.8077753779658, 2405.1461731085474, 2374.0741110966737, 2404.759524047599, 2406.061635961976, 2407.783299503053, 2409.6144616861393, 2364.0780095762493, 2367.195153647768, 2441.292025312657, 2441.962166079427, 2446.1805295226122, 8583.785405364853, 8639.827203455896, 8655.740327790176, 8659.090795466449, 8669.783255418602, 5182.2485739567555, 5328.520433160996, 5330.200469929541, 5336.546393556514, 5345.786168553253, 2788.6653601567737, 3511.122219445139, 3520.806355650438, 3578.177019285579, 3600.9279814403567, 1203.211896207985, 1242.6520574239228, 1243.8009918413102, 1290.2967882504058, 1301.4143635364123, 11243.325400475998, 11320.943395283053, 11324.094072474183, 11329.886701132966, 11330.263532870336, 4516.187086324493, 4762.78567464465, 4788.209945358977, 4833.734144622009, 4843.104025755247, 9692.9030709692, 9703.223742100616, 9716.514174291256, 9720.805583888283, 9722.368046076983, 5401.7299135043095, 5402.540784033323, 5407.297051383295, 5410.945890541044, 5413.566914646819, 4485.147821913826, 4759.952400476021, 4848.248521479177, 4923.803047878045, 4931.827386041471, 3688.907777305535, 3803.201327721154, 3933.2330195612153, 3999.6600288975765, 4006.719529632898, 1154.8845115488384, 1215.7659975125255, 1269.289198049077, 1274.4710944957924, 1294.7475242327844, 845.3828705045352, 868.4745728834091, 870.1863757386864, 888.9911100889037, 890.7105190813012, 5667.404922483162, 5722.713864306768, 5775.509081728016, 5836.2412886325355, 5958.523318134538, 1017.3844823881593, 1019.9031092046243, 1020.9387436753818, 1023.0, 1061.8566493523276, 3629.0020244432994, 3794.354959656865, 3859.8842034739005, 3890.708196885245, 3924.7645141291614, 9219.861702074475, 9528.047195280555, 9895.356801807859, 10270.948645256725, 10283.53724082418, 9702.27232957531, 10174.898251017543, 10175.491225438847, 10263.0, 10288.897111028793, 7806.375489960789, 8126.674933002732, 8141.918580814235, 8142.470739402039, 8153.8369232616205, 5460.918086228789, 5660.122680984454, 5767.2502574666705, 5782.508486778671, 5975.40245975399, 9412.294077944045, 9513.619455221713, 9520.428774273289, 9528.333016688764, 9567.043295670377, 9129.817403652023, 9471.621135154517, 9483.430994140374, 9525.904740952501, 9627.0, 7274.199838017919, 7381.926180738124, 7388.630568471663, 7396.223396543285, 7401.222871598405, 7197.856042879218, 7417.332440080419, 7536.944827724233, 7562.432817538816, 7989.3209077229085, 7126.465515086493, 7201.0278612386655, 7262.96368518154, 7267.963660181666, 7412.62936853166, 7163.6060016699585, 7174.605396703023, 7183.425325973805, 7199.892001619875, 7255.782326530212, 6475.417212450902, 6498.317676644074, 6513.8697226056165, 6560.114384558024, 6589.670516474253, 4947.975260123676, 4963.801447942186, 4977.676451030671, 5043.84868453947, 5092.592592592509, 4966.428860681068, 5046.873828154326, 5068.087744206078, 5151.665141765923, 5163.251328557413], "value": 4520.284182700423, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.58387481832574, 380.40656575741843, 385.49885149305896, 394.11521135051794, 397.6699339548175, 4725.935695302038, 5016.993202718914, 5139.640225184238, 5166.199239117938, 5321.115585622493, 4933.360652051153, 4961.3798275215595, 5021.121303771834, 5170.974145129278, 5198.194279886624, 3381.6449272826367, 3426.914327141829, 4115.238680844046, 4155.522114956789, 4198.8530401435955, 3960.603939606031, 4143.627073563379, 4176.937345939798, 4199.853005144821, 4206.843118142505, 3635.618260082693, 3890.0080479477692, 4056.614621610957, 4100.917981640366, 4168.478940132483, 3643.744937854351, 3703.8703195525354, 3866.8592765134354, 4135.855245066408, 4164.646005089556, 3686.8525258989607, 3704.629537046301, 3712.962870371289, 3714.4428335749585, 3718.2074284230202, 5007.2489126630935, 5127.846234597186, 5143.8456846294675, 5151.639385242997, 5183.974080129613, 3632.527771389729, 4285.357196420562, 4455.955440445587, 4733.431988161443, 4796.856094317176, 5499.945000550023, 5518.806841760519, 5571.888562228733, 5574.721263936787, 5579.6652200867675, 3562.4834399011997, 3976.224636195943, 4066.532348779869, 4088.8160032798596, 4093.2427500912127, 5737.655740655574, 5813.035351970483, 5833.533317334603, 5838.795642152504, 5841.970790146022, 3993.221321842213, 4173.227952828736, 4184.91630167401, 4190.28765109932, 4193.748375097504, 4019.959800402017, 4276.18752437036, 4285.400043993844, 4303.849365272201, 4318.265894797892, 4252.4259225004225, 4441.0, 4495.707778994355, 4496.145732310851, 4531.954680453153, 5018.548330650259, 5154.603109554076, 5179.135511215959, 5427.891442171134, 5511.283533140666, 1065.5258410007627, 1185.229600759496, 1235.5243231355992, 1249.2129958126322, 1272.8607895933087, 841.8148007438353, 849.0193826130828, 863.9956800215958, 874.9413210015952, 885.7874110213631, 4092.6521245693853, 4219.430376899079, 4756.762161891892, 4962.082014827269, 4975.751212439363, 4737.431508219036, 5190.37715474138, 5276.098146019751, 5312.946870531246, 5410.97294513525, 4404.471463424409, 4729.43928503593, 4876.731779752147, 4909.87725306863, 4928.704277743347, 2403.531311394296, 2617.7147679661903, 2702.6216329713857, 2813.38105616764, 2846.4164846206477, 5580.967521008626, 5593.328800543961, 5593.720313984284, 5595.608307418442, 5628.437156284421, 4783.7129772213775, 5132.2534549778875, 5159.638825282269, 5204.76578553966, 5242.554382877498, 4656.557627025427, 5116.855347168806, 5203.81786637481, 5246.868828279247, 5583.274174357308, 5125.666831655931, 5174.844754657366, 5335.959487899978, 5361.203996661162, 5383.7308134593895, 5397.892042159214, 5491.7254137292175, 5574.442555744393, 5593.972030139823, 5602.85992850182, 5287.75270510024, 5295.894082118413, 5791.073428251628, 5844.47399734026, 5871.794487192928, 3622.873199438007, 3816.637419445148, 3826.789526576065, 3829.9467646397466, 3837.1558257183374, 4542.613877820422, 4861.260271235658, 4920.76105372062, 5391.7034563099405, 5615.764531802997, 5490.474381784424, 5500.4224556420995, 5503.3120859892515, 5505.972470137784, 5521.2270282161335, 4610.2854057621125, 4821.011692602938, 5252.9737351314525, 5459.235707000944, 5569.6936668482, 4479.3426432220285, 5183.50756678115, 5367.651102678314, 5393.487618676219, 5427.945720542902, 4320.4383430153875, 5100.336956195671, 5297.5232229099565, 5383.757730902041, 5435.619506634498, 5306.814261500829, 5346.812861549827, 5390.434004429479, 5434.5652347812875, 5459.69971651563], "value": 4032.8987434605115, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.3700378024945, 746.6266866566716, 765.877459606463, 866.5840396609627, 881.154092071611, 15392.615184620376, 15575.454859079935, 15604.687906241898, 15612.141332226724, 15634.765478517831, 14612.707745845077, 14621.780673289883, 14659.92670036651, 14667.92666036671, 14740.33668484918, 721.0, 750.3059669805408, 752.1049950558845, 893.7497500699815, 918.5177781664613, 912.4616476278994, 925.2967744514184, 927.6938610258633, 928.401181238101, 929.0570071377557, 976.1214906584061, 981.9852702209473, 982.6118683120163, 982.7002764156929, 986.1223511075149, 972.5866506734609, 974.4202199691208, 975.0, 975.0006243600367, 975.7072878136566, 729.2488736601309, 731.9780406587811, 733.6808488307549, 734.6877577029794, 739.1093732052864, 15396.23018849053, 15584.298706558233, 15768.211589420484, 15810.920945395314, 15977.440789572309, 14904.254787260703, 15083.396664133421, 15286.706993950886, 15293.923530382277, 15333.23333833315, 11773.470193841298, 11805.763884722342, 12021.459034343476, 12037.337946412943, 12154.966827819646, 3785.6025117362556, 3883.5533913600016, 3967.1272320089533, 3998.8800335989968, 4094.897627559305, 67915.0, 91189.0, 93043.53478232566, 101527.49236253771, 102786.0, 11421.143414243965, 11502.858766468353, 11523.654290371302, 11751.177417580859, 11850.407479625985, 23212.18757343485, 23688.763112368655, 23950.0, 23951.922163502684, 23978.04087836502, 8228.83542329162, 8239.588020599065, 8320.542370169578, 8327.250547450758, 8444.408891377545, 4389.297712366006, 4477.238869392146, 4496.235639941217, 4647.930281045787, 4713.222318317507, 3677.2645470905927, 3730.216654502585, 3783.0164157319296, 3786.981065094657, 3976.840926362971, 739.5858319341186, 742.9628518574158, 743.8214828441135, 756.5725365168662, 757.9242075792376, 685.2017399729359, 705.7424040225384, 718.1346477494711, 734.6069852628818, 766.3677466090497, 10225.539850706737, 10322.174226061898, 10362.430066346273, 10696.732581685364, 10786.946065269623, 717.1465955512923, 735.2647352647352, 740.6852087862637, 748.5747907303266, 761.6039659377093, 5020.3724534433195, 5180.0, 5199.636025478256, 5202.167653175474, 5203.453637368098, 73379.63310183414, 84356.0, 84686.576567118, 87932.0, 91506.54246728723, 81342.59328703319, 81447.59276203699, 81485.0, 81811.0, 83339.16660833314, 71551.92672109818, 72484.63757681177, 73607.26392736111, 73691.99999999892, 73813.89279160817, 9934.304598678023, 10765.461726913467, 10995.395253261147, 11151.275167114112, 11296.887031129583, 46357.07285854332, 47181.528184719085, 47550.84931835055, 48377.0, 49166.0, 61758.0, 63391.0491342621, 64861.0, 65152.37119072061, 65930.67034664987, 13292.468301267842, 13377.464901403835, 13409.195448273134, 13412.463501459832, 13759.036867419185, 14794.556163315117, 14795.704085918005, 15244.923775381052, 15256.542303730906, 15655.921720391325, 10895.836562451412, 13571.38928748189, 14137.293135343398, 14152.221627810157, 14210.07634503754, 13016.414261358072, 13839.654008649462, 13905.304734763424, 14014.719705606034, 14152.929235353757, 13642.0, 13700.24648644334, 13912.567490234213, 13951.790723138958, 14341.211233382264, 10585.417802020655, 10911.454427278446, 11163.944180279046, 11362.0, 11618.360990145286, 10426.530806113591, 11126.888731112585, 11156.881234800929, 11465.254758440675, 11479.770404592029], "value": 7723.280370884057, "unit": "score"}], "name": "dromaeo_css", "value": 7450.811779319419, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 114.0, 113.0, 110.0, 115.0, 113.0, 112.0, 113.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 106.0, 109.0, 144.0, 107.0, 105.0, 108.0, 118.0, 128.0, 108.0], "value": 117.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 182.0, 184.0, 181.0, 179.0, 182.0, 182.0, 183.0, 182.0], "value": 182.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 58.0, 88.0, 61.0, 57.0, 57.0, 58.0, 72.0, 69.0], "value": 65.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 69.0, 85.0, 68.0, 67.0, 69.0, 79.0, 66.0, 69.0, 82.0], "value": 73.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 86.0, 83.0, 86.0, 84.0, 87.0, 83.0, 86.0, 83.0], "value": 84.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 83.0, 88.0, 84.0, 85.0, 85.0, 83.0, 85.0, 86.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 55.0, 57.0, 57.0, 54.0, 56.0, 56.0, 54.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 71.0, 73.0, 72.0, 69.0, 68.0, 69.0, 73.0, 69.0, 69.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 80.0, 98.0, 100.0, 82.0, 81.0, 83.0, 87.0, 88.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 143.0, 121.0, 140.0, 135.0, 148.0, 143.0, 134.0, 178.0, 133.0], "value": 140.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 161.0, 159.0, 161.0, 163.0, 157.0, 161.0, 163.0, 165.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 65.0, 64.0, 63.0, 64.0, 63.0, 63.0, 63.0, 63.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1392.1, "alertThreshold": 2.0}]} 05:51:45 INFO - Return code: 0 05:51:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:51:45 INFO - # TBPL SUCCESS # 05:51:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:51:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:51:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:51:45 INFO - 2017-03-22 05:51:45.663 screenresolution[1653:9704] starting screenresolution argv=screenresolution get 05:51:45 INFO - 2017-03-22 05:51:45.665 screenresolution[1653:9704] Display 0: 1600x1200x32@60 05:51:45 INFO - 2017-03-22 05:51:45.671 screenresolution[1654:9707] starting screenresolution argv=screenresolution list 05:51:45 INFO - Available Modes on Display 0 05:51:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:51:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:51:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:51:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:51:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:51:45 INFO - Intel Iris: 05:51:45 INFO - Chipset Model: Intel Iris 05:51:45 INFO - Type: GPU 05:51:45 INFO - Bus: Built-In 05:51:45 INFO - VRAM (Dynamic, Max): 1536 MB 05:51:45 INFO - Vendor: Intel (0x8086) 05:51:45 INFO - Device ID: 0x0a2e 05:51:45 INFO - Revision ID: 0x0009 05:51:45 INFO - Displays: 05:51:45 INFO - Display: 05:51:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:51:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:51:45 INFO - Display Serial Number: 1600x1200 60 05:51:45 INFO - Main Display: Yes 05:51:45 INFO - Mirror: Off 05:51:45 INFO - Online: Yes 05:51:45 INFO - Rotation: Supported 05:51:45 INFO - Return code: 0 05:51:45 INFO - Running post-action listener: _resource_record_post_action 05:51:45 INFO - [mozharness: 2017-03-22 12:51:45.905576Z] Finished run-tests step (success) 05:51:45 INFO - Running post-run listener: _resource_record_post_run 05:51:45 INFO - Total resource usage - Wall time: 1189s; CPU: 54.0%; Read bytes: 38085632; Write bytes: 423329280; Read time: 244; Write time: 1392 05:51:45 INFO - TinderboxPrint: CPU usage
53.7% 05:51:45 INFO - TinderboxPrint: I/O read bytes / time
38,085,632 / 244 05:51:45 INFO - TinderboxPrint: I/O write bytes / time
423,329,280 / 1,392 05:51:45 INFO - TinderboxPrint: CPU idle
2,201.4 (46.3%) 05:51:45 INFO - TinderboxPrint: CPU system
951.9 (20.0%) 05:51:45 INFO - TinderboxPrint: CPU user
1,604.4 (33.7%) 05:51:45 INFO - TinderboxPrint: Swap in / out
160,096,256 / 0 05:51:45 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 109988352; Write bytes: 106248192; Read time: 9860; Write time: 237 05:51:45 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 37159936; Write bytes: 296601088; Read time: 231; Write time: 1096 05:51:46 INFO - Running post-run listener: _upload_blobber_files 05:51:46 INFO - Blob upload gear active. 05:51:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:51:46 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 05:51:46 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'] 05:51:46 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 05:51:46 INFO - (blobuploader) - INFO - Open directory for files ... 05:51:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:51:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:51:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:48 INFO - (blobuploader) - INFO - Done attempting. 05:51:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:51:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:51:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:48 INFO - (blobuploader) - INFO - Done attempting. 05:51:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:51:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:51:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:50 INFO - (blobuploader) - INFO - Done attempting. 05:51:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:51:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:51:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:52 INFO - (blobuploader) - INFO - Done attempting. 05:51:52 INFO - (blobuploader) - INFO - Iteration through files over. 05:51:52 INFO - Return code: 0 05:51:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:51:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:51:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4740d9b9d34f473dfdd9945d5d65804954c0faf632feca4d7c75acb398734a197a6bf106de6f9be3f959687d47bda517106da839c027254020383a03bc0925ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5d1a869d20b7e61f23791f60b5cdf2033e0f5368e361302b24008383701410296f788ac0a1f77ffdc5e568e8dc853886e9fb12d8c8c4d93cd7a62bcadb94ce36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/81a978e45a1220904a0d69fe1373cf2da179dad867903cc0a49d35de89861aa9bb624a87987ad65b8dae465651ae1b1cd6bcf278453166e7b4ce93efc04f608c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d647bfda8bf1b12a83c7904f617aabbcb51e573d0bd5acfdfed2287b329c7d495581e18d4a9f31374b39f023a8f1cc2e759851dd16eb2f26d24cb809a27c187"} 05:51:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:51:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:51:52 INFO - Contents: 05:51:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4740d9b9d34f473dfdd9945d5d65804954c0faf632feca4d7c75acb398734a197a6bf106de6f9be3f959687d47bda517106da839c027254020383a03bc0925ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5d1a869d20b7e61f23791f60b5cdf2033e0f5368e361302b24008383701410296f788ac0a1f77ffdc5e568e8dc853886e9fb12d8c8c4d93cd7a62bcadb94ce36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/81a978e45a1220904a0d69fe1373cf2da179dad867903cc0a49d35de89861aa9bb624a87987ad65b8dae465651ae1b1cd6bcf278453166e7b4ce93efc04f608c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d647bfda8bf1b12a83c7904f617aabbcb51e573d0bd5acfdfed2287b329c7d495581e18d4a9f31374b39f023a8f1cc2e759851dd16eb2f26d24cb809a27c187"} 05:51:52 INFO - Running post-run listener: copy_logs_to_upload_dir 05:51:52 INFO - Copying logs to upload dir... 05:51:52 INFO - mkdir: /builds/slave/test/build/upload/logs 05:51:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.045630 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-03-22 05:51:52.469413) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 05:51:52.473270) ========= 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.H5kHGMDbtr/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.YEt39LeKTo/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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/4740d9b9d34f473dfdd9945d5d65804954c0faf632feca4d7c75acb398734a197a6bf106de6f9be3f959687d47bda517106da839c027254020383a03bc0925ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5d1a869d20b7e61f23791f60b5cdf2033e0f5368e361302b24008383701410296f788ac0a1f77ffdc5e568e8dc853886e9fb12d8c8c4d93cd7a62bcadb94ce36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/81a978e45a1220904a0d69fe1373cf2da179dad867903cc0a49d35de89861aa9bb624a87987ad65b8dae465651ae1b1cd6bcf278453166e7b4ce93efc04f608c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d647bfda8bf1b12a83c7904f617aabbcb51e573d0bd5acfdfed2287b329c7d495581e18d4a9f31374b39f023a8f1cc2e759851dd16eb2f26d24cb809a27c187"} build_url:https://queue.taskcluster.net/v1/task/Ado8egYdSrSP6BkrxWwfQA/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010843 build_url: 'https://queue.taskcluster.net/v1/task/Ado8egYdSrSP6BkrxWwfQA/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4740d9b9d34f473dfdd9945d5d65804954c0faf632feca4d7c75acb398734a197a6bf106de6f9be3f959687d47bda517106da839c027254020383a03bc0925ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5d1a869d20b7e61f23791f60b5cdf2033e0f5368e361302b24008383701410296f788ac0a1f77ffdc5e568e8dc853886e9fb12d8c8c4d93cd7a62bcadb94ce36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/81a978e45a1220904a0d69fe1373cf2da179dad867903cc0a49d35de89861aa9bb624a87987ad65b8dae465651ae1b1cd6bcf278453166e7b4ce93efc04f608c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d647bfda8bf1b12a83c7904f617aabbcb51e573d0bd5acfdfed2287b329c7d495581e18d4a9f31374b39f023a8f1cc2e759851dd16eb2f26d24cb809a27c187"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 05:51:52.507622) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 05:51:52.507970) ========= 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.H5kHGMDbtr/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.YEt39LeKTo/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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.005073 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 05:51:52.556701) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 05:51:52.557031) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 05:51:52.557343) ========= ========= Total master_lag: 0.18 =========