builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0330 starttime: 1475219675.55 results: success (0) buildid: 20160929232019 builduid: 8060021746d44b89993a86eb2b94b75f revision: af6e01b8574b2a844e86a4ed983b98c18305525f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 00:14:35.553594) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 00:14:35.554037) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 00:14:35.554327) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 00:14:35.578480) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 00:14:35.578764) ========= 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.bNftBeQssC/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.wzUQD9EyEN/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-30 00:14:35-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 173M=0s 2016-09-30 00:14:35 (173 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103745 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 00:14:35.704732) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 00:14:35.705070) ========= 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.bNftBeQssC/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.wzUQD9EyEN/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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.026676 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 00:14:35.753795) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-30 00:14:35.754161) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev af6e01b8574b2a844e86a4ed983b98c18305525f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev af6e01b8574b2a844e86a4ed983b98c18305525f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bNftBeQssC/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.wzUQD9EyEN/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-30 00:14:35,855 truncating revision to first 12 chars 2016-09-30 00:14:35,855 Setting DEBUG logging. 2016-09-30 00:14:35,855 attempt 1/10 2016-09-30 00:14:35,855 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/af6e01b8574b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-30 00:14:36,842 unpacking tar archive at: fx-team-af6e01b8574b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.261277 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-30 00:14:37.038388) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 00:14:37.038761) ========= script_repo_revision: af6e01b8574b2a844e86a4ed983b98c18305525f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 00:14:37.039154) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 00:14:37.039421) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 00:14:37.056947) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-09-30 00:14:37.057218) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bNftBeQssC/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.wzUQD9EyEN/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 00:14:37 INFO - MultiFileLogger online at 20160930 00:14:37 in /builds/slave/test 00:14:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 00:14:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:14:37 INFO - {'append_to_log': False, 00:14:37 INFO - 'base_work_dir': '/builds/slave/test', 00:14:37 INFO - 'blob_upload_branch': 'Fx-Team', 00:14:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:14:37 INFO - 'branch': 'Fx-Team', 00:14:37 INFO - 'buildbot_json_path': 'buildprops.json', 00:14:37 INFO - 'config_files': ('talos/mac_config.py',), 00:14:37 INFO - 'default_actions': ('clobber', 00:14:37 INFO - 'read-buildbot-config', 00:14:37 INFO - 'download-and-extract', 00:14:37 INFO - 'populate-webroot', 00:14:37 INFO - 'create-virtualenv', 00:14:37 INFO - 'install', 00:14:37 INFO - 'run-tests'), 00:14:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:14:37 INFO - 'download_minidump_stackwalk': True, 00:14:37 INFO - 'download_symbols': 'ondemand', 00:14:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:14:37 INFO - 'tooltool.py': '/tools/tooltool.py', 00:14:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:14:37 INFO - '/tools/misc-python/virtualenv.py')}, 00:14:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:14:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:14:37 INFO - 'installer_path': 'installer.exe', 00:14:37 INFO - 'log_level': 'info', 00:14:37 INFO - 'log_name': 'talos', 00:14:37 INFO - 'log_to_console': True, 00:14:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:14:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:14:37 INFO - 'opt_config_files': (), 00:14:37 INFO - 'pip_index': False, 00:14:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:14:37 INFO - 'cmd': ('bash', 00:14:37 INFO - '-c', 00:14:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:14:37 INFO - 'enabled': True, 00:14:37 INFO - 'halt_on_failure': False, 00:14:37 INFO - 'name': 'check_screen_resolution'},), 00:14:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:14:37 INFO - 'cmd': ('bash', 00:14:37 INFO - '-c', 00:14:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:14:37 INFO - 'enabled': True, 00:14:37 INFO - 'halt_on_failure': False, 00:14:37 INFO - 'name': 'check_screen_resolution'},), 00:14:37 INFO - 'run_cmd_checks_enabled': True, 00:14:37 INFO - 'sps_profile': False, 00:14:37 INFO - 'sps_profile_interval': 0, 00:14:37 INFO - 'suite': 'dromaeojs', 00:14:37 INFO - 'system_bits': '32', 00:14:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:14:37 INFO - 'title': 't-yosemite-r7-0330', 00:14:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:14:37 INFO - 'use_talos_json': True, 00:14:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:14:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:14:37 INFO - 'work_dir': 'build'} 00:14:37 INFO - [mozharness: 2016-09-30 07:14:37.290884Z] Running clobber step. 00:14:37 INFO - Running pre-action listener: _resource_record_pre_action 00:14:37 INFO - Running main action method: clobber 00:14:37 INFO - rmtree: /builds/slave/test/build 00:14:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:14:39 INFO - Running post-action listener: _resource_record_post_action 00:14:39 INFO - [mozharness: 2016-09-30 07:14:39.594582Z] Finished clobber step (success) 00:14:39 INFO - [mozharness: 2016-09-30 07:14:39.594738Z] Running read-buildbot-config step. 00:14:39 INFO - Running pre-action listener: _resource_record_pre_action 00:14:39 INFO - Running main action method: read_buildbot_config 00:14:39 INFO - Using buildbot properties: 00:14:39 INFO - { 00:14:39 INFO - "project": "", 00:14:39 INFO - "product": "firefox", 00:14:39 INFO - "script_repo_revision": "production", 00:14:39 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 00:14:39 INFO - "repository": "", 00:14:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 00:14:39 INFO - "buildid": "20160929232019", 00:14:39 INFO - "pgo_build": "False", 00:14:39 INFO - "basedir": "/builds/slave/test", 00:14:39 INFO - "buildnumber": 167, 00:14:39 INFO - "slavename": "t-yosemite-r7-0330", 00:14:39 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 00:14:39 INFO - "platform": "yosemite_r7", 00:14:39 INFO - "scheduler": "tests-fx-team-macosx64-talos", 00:14:39 INFO - "branch": "fx-team", 00:14:39 INFO - "repo_path": "integration/fx-team", 00:14:39 INFO - "revision": "af6e01b8574b2a844e86a4ed983b98c18305525f", 00:14:39 INFO - "stage_platform": "macosx64", 00:14:39 INFO - "builduid": "8060021746d44b89993a86eb2b94b75f", 00:14:39 INFO - "slavebuilddir": "test" 00:14:39 INFO - } 00:14:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/Sgxj9AGYRXeMR0GmZ0dW4Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 00:14:39 INFO - Running post-action listener: _resource_record_post_action 00:14:39 INFO - [mozharness: 2016-09-30 07:14:39.598029Z] Finished read-buildbot-config step (success) 00:14:39 INFO - [mozharness: 2016-09-30 07:14:39.598136Z] Running download-and-extract step. 00:14:39 INFO - Running pre-action listener: _resource_record_pre_action 00:14:39 INFO - Running main action method: download_and_extract 00:14:39 INFO - mkdir: /builds/slave/test/build/tests 00:14: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')]} 00:14:39 INFO - trying https://queue.taskcluster.net/v1/task/Sgxj9AGYRXeMR0GmZ0dW4Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 00:14:39 INFO - Downloading https://queue.taskcluster.net/v1/task/Sgxj9AGYRXeMR0GmZ0dW4Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 00:14:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sgxj9AGYRXeMR0GmZ0dW4Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 00:14:40 INFO - Downloaded 1199 bytes. 00:14:40 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 00:14:40 INFO - Using the following test package requirements: 00:14:40 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 00:14:40 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:14:40 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 00:14:40 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:14:40 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 00:14:40 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:14:40 INFO - u'jsshell-mac.zip'], 00:14:40 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:14:40 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 00:14:40 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 00:14:40 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:14:40 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 00:14:40 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:14:40 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 00:14:40 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:14:40 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 00:14:40 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:14:40 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 00:14:40 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 00:14:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Sgxj9AGYRXeMR0GmZ0dW4Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 00:14:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sgxj9AGYRXeMR0GmZ0dW4Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:14:40 INFO - Fetch https://queue.taskcluster.net/v1/task/Sgxj9AGYRXeMR0GmZ0dW4Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 00:14:41 INFO - Http code: 200 00:14:41 INFO - Content-Encoding: None 00:14:41 INFO - Content-Type: application/zip 00:14:41 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 00:14:41 INFO - x-amz-cf-id: mrzMoIFv0RdBJb_F7g5pd_lp9T92gmnnQp3RMZ14aCiOcOcTdXds0w== 00:14:41 INFO - x-amz-version-id: qOgDOoWUjEyDmmE5e8MW4J8JoTLyhX.6 00:14:41 INFO - x-cache: Hit from cloudfront 00:14:41 INFO - Expected file size: 16473315 00:14:41 INFO - Obtained file size: 16473315 00:14:48 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 00:14:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Sgxj9AGYRXeMR0GmZ0dW4Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 00:14:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sgxj9AGYRXeMR0GmZ0dW4Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:14:48 INFO - Fetch https://queue.taskcluster.net/v1/task/Sgxj9AGYRXeMR0GmZ0dW4Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 00:14:48 INFO - Http code: 200 00:14:48 INFO - Content-Encoding: None 00:14:48 INFO - Content-Type: application/zip 00:14:48 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 00:14:48 INFO - x-amz-cf-id: rtVKaw2nRkGQcXUMav--zcWyu8DinlsVyaeGiJlLlcn0mXLW79mcRQ== 00:14:48 INFO - x-amz-version-id: qOgDOoWUjEyDmmE5e8MW4J8JoTLyhX.6 00:14:48 INFO - x-cache: Hit from cloudfront 00:14:48 INFO - Expected file size: 16473315 00:14:48 INFO - Obtained file size: 16473315 00:14:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Sgxj9AGYRXeMR0GmZ0dW4Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 00:14:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sgxj9AGYRXeMR0GmZ0dW4Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 00:14:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Sgxj9AGYRXeMR0GmZ0dW4Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 00:14:55 INFO - Http code: 200 00:14:55 INFO - Content-Encoding: None 00:14:55 INFO - Content-Type: application/zip 00:14:55 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 00:14:55 INFO - x-amz-cf-id: XMtDILQXgZfY8VN5J6yfbP2R1u7swUl3LmeH9NdOfWvWxsM3shYDjQ== 00:14:55 INFO - x-amz-version-id: KenfEqyLqmrLmfymOSxJKWXXreyeEEvw 00:14:55 INFO - x-cache: Miss from cloudfront 00:14:56 INFO - Expected file size: 14414067 00:14:56 INFO - Obtained file size: 14414067 00:14:57 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')]} 00:14:57 INFO - trying https://queue.taskcluster.net/v1/task/Sgxj9AGYRXeMR0GmZ0dW4Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 00:14:57 INFO - Downloading https://queue.taskcluster.net/v1/task/Sgxj9AGYRXeMR0GmZ0dW4Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 00:14:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sgxj9AGYRXeMR0GmZ0dW4Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 00:15:00 INFO - Downloaded 111806145 bytes. 00:15:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Sgxj9AGYRXeMR0GmZ0dW4Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 00:15:00 INFO - mkdir: /builds/slave/test/properties 00:15:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:15:00 INFO - Writing to file /builds/slave/test/properties/build_url 00:15:00 INFO - Contents: 00:15:00 INFO - build_url:https://queue.taskcluster.net/v1/task/Sgxj9AGYRXeMR0GmZ0dW4Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 00:15:01 INFO - Running post-action listener: _resource_record_post_action 00:15:01 INFO - Running post-action listener: set_extra_try_arguments 00:15:01 INFO - [mozharness: 2016-09-30 07:15:01.468270Z] Finished download-and-extract step (success) 00:15:01 INFO - [mozharness: 2016-09-30 07:15:01.468428Z] Running populate-webroot step. 00:15:01 INFO - Running pre-action listener: _resource_record_pre_action 00:15:01 INFO - Running main action method: populate_webroot 00:15:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:15:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:15:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:15:01 INFO - '--tppagecycles', 00:15:01 INFO - '7'], 00:15:01 INFO - 'tests': ['tsvgm']}}, 00:15:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:15:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:15:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:15:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:15:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:15:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:15:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:15:01 INFO - 'talos_options': ['--disable-e10s'], 00:15:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:15:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:15:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:15:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:15:01 INFO - 'talos_options': ['--disable-e10s'], 00:15:01 INFO - 'tests': ['damp', 'tps']}, 00:15:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:15:01 INFO - 'tests': ['damp', 'tps']}, 00:15:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:15:01 INFO - 'tests': ['dromaeo_dom']}, 00:15:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:15:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:15:01 INFO - 'tests': ['basic_compositor_video']}, 00:15:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:15:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:15:01 INFO - 'tests': ['a11yr', 00:15:01 INFO - 'ts_paint', 00:15:01 INFO - 'tpaint', 00:15:01 INFO - 'sessionrestore', 00:15:01 INFO - 'sessionrestore_no_auto_restore', 00:15:01 INFO - 'tabpaint']}, 00:15:01 INFO - 'other-e10s': {'tests': ['a11yr', 00:15:01 INFO - 'ts_paint', 00:15:01 INFO - 'tpaint', 00:15:01 INFO - 'sessionrestore', 00:15:01 INFO - 'sessionrestore_no_auto_restore', 00:15:01 INFO - 'tabpaint']}, 00:15:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:15:01 INFO - 'ts_paint', 00:15:01 INFO - 'tpaint', 00:15:01 INFO - 'sessionrestore', 00:15:01 INFO - 'sessionrestore_no_auto_restore', 00:15:01 INFO - 'tabpaint']}, 00:15:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:15:01 INFO - 'ts_paint', 00:15:01 INFO - 'tpaint', 00:15:01 INFO - 'sessionrestore', 00:15:01 INFO - 'sessionrestore_no_auto_restore', 00:15:01 INFO - 'tabpaint']}, 00:15:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:15:01 INFO - 'tests': ['a11yr', 00:15:01 INFO - 'ts_paint', 00:15:01 INFO - 'tpaint', 00:15:01 INFO - 'sessionrestore', 00:15:01 INFO - 'sessionrestore_no_auto_restore', 00:15:01 INFO - 'tabpaint']}, 00:15:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:15:01 INFO - 'tests': ['a11yr', 00:15:01 INFO - 'ts_paint', 00:15:01 INFO - 'tpaint', 00:15:01 INFO - 'sessionrestore', 00:15:01 INFO - 'sessionrestore_no_auto_restore', 00:15:01 INFO - 'tabpaint']}, 00:15:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:15:01 INFO - 'tests': ['tsvgx', 00:15:01 INFO - 'tsvgr_opacity', 00:15:01 INFO - 'tart', 00:15:01 INFO - 'tscrollx', 00:15:01 INFO - 'cart']}, 00:15:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:15:01 INFO - 'tsvgr_opacity', 00:15:01 INFO - 'tart', 00:15:01 INFO - 'tscrollx', 00:15:01 INFO - 'cart']}, 00:15:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:15:01 INFO - 'talos_options': ['--disable-e10s'], 00:15:01 INFO - 'tests': ['tp5o']}, 00:15:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:15:01 INFO - 'tests': ['tp5o']}, 00:15:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:15:01 INFO - 'talos_options': ['--disable-e10s', 00:15:01 INFO - '--xperf_path', 00:15:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:15:01 INFO - 'tests': ['tp5n']}, 00:15:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:15:01 INFO - 'talos_options': ['--xperf_path', 00:15:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:15:01 INFO - 'tests': ['tp5n']}}, 00:15:01 INFO - 'talos.zip': {'path': '', 00:15:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:15:01 INFO - Running post-action listener: _resource_record_post_action 00:15:01 INFO - [mozharness: 2016-09-30 07:15:01.487510Z] Finished populate-webroot step (success) 00:15:01 INFO - [mozharness: 2016-09-30 07:15:01.487642Z] Running create-virtualenv step. 00:15:01 INFO - Running pre-action listener: _resource_record_pre_action 00:15:01 INFO - Running main action method: create_virtualenv 00:15:01 INFO - Creating virtualenv /builds/slave/test/build/venv 00:15:01 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 00:15:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:15:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:15:01 INFO - Using real prefix '/tools/python27' 00:15:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:15:02 INFO - Installing distribute.............................................................................................................................................................................................done. 00:15:05 INFO - Installing pip.................done. 00:15:05 INFO - Return code: 0 00:15:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:15:05 INFO - Reading from file tmpfile_stdout 00:15:05 INFO - Output received: 00:15:05 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) 00:15:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:15:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108db9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d2f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9e1ca6160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bcdd30>, '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 0x1089f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bc5b20>, '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.bNftBeQssC/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.wzUQD9EyEN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 00:15:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:15:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bNftBeQssC/Render', 00:15:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:15:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:15:05 INFO - 'HOME': '/Users/cltbld', 00:15:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:15:05 INFO - 'LOGNAME': 'cltbld', 00:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:05 INFO - 'MOZ_NO_REMOTE': '1', 00:15:05 INFO - 'NO_EM_RESTART': '1', 00:15:05 INFO - 'PAGER': '/bin/cat', 00:15:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:05 INFO - 'PWD': '/builds/slave/test', 00:15:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:15:05 INFO - 'SHELL': '/bin/bash', 00:15:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzUQD9EyEN/Listeners', 00:15:05 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 00:15:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:15:05 INFO - 'USER': 'cltbld', 00:15:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:15:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:05 INFO - 'XPC_FLAGS': '0x0', 00:15:05 INFO - 'XPC_SERVICE_NAME': '0', 00:15:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:05 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 00:15:05 INFO - Cleaning up... 00:15:05 INFO - Return code: 0 00:15:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:15:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108db9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d2f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9e1ca6160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bcdd30>, '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 0x1089f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bc5b20>, '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.bNftBeQssC/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.wzUQD9EyEN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 00:15:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:15:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bNftBeQssC/Render', 00:15:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:15:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:15:05 INFO - 'HOME': '/Users/cltbld', 00:15:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:15:05 INFO - 'LOGNAME': 'cltbld', 00:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:05 INFO - 'MOZ_NO_REMOTE': '1', 00:15:05 INFO - 'NO_EM_RESTART': '1', 00:15:05 INFO - 'PAGER': '/bin/cat', 00:15:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:05 INFO - 'PWD': '/builds/slave/test', 00:15:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:15:05 INFO - 'SHELL': '/bin/bash', 00:15:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzUQD9EyEN/Listeners', 00:15:05 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 00:15:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:15:05 INFO - 'USER': 'cltbld', 00:15:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:15:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:05 INFO - 'XPC_FLAGS': '0x0', 00:15:05 INFO - 'XPC_SERVICE_NAME': '0', 00:15:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:05 INFO - Downloading/unpacking psutil>=3.1.1 00:15:05 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 00:15:05 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 00:15:05 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 00:15:05 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 00:15:05 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 00:15:05 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 00:15:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:15:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:15:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:15:09 INFO - Installing collected packages: psutil 00:15:09 INFO - Running setup.py install for psutil 00:15:09 INFO - building 'psutil._psutil_osx' extension 00:15:09 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 00:15:10 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 00:15:10 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 00:15:10 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 00:15:10 INFO - building 'psutil._psutil_posix' extension 00:15:10 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 00:15:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:15:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:15:10 INFO - ^ 00:15:10 INFO - 1 warning generated. 00:15:10 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 00:15:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:15:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:15:10 INFO - Successfully installed psutil 00:15:10 INFO - Cleaning up... 00:15:10 INFO - Return code: 0 00:15:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:15: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')]} 00:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:15: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')]} 00:15:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:15:10 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 0x108db9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d2f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9e1ca6160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bcdd30>, '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 0x1089f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bc5b20>, '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.bNftBeQssC/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.wzUQD9EyEN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 00:15:10 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 00:15:10 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 00:15:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bNftBeQssC/Render', 00:15:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:15:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:15:10 INFO - 'HOME': '/Users/cltbld', 00:15:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:15:10 INFO - 'LOGNAME': 'cltbld', 00:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:10 INFO - 'MOZ_NO_REMOTE': '1', 00:15:10 INFO - 'NO_EM_RESTART': '1', 00:15:10 INFO - 'PAGER': '/bin/cat', 00:15:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:10 INFO - 'PWD': '/builds/slave/test', 00:15:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:15:10 INFO - 'SHELL': '/bin/bash', 00:15:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzUQD9EyEN/Listeners', 00:15:10 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 00:15:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:15:10 INFO - 'USER': 'cltbld', 00:15:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:15:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:10 INFO - 'XPC_FLAGS': '0x0', 00:15:10 INFO - 'XPC_SERVICE_NAME': '0', 00:15:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:15:10 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 00:15:10 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 00:15:10 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 00:15:10 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 00:15:10 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 00:15:10 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 00:15:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:15:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:15:13 INFO - Installing collected packages: mozsystemmonitor 00:15:13 INFO - Running setup.py install for mozsystemmonitor 00:15:13 INFO - Successfully installed mozsystemmonitor 00:15:13 INFO - Cleaning up... 00:15:13 INFO - Return code: 0 00:15:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:15:13 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')]} 00:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:15:13 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')]} 00:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:15:13 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 0x108db9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d2f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9e1ca6160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bcdd30>, '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 0x1089f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bc5b20>, '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.bNftBeQssC/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.wzUQD9EyEN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 00:15:13 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 00:15:13 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 00:15:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bNftBeQssC/Render', 00:15:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:15:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:15:13 INFO - 'HOME': '/Users/cltbld', 00:15:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:15:13 INFO - 'LOGNAME': 'cltbld', 00:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:13 INFO - 'MOZ_NO_REMOTE': '1', 00:15:13 INFO - 'NO_EM_RESTART': '1', 00:15:13 INFO - 'PAGER': '/bin/cat', 00:15:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:13 INFO - 'PWD': '/builds/slave/test', 00:15:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:15:13 INFO - 'SHELL': '/bin/bash', 00:15:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzUQD9EyEN/Listeners', 00:15:13 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 00:15:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:15:13 INFO - 'USER': 'cltbld', 00:15:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:15:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:13 INFO - 'XPC_FLAGS': '0x0', 00:15:13 INFO - 'XPC_SERVICE_NAME': '0', 00:15:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:13 INFO - Downloading/unpacking jsonschema==2.5.1 00:15:13 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 00:15:13 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 00:15:13 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 00:15:13 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 00:15:13 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 00:15:13 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 00:15:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:15:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:15:16 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 00:15:16 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 00:15:16 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 00:15:16 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 00:15:16 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 00:15:16 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 00:15:16 INFO - Downloading functools32-3.2.3-2.tar.gz 00:15:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:15:16 INFO - warning: no files found matching '*.txt' 00:15:16 INFO - no previously-included directories found matching 'build' 00:15:16 INFO - no previously-included directories found matching 'dist' 00:15:16 INFO - no previously-included directories found matching '.git*' 00:15:16 INFO - Installing collected packages: jsonschema, functools32 00:15:16 INFO - Running setup.py install for functools32 00:15:17 INFO - warning: no files found matching '*.txt' 00:15:17 INFO - no previously-included directories found matching 'build' 00:15:17 INFO - no previously-included directories found matching 'dist' 00:15:17 INFO - no previously-included directories found matching '.git*' 00:15:17 INFO - Successfully installed jsonschema functools32 00:15:17 INFO - Cleaning up... 00:15:17 INFO - Return code: 0 00:15:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:15:17 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')]} 00:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:15:17 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')]} 00:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:15:17 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 0x108db9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d2f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9e1ca6160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bcdd30>, '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 0x1089f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bc5b20>, '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.bNftBeQssC/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.wzUQD9EyEN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 00:15:17 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 00:15:17 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 00:15:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bNftBeQssC/Render', 00:15:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:15:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:15:17 INFO - 'HOME': '/Users/cltbld', 00:15:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:15:17 INFO - 'LOGNAME': 'cltbld', 00:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:17 INFO - 'MOZ_NO_REMOTE': '1', 00:15:17 INFO - 'NO_EM_RESTART': '1', 00:15:17 INFO - 'PAGER': '/bin/cat', 00:15:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:17 INFO - 'PWD': '/builds/slave/test', 00:15:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:15:17 INFO - 'SHELL': '/bin/bash', 00:15:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzUQD9EyEN/Listeners', 00:15:17 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 00:15:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:15:17 INFO - 'USER': 'cltbld', 00:15:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:15:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:17 INFO - 'XPC_FLAGS': '0x0', 00:15:17 INFO - 'XPC_SERVICE_NAME': '0', 00:15:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:15:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:15:17 INFO - Cleaning up... 00:15:17 INFO - Return code: 0 00:15:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:15:17 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')]} 00:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:15:17 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')]} 00:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:15:17 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 0x108db9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d2f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9e1ca6160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bcdd30>, '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 0x1089f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bc5b20>, '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.bNftBeQssC/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.wzUQD9EyEN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 00:15:17 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 00:15:17 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 00:15:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bNftBeQssC/Render', 00:15:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:15:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:15:17 INFO - 'HOME': '/Users/cltbld', 00:15:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:15:17 INFO - 'LOGNAME': 'cltbld', 00:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:17 INFO - 'MOZ_NO_REMOTE': '1', 00:15:17 INFO - 'NO_EM_RESTART': '1', 00:15:17 INFO - 'PAGER': '/bin/cat', 00:15:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:17 INFO - 'PWD': '/builds/slave/test', 00:15:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:15:17 INFO - 'SHELL': '/bin/bash', 00:15:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzUQD9EyEN/Listeners', 00:15:17 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 00:15:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:15:17 INFO - 'USER': 'cltbld', 00:15:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:15:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:17 INFO - 'XPC_FLAGS': '0x0', 00:15:17 INFO - 'XPC_SERVICE_NAME': '0', 00:15:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:15:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:17 INFO - Downloading/unpacking blobuploader==1.2.4 00:15:17 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 00:15:17 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 00:15:17 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 00:15:17 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 00:15:17 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 00:15:17 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 00:15:20 INFO - Downloading blobuploader-1.2.4.tar.gz 00:15:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:15:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:15:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:15:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:15:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:15:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:15:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:15:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:15:21 INFO - Downloading docopt-0.6.1.tar.gz 00:15:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:15:21 INFO - Installing collected packages: blobuploader, requests, docopt 00:15:21 INFO - Running setup.py install for blobuploader 00:15:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:15:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:15:21 INFO - Running setup.py install for requests 00:15:22 INFO - Running setup.py install for docopt 00:15:22 INFO - Successfully installed blobuploader requests docopt 00:15:22 INFO - Cleaning up... 00:15:22 INFO - Return code: 0 00:15:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:15:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:15:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:15:22 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 0x108db9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d2f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9e1ca6160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bcdd30>, '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 0x1089f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bc5b20>, '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.bNftBeQssC/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.wzUQD9EyEN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 00:15:22 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 00:15:22 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 00:15:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bNftBeQssC/Render', 00:15:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:15:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:15:22 INFO - 'HOME': '/Users/cltbld', 00:15:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:15:22 INFO - 'LOGNAME': 'cltbld', 00:15:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:22 INFO - 'MOZ_NO_REMOTE': '1', 00:15:22 INFO - 'NO_EM_RESTART': '1', 00:15:22 INFO - 'PAGER': '/bin/cat', 00:15:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:15:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:22 INFO - 'PWD': '/builds/slave/test', 00:15:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:15:22 INFO - 'SHELL': '/bin/bash', 00:15:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzUQD9EyEN/Listeners', 00:15:22 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 00:15:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:15:22 INFO - 'USER': 'cltbld', 00:15:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:15:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:15:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:22 INFO - 'XPC_FLAGS': '0x0', 00:15:22 INFO - 'XPC_SERVICE_NAME': '0', 00:15:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:15:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:15:22 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-OH8do2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:15:22 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-iGQLW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:15:22 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-MEfPtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:15:22 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-ZAzPjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:15:23 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-5RnKlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:15:23 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-bYsyep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:15:23 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-n7a_L_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:15:23 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-9S5VNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:15:23 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-04U3cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:15:23 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-HVCSAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:15:23 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-ADhmqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:15:23 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-_XRCAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:15:23 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-ria0Lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:15:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:15:23 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-rFeAdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:15:24 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-3CCDJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:15:24 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-G8tppY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:15:24 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-iTtoQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:15:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:15:24 INFO - Running setup.py install for manifestparser 00:15:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:15:24 INFO - Running setup.py install for mozcrash 00:15:24 INFO - Running setup.py install for mozdebug 00:15:24 INFO - Running setup.py install for mozdevice 00:15:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:15:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:15:24 INFO - Running setup.py install for mozfile 00:15:25 INFO - Running setup.py install for mozhttpd 00:15:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:15:25 INFO - Running setup.py install for mozinfo 00:15:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:15:25 INFO - Running setup.py install for mozInstall 00:15:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:15:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:15:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:15:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:15:25 INFO - Running setup.py install for mozleak 00:15:25 INFO - Running setup.py install for mozlog 00:15:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:15:25 INFO - Running setup.py install for moznetwork 00:15:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:15:25 INFO - Running setup.py install for mozprocess 00:15:26 INFO - Running setup.py install for mozprofile 00:15:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:15:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:15:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:15:26 INFO - Running setup.py install for mozrunner 00:15:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:15:26 INFO - Running setup.py install for mozscreenshot 00:15:26 INFO - Running setup.py install for moztest 00:15:26 INFO - Running setup.py install for mozversion 00:15:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:15:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:15:26 INFO - Cleaning up... 00:15:26 INFO - Return code: 0 00:15:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:15:26 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 0x108db9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d2f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9e1ca6160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bcdd30>, '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 0x1089f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bc5b20>, '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.bNftBeQssC/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.wzUQD9EyEN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 00:15:26 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 00:15:26 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 00:15:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bNftBeQssC/Render', 00:15:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:15:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:15:26 INFO - 'HOME': '/Users/cltbld', 00:15:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:15:26 INFO - 'LOGNAME': 'cltbld', 00:15:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:26 INFO - 'MOZ_NO_REMOTE': '1', 00:15:26 INFO - 'NO_EM_RESTART': '1', 00:15:26 INFO - 'PAGER': '/bin/cat', 00:15:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:15:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:26 INFO - 'PWD': '/builds/slave/test', 00:15:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:15:26 INFO - 'SHELL': '/bin/bash', 00:15:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzUQD9EyEN/Listeners', 00:15:26 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 00:15:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:15:26 INFO - 'USER': 'cltbld', 00:15:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:15:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:15:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:26 INFO - 'XPC_FLAGS': '0x0', 00:15:26 INFO - 'XPC_SERVICE_NAME': '0', 00:15:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:15:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:15:27 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-UmMYDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:15:27 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)) 00:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:15:27 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-NdcHm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:15:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:15:27 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-rGfWRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:15:27 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)) 00:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:15:27 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-QqgpYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:15:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:15:27 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-QEOBLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:15:27 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)) 00:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:15:27 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-Ltvlu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:15:27 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)) 00:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:15:27 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-D3AGKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:15:27 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)) 00:15:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:15:27 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-KiLupQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:15:28 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)) 00:15:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:15:28 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-7xOZbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:15:28 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)) 00:15:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:15:28 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-H6RbHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:15:28 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)) 00:15:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:15:28 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-MnOqUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:15:28 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)) 00:15:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:15:28 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-FCMnlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:15:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:15:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:15:28 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-3WTwDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:15:28 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)) 00:15:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:15:28 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-IOzxaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:15:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:15:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:15:28 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-miVS_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:15:28 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)) 00:15:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:15:28 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-rQtMDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:15:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 00:15:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:15:28 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-F28Bmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:15:29 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)) 00:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:15:29 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)) 00:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:15:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:15:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:15:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:15:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:15:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:15:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:15:31 INFO - Downloading blessings-1.6.tar.gz 00:15:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:15:31 INFO - Installing collected packages: blessings 00:15:31 INFO - Running setup.py install for blessings 00:15:31 INFO - Successfully installed blessings 00:15:31 INFO - Cleaning up... 00:15:31 INFO - Return code: 0 00:15:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:15:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:15:32 INFO - Reading from file tmpfile_stdout 00:15:32 INFO - Current package versions: 00:15:32 INFO - blessings == 1.6 00:15:32 INFO - blobuploader == 1.2.4 00:15:32 INFO - docopt == 0.6.1 00:15:32 INFO - functools32 == 3.2.3-2 00:15:32 INFO - jsonschema == 2.5.1 00:15:32 INFO - manifestparser == 1.1 00:15:32 INFO - mozInstall == 1.12 00:15:32 INFO - mozcrash == 0.17 00:15:32 INFO - mozdebug == 0.1 00:15:32 INFO - mozdevice == 0.48 00:15:32 INFO - mozfile == 1.2 00:15:32 INFO - mozhttpd == 0.7 00:15:32 INFO - mozinfo == 0.9 00:15:32 INFO - mozleak == 0.1 00:15:32 INFO - mozlog == 3.4 00:15:32 INFO - moznetwork == 0.27 00:15:32 INFO - mozprocess == 0.23 00:15:32 INFO - mozprofile == 0.28 00:15:32 INFO - mozrunner == 6.12 00:15:32 INFO - mozscreenshot == 0.1 00:15:32 INFO - mozsystemmonitor == 0.3 00:15:32 INFO - moztest == 0.7 00:15:32 INFO - mozversion == 1.4 00:15:32 INFO - psutil == 3.1.1 00:15:32 INFO - requests == 1.2.3 00:15:32 INFO - wsgiref == 0.1.2 00:15:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:15: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')]} 00:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:15: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')]} 00:15:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:15:33 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 0x108db9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d2f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9e1ca6160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bcdd30>, '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 0x1089f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bc5b20>, '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.bNftBeQssC/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.wzUQD9EyEN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 00:15:33 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 00:15:33 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 00:15:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bNftBeQssC/Render', 00:15:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:15:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:15:33 INFO - 'HOME': '/Users/cltbld', 00:15:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:15:33 INFO - 'LOGNAME': 'cltbld', 00:15:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:33 INFO - 'MOZ_NO_REMOTE': '1', 00:15:33 INFO - 'NO_EM_RESTART': '1', 00:15:33 INFO - 'PAGER': '/bin/cat', 00:15:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:15:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:33 INFO - 'PWD': '/builds/slave/test', 00:15:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:15:33 INFO - 'SHELL': '/bin/bash', 00:15:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzUQD9EyEN/Listeners', 00:15:33 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 00:15:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:15:33 INFO - 'USER': 'cltbld', 00:15:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:15:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:15:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:33 INFO - 'XPC_FLAGS': '0x0', 00:15:33 INFO - 'XPC_SERVICE_NAME': '0', 00:15:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:15:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:33 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)) 00:15:33 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)) 00:15:33 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)) 00:15:33 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)) 00:15:33 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)) 00:15:33 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)) 00:15:33 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)) 00:15:33 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)) 00:15:33 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)) 00:15:33 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)) 00:15:33 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)) 00:15:33 INFO - Cleaning up... 00:15:33 INFO - Return code: 0 00:15:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:15:33 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')]} 00:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:15:33 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')]} 00:15:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:15:34 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 0x108db9490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d2f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9e1ca6160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bcdd30>, '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 0x1089f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bc5b20>, '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.bNftBeQssC/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.wzUQD9EyEN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 00:15:34 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 00:15:34 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 00:15:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bNftBeQssC/Render', 00:15:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:15:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:15:34 INFO - 'HOME': '/Users/cltbld', 00:15:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:15:34 INFO - 'LOGNAME': 'cltbld', 00:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:34 INFO - 'MOZ_NO_REMOTE': '1', 00:15:34 INFO - 'NO_EM_RESTART': '1', 00:15:34 INFO - 'PAGER': '/bin/cat', 00:15:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:34 INFO - 'PWD': '/builds/slave/test', 00:15:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:15:34 INFO - 'SHELL': '/bin/bash', 00:15:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzUQD9EyEN/Listeners', 00:15:34 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 00:15:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:15:34 INFO - 'USER': 'cltbld', 00:15:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:15:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:34 INFO - 'XPC_FLAGS': '0x0', 00:15:34 INFO - 'XPC_SERVICE_NAME': '0', 00:15:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:15:34 INFO - Cleaning up... 00:15:34 INFO - Return code: 0 00:15:34 INFO - Running post-action listener: _resource_record_post_action 00:15:34 INFO - Running post-action listener: _start_resource_monitoring 00:15:34 INFO - Starting resource monitoring. 00:15:34 INFO - [mozharness: 2016-09-30 07:15:34.362473Z] Finished create-virtualenv step (success) 00:15:34 INFO - [mozharness: 2016-09-30 07:15:34.363524Z] Running install step. 00:15:34 INFO - Running pre-action listener: _resource_record_pre_action 00:15:34 INFO - Running main action method: install 00:15:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:15:34 INFO - Reading from file tmpfile_stdout 00:15:34 INFO - Detecting whether we're running mozinstall >=1.0... 00:15:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:15:34 INFO - Reading from file tmpfile_stdout 00:15:34 INFO - Output received: 00:15:34 INFO - Usage: mozinstall [options] installer 00:15:34 INFO - Options: 00:15:34 INFO - -h, --help show this help message and exit 00:15:34 INFO - -d DEST, --destination=DEST 00:15:34 INFO - Directory to install application into. [default: 00:15:34 INFO - "/builds/slave/test"] 00:15:34 INFO - --app=APP Application being installed. [default: firefox] 00:15:34 INFO - mkdir: /builds/slave/test/build/application 00:15:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 00:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 00:16:09 INFO - Reading from file tmpfile_stdout 00:16:09 INFO - Output received: 00:16:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 00:16:09 INFO - Running post-action listener: _resource_record_post_action 00:16:09 INFO - [mozharness: 2016-09-30 07:16:09.111657Z] Finished install step (success) 00:16:09 INFO - [mozharness: 2016-09-30 07:16:09.111817Z] Running run-tests step. 00:16:09 INFO - Running pre-action listener: _resource_record_pre_action 00:16:09 INFO - Running main action method: run_tests 00:16:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:16:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:16:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:16:09 INFO - 2016-09-30 00:16:09.127 screenresolution[1659:8793] starting screenresolution argv=screenresolution get 00:16:09 INFO - 2016-09-30 00:16:09.129 screenresolution[1659:8793] Display 0: 1600x1200x32@60 00:16:09 INFO - 2016-09-30 00:16:09.136 screenresolution[1660:8796] starting screenresolution argv=screenresolution list 00:16:09 INFO - Available Modes on Display 0 00:16:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:16:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:16:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:16:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:16:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:16:09 INFO - Intel Iris: 00:16:09 INFO - Chipset Model: Intel Iris 00:16:09 INFO - Type: GPU 00:16:09 INFO - Bus: Built-In 00:16:09 INFO - VRAM (Dynamic, Max): 1536 MB 00:16:09 INFO - Vendor: Intel (0x8086) 00:16:09 INFO - Device ID: 0x0a2e 00:16:09 INFO - Revision ID: 0x0009 00:16:09 INFO - Displays: 00:16:09 INFO - Display: 00:16:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:16:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:16:09 INFO - Display Serial Number: 1600x1200 60 00:16:09 INFO - Main Display: Yes 00:16:09 INFO - Mirror: Off 00:16:09 INFO - Online: Yes 00:16:09 INFO - Rotation: Supported 00:16:09 INFO - Return code: 0 00:16:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:16:09 INFO - Python 2.7.3 00:16:09 INFO - Return code: 0 00:16:09 INFO - grabbing minidump binary from tooltool 00:16:09 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')]} 00:16:09 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 0x108bcdd30>, '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 0x1089f3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bc5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:16:09 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 00:16:09 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 00:16:09 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 00:16:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:16:09 INFO - Return code: 0 00:16:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:16:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:16:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:16:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:16:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:16:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sgxj9AGYRXeMR0GmZ0dW4Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0330', '--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 00:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Sgxj9AGYRXeMR0GmZ0dW4Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0330 --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 00:16:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bNftBeQssC/Render', 00:16:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:16:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:16:09 INFO - 'HOME': '/Users/cltbld', 00:16:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:16:09 INFO - 'LOGNAME': 'cltbld', 00:16:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:16:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:16:09 INFO - 'MOZ_NO_REMOTE': '1', 00:16:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:16:09 INFO - 'NO_EM_RESTART': '1', 00:16:09 INFO - 'PAGER': '/bin/cat', 00:16:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:16:09 INFO - 'PWD': '/builds/slave/test', 00:16:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:16:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:16:09 INFO - 'SHELL': '/bin/bash', 00:16:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzUQD9EyEN/Listeners', 00:16:09 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 00:16:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:16:09 INFO - 'USER': 'cltbld', 00:16:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:16:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:16:09 INFO - 'XPC_FLAGS': '0x0', 00:16:09 INFO - 'XPC_SERVICE_NAME': '0', 00:16:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:16:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sgxj9AGYRXeMR0GmZ0dW4Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0330', '--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 00:16:09 INFO - mozversion application_buildid: 20160929232019 00:16:09 INFO - mozversion application_changeset: af6e01b8574b2a844e86a4ed983b98c18305525f 00:16:09 INFO - mozversion application_display_name: Nightly 00:16:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:16:09 INFO - mozversion application_name: Firefox 00:16:09 INFO - mozversion application_remotingname: firefox 00:16:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:16:09 INFO - mozversion application_vendor: Mozilla 00:16:09 INFO - mozversion application_version: 52.0a1 00:16:09 INFO - mozversion platform_buildid: 20160929232019 00:16:09 INFO - mozversion platform_changeset: af6e01b8574b2a844e86a4ed983b98c18305525f 00:16:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:16:09 INFO - mozversion platform_version: 52.0a1 00:16:09 INFO - using testdate: 1475219769 00:16:09 INFO - actual date: 1475219769 00:16:09 INFO - starting webserver on 'localhost:49267' 00:16:09 INFO - SUITE-START | Running 2 tests 00:16:09 INFO - TEST-START | dromaeo_css 00:16:09 INFO - operating with platform_type : mac_ 00:16:09 INFO - Initialising browser for dromaeo_css test... 00:16:09 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/tmpy7LUT2/profile http://localhost:49267/getInfo.html) 00:16:12 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 00:16:12 INFO - PROCESS | 1670 | colorDepth:24 00:16:12 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 00:16:12 INFO - PROCESS | 1670 | __metrics 00:16:12 INFO - PROCESS | 1670 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:16:12 INFO - PROCESS | 1670 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:16:13 INFO - TEST-INFO | 1670: exit 0 00:16:13 INFO - Browser initialized. 00:16:13 INFO - Running cycle 1/1 for dromaeo_css test... 00:16:13 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/tmpy7LUT2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:16:25 INFO - PROCESS | 1672 | RSS: Main: 235859968 00:16:25 INFO - PROCESS | 1672 | 00:17:16 INFO - PROCESS | 1672 | 1475219836181 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 00:19:27 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 00:19:30 INFO - PROCESS | 1672 | RSS: Main: 463007744 00:19:30 INFO - PROCESS | 1672 | 00:22:33 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 00:22:34 INFO - PROCESS | 1672 | RSS: Main: 371666944 00:22:34 INFO - PROCESS | 1672 | 00:25:36 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 00:25:36 INFO - PROCESS | 1672 | RSS: Main: 342671360 00:25:36 INFO - PROCESS | 1672 | 00:28:39 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 00:28:39 INFO - PROCESS | 1672 | RSS: Main: 342372352 00:28:39 INFO - PROCESS | 1672 | 00:31:43 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 00:31:43 INFO - PROCESS | 1672 | RSS: Main: 334647296 00:31:43 INFO - PROCESS | 1672 | 00:34:47 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 00:34:47 INFO - PROCESS | 1672 | RSS: Main: 418938880 00:34:47 INFO - PROCESS | 1672 | 00:34:47 INFO - PROCESS | 1672 | __start_tp_report 00:34:47 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 00:34:47 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 00:34:47 INFO - PROCESS | 1672 | |i|pagename|runs| 00:34:47 INFO - PROCESS | 1672 | |0;dojo.html;3306.735461163107;3306.917327066824;3310.2882880180755;3348.64839191885;3374.730021598271;5540.196671482632;5634.549236061111;5655.971720141399;5661.065924122515;5681.119426488891;5581.8604534886545;5636.379998200195;5647.237622920915;5650.039493286141;5660.377358490563;5105.463926287742;5143.305653736735;5149.716765577892;5155.845324640267;5168.586513078944;5074.137396642561;5182.248573956774;5207.4792520747815;5210.583153347723;5255.579553635719;5158.845234642967;5227.398849132342;5234.8691282717855;5242.8165014224505;5304.3634763828395;5047.621428392867;5262.710550919698;5288.471152884719;5293.417724050351;5308.5487733542695;4980.601551875841;5098.056859480971;5131.076406246874;5161.4322424533275;5174.508421699932;5608.887822243573;5616;5626.521745651625;5643.971780141114;5657.745401456944;6110.832160913957;6114.59769371268;6122.36762111682;6123.418275263843;6193.535484838655;5192.883530041022;5862.384449632812;6116.12274041307;6217.285012223561;6263.935131027736;5758.942410575924;5767.279090113736;5769.480746732815;5774.2782152230975;5776.826695199109;6165.753369865245;6224.502039836802;6276.089966954766;6285.59143655661;6298.968505157536;6088.360722124113;6098.878022439526;6105.419985101408;6127.234095738033;6143.754249829957;6173.32093469718;6231.22109736283;6246.562740608114;6251.624902505864;6261.217347831521;4975.800967961313;6035.909461358083;6038.33578306386;6106.72519736613;6186.783462578878;6080.847978800565;6091.0558863376245;6091.466195982041;6113.35025128125;6123.0509271062165;4798.448178459452;4808.0383923215495;4809.519048095162;4812.085703716352;4844.8304309349005;4328.069465064963;4341.630961368256;4343.847965321262;4354.303311470149;4358.128374325148;5593.636413633101;5654.4062873398525;5668.943310566841;5707.315122185281;5777.335606405233;6231.393539986162;6258.092576576371;6265.96867015662;6270.996640537492;6277.1525844011385;5714.942850571441;5721.628094173865;5728.312602487728;5735.369109397963;5761.625494342854;5229.895402091937;5254.15933450646;5280.339957505312;5290.735463226823;5319.335083114611;6223.408776166348;6229.377062293825;6241.063840423791;6257.655828929271;6271.686415679106;5299.5760339172;6083.969580152071;6228.283747369111;6259.96870015647;6264.5301602379095;6196.81409557714;6200.441960223601;6215.347388524321;6244.125822384779;6302.117703521419;6115.696722738907;6157.784477543264;6163.691815409301;6165.568410211242;6186.783462578788;6209.813705588839;6219.502439804895;6219.937800622117;6223.813285601439;6241.469475094668;5284.81503147388;5449.782008719607;5771.932192544393;5925.081612350093;6054.273487181566;5923.170756094237;5982.940170598238;5984.940150598438;5997.580169388276;6001.309849367379;5822.912656310244;5826.475617194304;5840.445157710011;5846.269216347957;5858.794942177004;5985;6035.0343944970355;6037.034074548052;6053.757849685963;6054.455099040932;5835.67903765297;5850.94149058504;5855.795047173328;5856.180134781049;5858.912116318344 00:34:47 INFO - PROCESS | 1672 | |1;ext.html;513.6019584821763;520.1521519922526;531.1183435497076;533.1017235957412;554.3154204557371;30499.237519062033;31243.375132497364;41069.79465102674;41223.58776412235;43439;41787.79106104473;42095.36856947148;42213.57786422135;42247.57752422475;42395.364069538984;8649.870251946226;9731.464769437678;9884.604615815359;9887.851682224737;9892.208623310155;8831.11688831115;11877.7624447511;12240.143189976705;12255.958243549265;12425.378731063456;12093;12099.879001209963;12161.756764864698;12165.209261398026;12210.389480525982;8750.737477875611;9004.234640055603;12196.45115969779;12293.262404255773;12326.50693972249;11749.588764393291;12069.758604827943;12122.454489547992;12263;12278.815817762741;40617.98455038618;40637.98405039868;40639;40648.39027414591;40699;2921.956170657442;3310.155910242873;3484.564429446319;3714.257148570297;3764.834945646737;29768.660410281373;30697.693023069707;31477.898273560546;31519.212019699462;31548;2785.916422507328;3162.794418362799;3313.8508767105295;3337.332533493287;3384.644612315696;473823.20149190194;473940.6302968463;474605.6269718664;474761.6261918703;474809;55834;56206.43793562012;56577.43422565804;56597;56714;58262.417375826546;59413;59537;59541.40458595445;59621.40378596245;15722.29249683767;15935.36258549645;15936.362545498283;15941.282642281125;15962.882598218246;11166.776664466828;11460.59887903936;11481.024112950492;12394.566190183481;12470.189437686522;15268.694626107415;15375.538733838002;15441.691166176613;15512.509685320712;15587.67504762108;5696.3733989261145;6242.469390101802;6356.555041147075;6391.552591318563;6431.774887878902;852.497026754218;884.5842454046588;919.8804155459748;959.947202903833;1004.834202356603;26524.867375663383;28923;29189.56215656767;29952.25119372033;30080.886249337666;1128.189256243717;1128.2440764687678;1136.3466007045815;1176.3706417066828;1199.9100067494974;15123.621909452131;15267.770983435035;15339.002964807252;15417.383304667912;15603.921980390025;632576;635857;639426;640099;640421;56604.71697641486;56631.43368566344;56683;56767.14849277264;57197;1298.8571257161705;1343.603636927109;1364.9112807667866;1369.0553518072497;1373.5604606526015;29279.560806588343;29306.41387172202;29423.411531769674;30175.69824301729;30217;48237.75881120572;48654;48716.512834871195;48736.512634873194;48839.755801222185;590137;592628.7002734733;592760;596542;596622;32920.341593167526;33913.83043084769;38604.6139538601;39608.40587391249;39809.20381592294;37887.863364099125;41853.162936741704;44701.55298447104;48092.519074808806;48765.5123448761;38025;38666;38757.612423876526;39628.20743585054;39911.2017759649;35131.824340878135;38299.617003829604;38380.42429363506;39475.210495790496;39673.60326396814;36190.04161314158;36789.63210367862;37771;37841.432378514895;37901.620983789806;32715;32928.506072408454;33980.66019339775;34156.31687366289;34278.48582271318;24552;24673.766311684703;24948;25192;25590.23229303124 00:34:47 INFO - PROCESS | 1672 | |2;jquery.html;322.3697671053091;355.96440355964404;365.20932181826356;383.0595887097177;394.7256656623646;16410.671786564275;20084.698729519052;20187.09158087886;20512.35901127908;21260.681089783626;19462.902685486588;19663;20017.099230534626;20157.496062598442;20165.294214702488;5789.160571717099;5904.793332233373;6173.783917562886;6178.011518157095;6186.84532886677;5190.71451070191;5850.736716847752;5932.525397968152;5953.255843019622;5995.6102853314615;5654.180143879135;5920.348761636216;5931.466168044875;5937.910931336033;5967.731452084645;5978.790742324019;6032.185654936571;6032.607880487798;6032.909506357386;6036.305824830135;4992.575631071363;5196.818111366084;5197.1424714922;5247.186686063628;5330.600204984642;12647.05147113961;12883.67790805228;12883.935580322131;14237;23941;2042.428120126367;2084.1975839301826;2089.4671858676093;2395.6646069550275;2745.272502786763;9547.520134379112;9563.617455301779;9616.326857120004;10064.798704025952;10117;1806.1962426720115;1864.2915692037075;1867.9346222882134;1870.3921225601598;1918.88486690799;92271.07728922692;111505;113497;114457.4277128609;114467.28299075521;10788.327809189588;10947.233693641529;10977.341359518454;11218.943905280421;11372.247158437862;14072.507462238773;14073.577792666032;14079.648008799863;14084.15495070299;14089.859101408854;7979.800504987422;8012.479188852706;8161.755147345589;8260.876086858701;8300.584970751439;6574.408303252731;8104.1085480597085;8176.3867709922;8330.791730206673;8336.416450848383;4273.124009578091;4309.956900431018;4360.819590204897;4372.562743725602;4444.377787109807;1813.9049397945394;1865.7947625761155;1871.8408935240384;1871.9625607487774;1875.577994951125;778.7196609220676;868.162223454357;879.8768172455862;894.1728900766894;935.8455854784021;15194.772078418833;19314.55140864441;20043.59476862786;20123.7925724457;20480.38558843237;866.3502373220085;879.6525372477836;937.6202637931513;941.4774799985937;974.4932635029745;9734.902650973541;10234.437105959094;10417.218708596885;10446.63436779709;10455.581776728846;507054.46472768136;513002;516969;603003;609506;118840.40579797045;125567.21029528028;128960.3551982234;129270.35364823116;129901;938.6573900526396;969.1326262994721;1003.8142943555465;1004.2668851738272;1006.3408467453829;15871.444499442465;18674;18764.87172821977;18806.435806925812;18904.810951890857;39381.2123757529;41979.37030944477;47666.52333476621;50913.72715682138;54147.729261353445;57363;57692;74094.14764630927;76371;76796.84804728045;6360.809175724736;7649.97275721923;7848.7645370638975;7921.683132674629;8124.187581241828;8896.82027903168;11996.940015300217;12166.75666486683;12348.753024939271;12520.749585008067;9725.9027409725;10654.786904262026;10794;10829.783404332027;10842.166639257015;9588.712338629852;10443.791124177626;10509.842352364874;10681.412522311037;10810.51352689115;10656.307340022873;10856.185786065918;10982.231243813176;11080.39057851826;11083.778324433304;7745.806354841174;7809.258120478546;7813.726519571787;7886.802829929068;8051.2351326623875;10339.276250662382;10685.465726713788;10849.349039057683;10896.673099807018;10981.670549883516 00:34:47 INFO - PROCESS | 1672 | |3;mootools.html;1341.6645838540364;1491.1723993183782;1506.7890495330653;1703.2080082761513;1900.1164458526782;7808.336291415229;8276.420650554464;8640.481571105738;8896;8923.241524470428;7492.700291988328;7601.733939312126;8721.7819554511;8726.825463490726;8824.338174636912;2377.9881100594516;2399.472116134448;2401;2401.9159329423474;2402;2337.181986304788;2371.81025517959;2385.0817435287454;2385.3678775124517;2393.293978276404;2352.5647755165264;2375.0381095656285;2383.2016274548046;2392.940176495593;2394.365493144318;2337.49743805081;2353.788159065684;2362.208660098869;2362.929112126622;2372.205311220726;2319.431739223884;2356.681847950539;2360.433495960957;2360.799332056777;2364.609839376501;7572;8752.081031491729;8782.560871956377;8854.424462409923;8874.890638670166;5184.377874655028;5409.9459005409835;5429.837104886859;5437.34751829783;5445.83662490126;3067.3558552703958;3483.89548313551;3708.5735140458924;3716.1267102230954;3721.6464435878547;1042.3224903812506;1074.215822449616;1076.7523469601956;1094.6661268313162;1098.8241881299034;11457.083433325313;11497.540098396054;11498.712532186679;11607.941960290145;11620.593279235187;4367.323064924942;4440.955590444119;4612.031473390559;4612.607928326062;4620.353150558924;7891.329237014918;8928.508932008672;9036.412633178823;9045.864312035324;9054.818903622023;5242.370915490089;5243.239730239094;5245.868853278698;5247.2653828464045;5249.6062795289745;4147.605977432139;4406.184855801687;4561.178987782231;4577;4927.7536123193695;3689.409694448875;3707.5736290326417;3784.905377365588;3792.355299599075;3804.163084121544;1152.2510368260698;1158.09089864456;1160.495184594704;1171.0924033873816;1173.7828501727208;872.6291326186472;876.3339861705023;877.1973644115691;899.5637115998735;951.1439704266078;5505.834824955257;5563.165525171256;5722.885542289214;5855.707214639251;5859.091840764689;875.4834647557972;882.2280504558511;913.0732306708563;927.5037854747677;935.6304259817471;3672.8163591820303;3725.850965961331;3811.561670407883;3833.3291673956946;3873.2447172801035;10381.636642717469;10805.13558915285;10839.295445795999;10841.891581084088;10843.078338341329;10792.974667406585;10808.459577021275;10809;10828.729281768019;10863;8135.959320203361;8285.42002059862;8287.378446616527;8310.83378332442;8332.62503187358;5019.372578427697;5318.867028324323;5376.112941364631;5618.550515958796;5693.658380497183;9768.413895166028;10028.997100290204;10084.092431681183;10087.646932357333;10198.33710808795;9357.578908948977;9896.406215627085;10264;10367.170626350025;10371.844422333821;6651;6853.7943861684225;6905.37851593359;7152.105986751656;7172.605506697182;8255.504669719836;8283.792905177419;8291.295239904675;8367.414281000272;8370.916290837258;7492.700291988477;7545.547267163988;7586.544807311579;7634.122075961113;7661;5798.739056742541;7088.893666594902;7314;7376.668049937658;7499.2500749924575;6912.274211207952;7073.71705131789;7074.823129421599;7078.646067696697;7085.6457177141965;4554.7039442436135;4687.5781179693995;4802.919343147763;4885.682430641997;4951.257311403318;4198.769067701183;4914.533119353656;4988.875278117931;5026.371703537058;5058.1654027085115 00:34:47 INFO - PROCESS | 1672 | |4;prototype.html;296.93912747886685;300.07576663875255;304.9600861063772;312.0902569011332;315.92101974506375;5162.889978654589;5213.504717051874;5240.711760853156;5250.186221135726;5259.474052594738;4782.258749893772;4882.216282381157;4883.389576302962;4940.802367905279;5083.517065878736;3341.63242043375;3439.29494453637;4000.399940008993;4016.4376987221813;4054.2904991626497;4001.8799436016966;4010.9398359024494;4012.217617564576;4035.4148648445957;4042.8584999524874;3830.291396091718;3863.3818589025764;3924.2936271471126;3992.4610177626087;4000.3799411091327;3370.5338177892695;3493.8602455901732;3984.203159368138;4005.9584508027833;4009.759414435114;3468.5664291963503;3483.4774783782636;3486.442169252907;3494.5631796025496;3528.435450327935;4521.660875434355;4803;5093.719845408501;5112.463191364927;5134.358205224347;3818.4344418788164;4322.697411181219;4595.977020114911;4605.930911036337;4632.166210082184;5448.45515448456;5479.4520547944885;5481.314835645544;5497.505224529811;5519.530839878575;3816.637419445148;3838.769673819552;3878.301905657009;3884.6892248620043;3891.649751522348;4749.7387643679585;5444.265024221719;5720.313562372542;5727.737543670269;5786.855328616776;3873.4577159197734;3888.891665875212;3897.2205558888336;3912.256671232457;3915.8086159779687;3352.1619595101224;3963.9009024774036;3968.9603103969166;3971.62269584389;3978.6817054635558;4200.432941552851;4455.576720211575;4569.527159358845;4570.451545814523;4581.610563102174;4496.96454892946;4805.639577031667;4938.209886418156;5395.541378982752;5513.448655134534;1298.3248710670398;1327.2169420042221;1331.7003674173234;1332.4936524120965;1334.1728128560355;832.7376876284072;853.8078932240196;854.43607219235;867.7266661001764;886.9512176830207;4775.617950563947;5133.178691409431;5138.3833939927445;5153.634286913971;5153.768080436389;4946.911679430519;5642.774289028475;5663;5670.688112153789;5673.546116310686;4282.978585107055;4553;4746.501617330199;5111.642185047011;5123.129068058439;2392.33732555872;2896.956545651817;2935.882564697431;2938.338873753431;2946.6758656547763;5480.588955828329;5795.94204057954;5813.110739009839;5820.185174075633;5825.611499285273;4961.82633607822;5552.194931734876;5811.128330750421;5889.793857215062;5894.823155305347;5659.651244733472;5907.6959985605645;5959.582829201914;5997.820065398045;6060.939390606214;4467.900086959124;5475.8500714850325;5530.474604912527;5726.541876649775;5788.6526808389945;5660.575456840836;5672.262605861211;5677.602567820378;5691.430856914276;5691.886162276648;5206.401263854706;5511.807086751945;5928.79249226275;5950.494207992369;6000;3064.5249986252165;3568.5555394554813;3650.3429382711365;3682.0610744260043;3840.137533296293;4953.157963146202;5776.566757493289;5793.856273178951;5794.478496935296;5826.329972053099;4942.1598328285;5461.617686761889;5670.914936276042;5685.175649530712;5688.459596338341;4679.929801052919;5261.368975617571;5340.118880384848;5555.944440555542;5583.2871140692605;4549.977250113729;5176.842126303028;5440.319960004999;5492.423295553909;5501.367342755634;4645.581897629229;5252.369715634149;5342.973285133549;5458.208559758892;5545.197810711455;4225.408442817947;5083.415407228216;5226.63413561047;5418.83743487696;5430.755615997368 00:34:47 INFO - PROCESS | 1672 | |5;yui.html;691.6645426967921;707.9681414336354;743.0674503498109;804.3565147881693;816.5264146794859;15675.216239188023;15964.920175399122;16294.83705162948;16352.345906163753;16719.582010449743;14576.344064517096;14647.487337943174;14677.192754398504;14683.559493215194;14717.558473245794;667.0960848050894;686.1526015371013;691.9135108111486;837.4556538250125;838.6226198210799;848.775074605227;862.3790870573177;866.9653213871469;869.4479005831311;871.1245198575423;913.0002647101413;914.6661468563959;914.8581969794692;915.8671992561108;919.4437365393941;721.6283613938825;740.8259059121102;915.9221466175383;916.3173435790345;916.812053529025;659.5943494750694;676.6751959059679;679.2460368990417;680.7379159023762;681.1213534540437;15382.307796149089;15409.075455472595;15411.306491207923;15421.691566168614;15487.767683484757;13826.30868456573;14061.929690351584;14191.503297384645;14253.643658908506;14376.209308488029;12664.240145591202;12783.424745886457;12783.61649150527;13008.414621342063;13406.329683515785;3926.088930804431;4482.372467854503;4595.287730401793;4601.700889442175;4669.976650116761;111739.44130279297;113542;114789;116793.4160329193;116840.41579792046;11058.726096218723;11096.500657470433;11136.832947505794;11194.440277986068;11506.712332191762;18934.715979260323;22503.549929001656;22568.322950311187;22589.87050647461;22609.773902260767;7978.680852765824;8005.039395272488;8011.839763204704;8038.954935858301;8159.877601835978;4390.07808360248;4399.23013472641;4446.844360447369;4485.147821913826;4588.151192029485;3512.104413374573;3629.927401451956;3631.782093074371;3631.891043268706;3639.745217834726;537.5941164420838;647.7700416352221;657.0833687006694;657.135866335767;657.2540166910591;583.8423625621059;600.9819705408845;614.8401415631879;637.8309747916805;645.4094503529218;7827.882581761278;8636.568171591522;9082;9232.90767092334;9302.86045709315;589.3369958796354;591.4115455122181;620.8354785981718;625.3951944356602;640.8846407646575;4469.575390337913;4477.462704475483;4478.686491945533;4519.141363140992;4568.803591268959;97096.51451742696;119354;135121.6487835109;158756;159372;130184;130627;136281.6371836289;137036;138289;73153.6342318285;74025;75291.62354188194;75357.62321188468;92020;7505.136909255287;8564.272036876686;8668.91331086681;8746.562671866508;8990.32572557074;41232.38151427671;54363.45636543584;56143.71928140333;56703;62601;80130.59934700289;85635.57182214299;86953;87731.56134219289;89525.55237223773;11040.779184416106;12848.229106253655;13273.601791946257;13542.458301667823;13894.23581703016;14750.188739619423;14908.925455372653;15056.397744090114;15149;15559.377624894878;14089.577312680636;14143.929280353532;14240.359183836545;14283.857161428252;14522.85477145215;13425.530106446227;13857.584272471842;13902.860971390157;13947.4421023162;14360.856391435951;13349.733005340033;13474.52839150625;13560.321983900569;13906.165630062229;14292.785608216092;9837.803243935225;11265.943670281596;11278;11512;11690.590829321272;11280.435978201222;11374.658760237206;11379.431028448378;11598.594049208237;11621 00:34:47 INFO - PROCESS | 1672 | __end_tp_report 00:34:47 INFO - PROCESS | 1672 | __start_cc_report 00:34:47 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,2514 00:34:47 INFO - PROCESS | 1672 | __end_cc_report 00:34:47 INFO - PROCESS | 1672 | __startTimestamp1475220887387__endTimestamp 00:34:47 INFO - PROCESS | 1672 | 00:34:47 INFO - PROCESS | 1672 | ------- Summary: start ------- 00:34:47 INFO - PROCESS | 1672 | Number of tests: 6 00:34:47 INFO - PROCESS | 1672 | 00:34:47 INFO - PROCESS | 1672 | [#0] dojo.html Cycles:165 Average:5664.60 Median:5826.48 stddev:635.97 (10.9%) stddev-sans-first:610.43 00:34:47 INFO - PROCESS | 1672 | Values: 3306.7 3306.9 3310.3 3348.6 3374.7 5540.2 5634.5 5656.0 5661.1 5681.1 5581.9 5636.4 5647.2 5650.0 5660.4 5105.5 5143.3 5149.7 5155.8 5168.6 5074.1 5182.2 5207.5 5210.6 5255.6 5158.8 5227.4 5234.9 5242.8 5304.4 5047.6 5262.7 5288.5 5293.4 5308.5 4980.6 5098.1 5131.1 5161.4 5174.5 5608.9 5616.0 5626.5 5644.0 5657.7 6110.8 6114.6 6122.4 6123.4 6193.5 5192.9 5862.4 6116.1 6217.3 6263.9 5758.9 5767.3 5769.5 5774.3 5776.8 6165.8 6224.5 6276.1 6285.6 6299.0 6088.4 6098.9 6105.4 6127.2 6143.8 6173.3 6231.2 6246.6 6251.6 6261.2 4975.8 6035.9 6038.3 6106.7 6186.8 6080.8 6091.1 6091.5 6113.4 6123.1 4798.4 4808.0 4809.5 4812.1 4844.8 4328.1 4341.6 4343.8 4354.3 4358.1 5593.6 5654.4 5668.9 5707.3 5777.3 6231.4 6258.1 6266.0 6271.0 6277.2 5714.9 5721.6 5728.3 5735.4 5761.6 5229.9 5254.2 5280.3 5290.7 5319.3 6223.4 6229.4 6241.1 6257.7 6271.7 5299.6 6084.0 6228.3 6260.0 6264.5 6196.8 6200.4 6215.3 6244.1 6302.1 6115.7 6157.8 6163.7 6165.6 6186.8 6209.8 6219.5 6219.9 6223.8 6241.5 5284.8 5449.8 5771.9 5925.1 6054.3 5923.2 5982.9 5984.9 5997.6 6001.3 5822.9 5826.5 5840.4 5846.3 5858.8 5985.0 6035.0 6037.0 6053.8 6054.5 5835.7 5850.9 5855.8 5856.2 5858.9 00:34:47 INFO - PROCESS | 1672 | 00:34:47 INFO - PROCESS | 1672 | [#1] ext.html Cycles:180 Average:70074.99 Median:37806.22 stddev:153025.34 (404.8%) stddev-sans-first:153365.49 00:34:47 INFO - PROCESS | 1672 | Values: 513.6 520.2 531.1 533.1 554.3 30499.2 31243.4 41069.8 41223.6 43439.0 41787.8 42095.4 42213.6 42247.6 42395.4 8649.9 9731.5 9884.6 9887.9 9892.2 8831.1 11877.8 12240.1 12256.0 12425.4 12093.0 12099.9 12161.8 12165.2 12210.4 8750.7 9004.2 12196.5 12293.3 12326.5 11749.6 12069.8 12122.5 12263.0 12278.8 40618.0 40638.0 40639.0 40648.4 40699.0 2922.0 3310.2 3484.6 3714.3 3764.8 29768.7 30697.7 31477.9 31519.2 31548.0 2785.9 3162.8 3313.9 3337.3 3384.6 473823.2 473940.6 474605.6 474761.6 474809.0 55834.0 56206.4 56577.4 56597.0 56714.0 58262.4 59413.0 59537.0 59541.4 59621.4 15722.3 15935.4 15936.4 15941.3 15962.9 11166.8 11460.6 11481.0 12394.6 12470.2 15268.7 15375.5 15441.7 15512.5 15587.7 5696.4 6242.5 6356.6 6391.6 6431.8 852.5 884.6 919.9 959.9 1004.8 26524.9 28923.0 29189.6 29952.3 30080.9 1128.2 1128.2 1136.3 1176.4 1199.9 15123.6 15267.8 15339.0 15417.4 15603.9 632576.0 635857.0 639426.0 640099.0 640421.0 56604.7 56631.4 56683.0 56767.1 57197.0 1298.9 1343.6 1364.9 1369.1 1373.6 29279.6 29306.4 29423.4 30175.7 30217.0 48237.8 48654.0 48716.5 48736.5 48839.8 590137.0 592628.7 592760.0 596542.0 596622.0 32920.3 33913.8 38604.6 39608.4 39809.2 37887.9 41853.2 44701.6 48092.5 48765.5 38025.0 38666.0 38757.6 39628.2 39911.2 35131.8 38299.6 38380.4 39475.2 39673.6 36190.0 36789.6 37771.0 37841.4 37901.6 32715.0 32928.5 33980.7 34156.3 34278.5 24552.0 24673.8 24948.0 25192.0 25590.2 00:34:47 INFO - PROCESS | 1672 | 00:34:47 INFO - PROCESS | 1672 | [#2] jquery.html Cycles:180 Average:32400.18 Median:339.17 stddev:92310.03 (27216.7%) stddev-sans-first:92537.56 00:34:47 INFO - PROCESS | 1672 | Values: 322.4 356.0 365.2 383.1 394.7 16410.7 20084.7 20187.1 20512.4 21260.7 19462.9 19663.0 20017.1 20157.5 20165.3 5789.2 5904.8 6173.8 6178.0 6186.8 5190.7 5850.7 5932.5 5953.3 5995.6 5654.2 5920.3 5931.5 5937.9 5967.7 5978.8 6032.2 6032.6 6032.9 6036.3 4992.6 5196.8 5197.1 5247.2 5330.6 12647.1 12883.7 12883.9 14237.0 23941.0 2042.4 2084.2 2089.5 2395.7 2745.3 9547.5 9563.6 9616.3 10064.8 10117.0 1806.2 1864.3 1867.9 1870.4 1918.9 92271.1 111505.0 113497.0 114457.4 114467.3 10788.3 10947.2 10977.3 11218.9 11372.2 14072.5 14073.6 14079.6 14084.2 14089.9 7979.8 8012.5 8161.8 8260.9 8300.6 6574.4 8104.1 8176.4 8330.8 8336.4 4273.1 4310.0 4360.8 4372.6 4444.4 1813.9 1865.8 1871.8 1872.0 1875.6 778.7 868.2 879.9 894.2 935.8 15194.8 19314.6 20043.6 20123.8 20480.4 866.4 879.7 937.6 941.5 974.5 9734.9 10234.4 10417.2 10446.6 10455.6 507054.5 513002.0 516969.0 603003.0 609506.0 118840.4 125567.2 128960.4 129270.4 129901.0 938.7 969.1 1003.8 1004.3 1006.3 15871.4 18674.0 18764.9 18806.4 18904.8 39381.2 41979.4 47666.5 50913.7 54147.7 57363.0 57692.0 74094.1 76371.0 76796.8 6360.8 7650.0 7848.8 7921.7 8124.2 8896.8 11996.9 12166.8 12348.8 12520.7 9725.9 10654.8 10794.0 10829.8 10842.2 9588.7 10443.8 10509.8 10681.4 10810.5 10656.3 10856.2 10982.2 11080.4 11083.8 7745.8 7809.3 7813.7 7886.8 8051.2 10339.3 10685.5 10849.3 10896.7 10981.7 00:34:47 INFO - PROCESS | 1672 | 00:34:47 INFO - PROCESS | 1672 | [#3] mootools.html Cycles:180 Average:5596.48 Median:4900.11 stddev:3156.07 (64.4%) stddev-sans-first:3148.72 00:34:47 INFO - PROCESS | 1672 | Values: 1341.7 1491.2 1506.8 1703.2 1900.1 7808.3 8276.4 8640.5 8896.0 8923.2 7492.7 7601.7 8721.8 8726.8 8824.3 2378.0 2399.5 2401.0 2401.9 2402.0 2337.2 2371.8 2385.1 2385.4 2393.3 2352.6 2375.0 2383.2 2392.9 2394.4 2337.5 2353.8 2362.2 2362.9 2372.2 2319.4 2356.7 2360.4 2360.8 2364.6 7572.0 8752.1 8782.6 8854.4 8874.9 5184.4 5409.9 5429.8 5437.3 5445.8 3067.4 3483.9 3708.6 3716.1 3721.6 1042.3 1074.2 1076.8 1094.7 1098.8 11457.1 11497.5 11498.7 11607.9 11620.6 4367.3 4441.0 4612.0 4612.6 4620.4 7891.3 8928.5 9036.4 9045.9 9054.8 5242.4 5243.2 5245.9 5247.3 5249.6 4147.6 4406.2 4561.2 4577.0 4927.8 3689.4 3707.6 3784.9 3792.4 3804.2 1152.3 1158.1 1160.5 1171.1 1173.8 872.6 876.3 877.2 899.6 951.1 5505.8 5563.2 5722.9 5855.7 5859.1 875.5 882.2 913.1 927.5 935.6 3672.8 3725.9 3811.6 3833.3 3873.2 10381.6 10805.1 10839.3 10841.9 10843.1 10793.0 10808.5 10809.0 10828.7 10863.0 8136.0 8285.4 8287.4 8310.8 8332.6 5019.4 5318.9 5376.1 5618.6 5693.7 9768.4 10029.0 10084.1 10087.6 10198.3 9357.6 9896.4 10264.0 10367.2 10371.8 6651.0 6853.8 6905.4 7152.1 7172.6 8255.5 8283.8 8291.3 8367.4 8370.9 7492.7 7545.5 7586.5 7634.1 7661.0 5798.7 7088.9 7314.0 7376.7 7499.3 6912.3 7073.7 7074.8 7078.6 7085.6 4554.7 4687.6 4802.9 4885.7 4951.3 4198.8 4914.5 4988.9 5026.4 5058.2 00:34:47 INFO - PROCESS | 1672 | 00:34:47 INFO - PROCESS | 1672 | [#4] prototype.html Cycles:180 Average:4466.65 Median:4950.03 stddev:1378.67 (27.9%) stddev-sans-first:1346.55 00:34:47 INFO - PROCESS | 1672 | Values: 296.9 300.1 305.0 312.1 315.9 5162.9 5213.5 5240.7 5250.2 5259.5 4782.3 4882.2 4883.4 4940.8 5083.5 3341.6 3439.3 4000.4 4016.4 4054.3 4001.9 4010.9 4012.2 4035.4 4042.9 3830.3 3863.4 3924.3 3992.5 4000.4 3370.5 3493.9 3984.2 4006.0 4009.8 3468.6 3483.5 3486.4 3494.6 3528.4 4521.7 4803.0 5093.7 5112.5 5134.4 3818.4 4322.7 4596.0 4605.9 4632.2 5448.5 5479.5 5481.3 5497.5 5519.5 3816.6 3838.8 3878.3 3884.7 3891.6 4749.7 5444.3 5720.3 5727.7 5786.9 3873.5 3888.9 3897.2 3912.3 3915.8 3352.2 3963.9 3969.0 3971.6 3978.7 4200.4 4455.6 4569.5 4570.5 4581.6 4497.0 4805.6 4938.2 5395.5 5513.4 1298.3 1327.2 1331.7 1332.5 1334.2 832.7 853.8 854.4 867.7 887.0 4775.6 5133.2 5138.4 5153.6 5153.8 4946.9 5642.8 5663.0 5670.7 5673.5 4283.0 4553.0 4746.5 5111.6 5123.1 2392.3 2897.0 2935.9 2938.3 2946.7 5480.6 5795.9 5813.1 5820.2 5825.6 4961.8 5552.2 5811.1 5889.8 5894.8 5659.7 5907.7 5959.6 5997.8 6060.9 4467.9 5475.9 5530.5 5726.5 5788.7 5660.6 5672.3 5677.6 5691.4 5691.9 5206.4 5511.8 5928.8 5950.5 6000.0 3064.5 3568.6 3650.3 3682.1 3840.1 4953.2 5776.6 5793.9 5794.5 5826.3 4942.2 5461.6 5670.9 5685.2 5688.5 4679.9 5261.4 5340.1 5555.9 5583.3 4550.0 5176.8 5440.3 5492.4 5501.4 4645.6 5252.4 5343.0 5458.2 5545.2 4225.4 5083.4 5226.6 5418.8 5430.8 00:34:47 INFO - PROCESS | 1672 | 00:34:47 INFO - PROCESS | 1672 | [#5] yui.html Cycles:180 Average:23589.22 Median:4394.65 stddev:37176.97 (846.0%) stddev-sans-first:37241.51 00:34:47 INFO - PROCESS | 1672 | Values: 691.7 708.0 743.1 804.4 816.5 15675.2 15964.9 16294.8 16352.3 16719.6 14576.3 14647.5 14677.2 14683.6 14717.6 667.1 686.2 691.9 837.5 838.6 848.8 862.4 867.0 869.4 871.1 913.0 914.7 914.9 915.9 919.4 721.6 740.8 915.9 916.3 916.8 659.6 676.7 679.2 680.7 681.1 15382.3 15409.1 15411.3 15421.7 15487.8 13826.3 14061.9 14191.5 14253.6 14376.2 12664.2 12783.4 12783.6 13008.4 13406.3 3926.1 4482.4 4595.3 4601.7 4670.0 111739.4 113542.0 114789.0 116793.4 116840.4 11058.7 11096.5 11136.8 11194.4 11506.7 18934.7 22503.5 22568.3 22589.9 22609.8 7978.7 8005.0 8011.8 8039.0 8159.9 4390.1 4399.2 4446.8 4485.1 4588.2 3512.1 3629.9 3631.8 3631.9 3639.7 537.6 647.8 657.1 657.1 657.3 583.8 601.0 614.8 637.8 645.4 7827.9 8636.6 9082.0 9232.9 9302.9 589.3 591.4 620.8 625.4 640.9 4469.6 4477.5 4478.7 4519.1 4568.8 97096.5 119354.0 135121.6 158756.0 159372.0 130184.0 130627.0 136281.6 137036.0 138289.0 73153.6 74025.0 75291.6 75357.6 92020.0 7505.1 8564.3 8668.9 8746.6 8990.3 41232.4 54363.5 56143.7 56703.0 62601.0 80130.6 85635.6 86953.0 87731.6 89525.6 11040.8 12848.2 13273.6 13542.5 13894.2 14750.2 14908.9 15056.4 15149.0 15559.4 14089.6 14143.9 14240.4 14283.9 14522.9 13425.5 13857.6 13902.9 13947.4 14360.9 13349.7 13474.5 13560.3 13906.2 14292.8 9837.8 11265.9 11278.0 11512.0 11690.6 11280.4 11374.7 11379.4 11598.6 11621.0 00:34:47 INFO - PROCESS | 1672 | -------- Summary: end -------- 00:34:47 INFO - PROCESS | 1672 | 00:34:48 INFO - TEST-INFO | 1672: exit 0 00:34:48 INFO - TEST-OK | dromaeo_css | took 1118367ms 00:34:48 INFO - TEST-START | kraken 00:34:48 INFO - operating with platform_type : mac_ 00:34:48 INFO - Initialising browser for kraken test... 00:34:48 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/tmpHyL5fD/profile http://localhost:49267/getInfo.html) 00:34:50 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 00:34:50 INFO - PROCESS | 1678 | colorDepth:24 00:34:50 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 00:34:50 INFO - PROCESS | 1678 | __metrics 00:34:50 INFO - PROCESS | 1678 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:34:50 INFO - PROCESS | 1678 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:34:51 INFO - TEST-INFO | 1678: exit 0 00:34:51 INFO - Browser initialized. 00:34:51 INFO - Running cycle 1/1 for kraken test... 00:34:51 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/tmpHyL5fD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:35:03 INFO - PROCESS | 1679 | RSS: Main: 244641792 00:35:03 INFO - PROCESS | 1679 | 00:35:05 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 00:35:06 INFO - PROCESS | 1679 | RSS: Main: 295170048 00:35:06 INFO - PROCESS | 1679 | 00:35:09 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 00:35:10 INFO - PROCESS | 1679 | RSS: Main: 293564416 00:35:10 INFO - PROCESS | 1679 | 00:35:13 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 00:35:14 INFO - PROCESS | 1679 | RSS: Main: 384135168 00:35:14 INFO - PROCESS | 1679 | 00:35:16 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 00:35:16 INFO - PROCESS | 1679 | RSS: Main: 285433856 00:35:16 INFO - PROCESS | 1679 | 00:35:18 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:35:19 INFO - PROCESS | 1679 | RSS: Main: 290660352 00:35:19 INFO - PROCESS | 1679 | 00:35:22 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 00:35:22 INFO - PROCESS | 1679 | RSS: Main: 329584640 00:35:22 INFO - PROCESS | 1679 | 00:35:25 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 00:35:26 INFO - PROCESS | 1679 | RSS: Main: 329338880 00:35:26 INFO - PROCESS | 1679 | 00:35:29 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 00:35:29 INFO - PROCESS | 1679 | RSS: Main: 327303168 00:35:29 INFO - PROCESS | 1679 | 00:35:31 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:35:31 INFO - PROCESS | 1679 | RSS: Main: 302080000 00:35:31 INFO - PROCESS | 1679 | 00:35:33 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:35:34 INFO - PROCESS | 1679 | RSS: Main: 306860032 00:35:34 INFO - PROCESS | 1679 | 00:35:36 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:35:37 INFO - PROCESS | 1679 | RSS: Main: 309030912 00:35:37 INFO - PROCESS | 1679 | 00:35:40 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:35:41 INFO - PROCESS | 1679 | RSS: Main: 317313024 00:35:41 INFO - PROCESS | 1679 | 00:35:43 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:35:44 INFO - PROCESS | 1679 | RSS: Main: 318935040 00:35:44 INFO - PROCESS | 1679 | 00:35:46 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 00:35:46 INFO - PROCESS | 1679 | RSS: Main: 362397696 00:35:46 INFO - PROCESS | 1679 | 00:35:46 INFO - PROCESS | 1679 | __start_tp_report 00:35:46 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 00:35:46 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 00:35:46 INFO - PROCESS | 1679 | |i|pagename|runs| 00:35:46 INFO - PROCESS | 1679 | |0;ai-astar;114;115;114;114;115;115;114;114;114;115 00:35:46 INFO - PROCESS | 1679 | |1;audio-beat-detection;153;94;110;170;141;139;111;108;143;108 00:35:46 INFO - PROCESS | 1679 | |2;audio-dft;184;182;196;215;186;183;184;180;183;183 00:35:46 INFO - PROCESS | 1679 | |3;audio-fft;81;63;75;112;83;72;59;59;79;57 00:35:46 INFO - PROCESS | 1679 | |4;audio-oscillator;87;70;91;71;69;69;91;67;68;89 00:35:46 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;87;84;90;129;88;83;88;84;86;87 00:35:46 INFO - PROCESS | 1679 | |6;imaging-darkroom;94;95;94;95;93;94;94;94;93;94 00:35:46 INFO - PROCESS | 1679 | |7;imaging-desaturate;86;85;84;85;86;84;86;86;84;84 00:35:46 INFO - PROCESS | 1679 | |8;json-parse-financial;56;55;53;53;53;54;56;54;54;53 00:35:46 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;64;71;69;76;71;70;68;70;71;70 00:35:46 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;89;88;84;91;101;101;102;79;87;91 00:35:46 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;140;138;138;139;146;149;133;161;243;150 00:35:46 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;169;166;167;170;170;164;169;167;168;167 00:35:46 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;68;70;67;69;68;67;68;65;68;66 00:35:46 INFO - PROCESS | 1679 | __end_tp_report 00:35:46 INFO - PROCESS | 1679 | __start_cc_report 00:35:46 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,1902 00:35:46 INFO - PROCESS | 1679 | __end_cc_report 00:35:46 INFO - PROCESS | 1679 | __startTimestamp1475220946509__endTimestamp 00:35:46 INFO - PROCESS | 1679 | 00:35:46 INFO - PROCESS | 1679 | ------- Summary: start ------- 00:35:46 INFO - PROCESS | 1679 | Number of tests: 14 00:35:46 INFO - PROCESS | 1679 | 00:35:46 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:114.40 Median:114.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 00:35:46 INFO - PROCESS | 1679 | Values: 114.0 115.0 114.0 114.0 115.0 115.0 114.0 114.0 114.0 115.0 00:35:46 INFO - PROCESS | 1679 | 00:35:46 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:127.70 Median:142.00 stddev:24.66 (17.4%) stddev-sans-first:24.39 00:35:46 INFO - PROCESS | 1679 | Values: 153.0 94.0 110.0 170.0 141.0 139.0 111.0 108.0 143.0 108.0 00:35:46 INFO - PROCESS | 1679 | 00:35:46 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:187.60 Median:184.00 stddev:10.55 (5.7%) stddev-sans-first:11.11 00:35:46 INFO - PROCESS | 1679 | Values: 184.0 182.0 196.0 215.0 186.0 183.0 184.0 180.0 183.0 183.0 00:35:46 INFO - PROCESS | 1679 | 00:35:46 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:74.00 Median:73.50 stddev:16.55 (22.5%) stddev-sans-first:17.35 00:35:46 INFO - PROCESS | 1679 | Values: 81.0 63.0 75.0 112.0 83.0 72.0 59.0 59.0 79.0 57.0 00:35:46 INFO - PROCESS | 1679 | 00:35:46 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:79.00 stddev:10.70 (13.5%) stddev-sans-first:10.74 00:35:46 INFO - PROCESS | 1679 | Values: 87.0 70.0 91.0 71.0 69.0 69.0 91.0 67.0 68.0 89.0 00:35:46 INFO - PROCESS | 1679 | 00:35:46 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:90.60 Median:87.00 stddev:13.66 (15.7%) stddev-sans-first:14.43 00:35:46 INFO - PROCESS | 1679 | Values: 87.0 84.0 90.0 129.0 88.0 83.0 88.0 84.0 86.0 87.0 00:35:46 INFO - PROCESS | 1679 | 00:35:46 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:94.00 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 00:35:46 INFO - PROCESS | 1679 | Values: 94.0 95.0 94.0 95.0 93.0 94.0 94.0 94.0 93.0 94.0 00:35:46 INFO - PROCESS | 1679 | 00:35:46 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.50 stddev:0.94 (1.1%) stddev-sans-first:0.93 00:35:46 INFO - PROCESS | 1679 | Values: 86.0 85.0 84.0 85.0 86.0 84.0 86.0 86.0 84.0 84.0 00:35:46 INFO - PROCESS | 1679 | 00:35:46 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:1.20 (2.2%) stddev-sans-first:1.05 00:35:46 INFO - PROCESS | 1679 | Values: 56.0 55.0 53.0 53.0 53.0 54.0 56.0 54.0 54.0 53.0 00:35:46 INFO - PROCESS | 1679 | 00:35:46 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:70.50 stddev:2.98 (4.2%) stddev-sans-first:2.24 00:35:46 INFO - PROCESS | 1679 | Values: 64.0 71.0 69.0 76.0 71.0 70.0 68.0 70.0 71.0 70.0 00:35:46 INFO - PROCESS | 1679 | 00:35:46 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:91.30 Median:87.50 stddev:7.76 (8.9%) stddev-sans-first:8.19 00:35:46 INFO - PROCESS | 1679 | Values: 89.0 88.0 84.0 91.0 101.0 101.0 102.0 79.0 87.0 91.0 00:35:46 INFO - PROCESS | 1679 | 00:35:46 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:153.70 Median:147.50 stddev:32.40 (22.0%) stddev-sans-first:33.98 00:35:46 INFO - PROCESS | 1679 | Values: 140.0 138.0 138.0 139.0 146.0 149.0 133.0 161.0 243.0 150.0 00:35:46 INFO - PROCESS | 1679 | 00:35:46 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.70 Median:168.50 stddev:1.89 (1.1%) stddev-sans-first:1.94 00:35:46 INFO - PROCESS | 1679 | Values: 169.0 166.0 167.0 170.0 170.0 164.0 169.0 167.0 168.0 167.0 00:35:46 INFO - PROCESS | 1679 | 00:35:46 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.43 (2.1%) stddev-sans-first:1.51 00:35:46 INFO - PROCESS | 1679 | Values: 68.0 70.0 67.0 69.0 68.0 67.0 68.0 65.0 68.0 66.0 00:35:46 INFO - PROCESS | 1679 | -------- Summary: end -------- 00:35:46 INFO - PROCESS | 1679 | 00:35:47 INFO - TEST-INFO | 1679: exit 0 00:35:47 INFO - TEST-OK | kraken | took 59343ms 00:35:47 INFO - SUITE-END | took 1177s 00:35:47 INFO - Completed test suite (00:19:37) 00:35:47 INFO - javascript benchmark 00:35:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3306.735461163107, 3306.917327066824, 3310.2882880180755, 3348.64839191885, 3374.730021598271, 5540.196671482632, 5634.549236061111, 5655.971720141399, 5661.065924122515, 5681.119426488891, 5581.8604534886545, 5636.379998200195, 5647.237622920915, 5650.039493286141, 5660.377358490563, 5105.463926287742, 5143.305653736735, 5149.716765577892, 5155.845324640267, 5168.586513078944, 5074.137396642561, 5182.248573956774, 5207.4792520747815, 5210.583153347723, 5255.579553635719, 5158.845234642967, 5227.398849132342, 5234.8691282717855, 5242.8165014224505, 5304.3634763828395, 5047.621428392867, 5262.710550919698, 5288.471152884719, 5293.417724050351, 5308.5487733542695, 4980.601551875841, 5098.056859480971, 5131.076406246874, 5161.4322424533275, 5174.508421699932, 5608.887822243573, 5616.0, 5626.521745651625, 5643.971780141114, 5657.745401456944, 6110.832160913957, 6114.59769371268, 6122.36762111682, 6123.418275263843, 6193.535484838655, 5192.883530041022, 5862.384449632812, 6116.12274041307, 6217.285012223561, 6263.935131027736, 5758.942410575924, 5767.279090113736, 5769.480746732815, 5774.2782152230975, 5776.826695199109, 6165.753369865245, 6224.502039836802, 6276.089966954766, 6285.59143655661, 6298.968505157536, 6088.360722124113, 6098.878022439526, 6105.419985101408, 6127.234095738033, 6143.754249829957, 6173.32093469718, 6231.22109736283, 6246.562740608114, 6251.624902505864, 6261.217347831521, 4975.800967961313, 6035.909461358083, 6038.33578306386, 6106.72519736613, 6186.783462578878, 6080.847978800565, 6091.0558863376245, 6091.466195982041, 6113.35025128125, 6123.0509271062165, 4798.448178459452, 4808.0383923215495, 4809.519048095162, 4812.085703716352, 4844.8304309349005, 4328.069465064963, 4341.630961368256, 4343.847965321262, 4354.303311470149, 4358.128374325148, 5593.636413633101, 5654.4062873398525, 5668.943310566841, 5707.315122185281, 5777.335606405233, 6231.393539986162, 6258.092576576371, 6265.96867015662, 6270.996640537492, 6277.1525844011385, 5714.942850571441, 5721.628094173865, 5728.312602487728, 5735.369109397963, 5761.625494342854, 5229.895402091937, 5254.15933450646, 5280.339957505312, 5290.735463226823, 5319.335083114611, 6223.408776166348, 6229.377062293825, 6241.063840423791, 6257.655828929271, 6271.686415679106, 5299.5760339172, 6083.969580152071, 6228.283747369111, 6259.96870015647, 6264.5301602379095, 6196.81409557714, 6200.441960223601, 6215.347388524321, 6244.125822384779, 6302.117703521419, 6115.696722738907, 6157.784477543264, 6163.691815409301, 6165.568410211242, 6186.783462578788, 6209.813705588839, 6219.502439804895, 6219.937800622117, 6223.813285601439, 6241.469475094668, 5284.81503147388, 5449.782008719607, 5771.932192544393, 5925.081612350093, 6054.273487181566, 5923.170756094237, 5982.940170598238, 5984.940150598438, 5997.580169388276, 6001.309849367379, 5822.912656310244, 5826.475617194304, 5840.445157710011, 5846.269216347957, 5858.794942177004, 5985.0, 6035.0343944970355, 6037.034074548052, 6053.757849685963, 6054.455099040932, 5835.67903765297, 5850.94149058504, 5855.795047173328, 5856.180134781049, 5858.912116318344], "value": 5624.240530675577, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [513.6019584821763, 520.1521519922526, 531.1183435497076, 533.1017235957412, 554.3154204557371, 30499.237519062033, 31243.375132497364, 41069.79465102674, 41223.58776412235, 43439.0, 41787.79106104473, 42095.36856947148, 42213.57786422135, 42247.57752422475, 42395.364069538984, 8649.870251946226, 9731.464769437678, 9884.604615815359, 9887.851682224737, 9892.208623310155, 8831.11688831115, 11877.7624447511, 12240.143189976705, 12255.958243549265, 12425.378731063456, 12093.0, 12099.879001209963, 12161.756764864698, 12165.209261398026, 12210.389480525982, 8750.737477875611, 9004.234640055603, 12196.45115969779, 12293.262404255773, 12326.50693972249, 11749.588764393291, 12069.758604827943, 12122.454489547992, 12263.0, 12278.815817762741, 40617.98455038618, 40637.98405039868, 40639.0, 40648.39027414591, 40699.0, 2921.956170657442, 3310.155910242873, 3484.564429446319, 3714.257148570297, 3764.834945646737, 29768.660410281373, 30697.693023069707, 31477.898273560546, 31519.212019699462, 31548.0, 2785.916422507328, 3162.794418362799, 3313.8508767105295, 3337.332533493287, 3384.644612315696, 473823.20149190194, 473940.6302968463, 474605.6269718664, 474761.6261918703, 474809.0, 55834.0, 56206.43793562012, 56577.43422565804, 56597.0, 56714.0, 58262.417375826546, 59413.0, 59537.0, 59541.40458595445, 59621.40378596245, 15722.29249683767, 15935.36258549645, 15936.362545498283, 15941.282642281125, 15962.882598218246, 11166.776664466828, 11460.59887903936, 11481.024112950492, 12394.566190183481, 12470.189437686522, 15268.694626107415, 15375.538733838002, 15441.691166176613, 15512.509685320712, 15587.67504762108, 5696.3733989261145, 6242.469390101802, 6356.555041147075, 6391.552591318563, 6431.774887878902, 852.497026754218, 884.5842454046588, 919.8804155459748, 959.947202903833, 1004.834202356603, 26524.867375663383, 28923.0, 29189.56215656767, 29952.25119372033, 30080.886249337666, 1128.189256243717, 1128.2440764687678, 1136.3466007045815, 1176.3706417066828, 1199.9100067494974, 15123.621909452131, 15267.770983435035, 15339.002964807252, 15417.383304667912, 15603.921980390025, 632576.0, 635857.0, 639426.0, 640099.0, 640421.0, 56604.71697641486, 56631.43368566344, 56683.0, 56767.14849277264, 57197.0, 1298.8571257161705, 1343.603636927109, 1364.9112807667866, 1369.0553518072497, 1373.5604606526015, 29279.560806588343, 29306.41387172202, 29423.411531769674, 30175.69824301729, 30217.0, 48237.75881120572, 48654.0, 48716.512834871195, 48736.512634873194, 48839.755801222185, 590137.0, 592628.7002734733, 592760.0, 596542.0, 596622.0, 32920.341593167526, 33913.83043084769, 38604.6139538601, 39608.40587391249, 39809.20381592294, 37887.863364099125, 41853.162936741704, 44701.55298447104, 48092.519074808806, 48765.5123448761, 38025.0, 38666.0, 38757.612423876526, 39628.20743585054, 39911.2017759649, 35131.824340878135, 38299.617003829604, 38380.42429363506, 39475.210495790496, 39673.60326396814, 36190.04161314158, 36789.63210367862, 37771.0, 37841.432378514895, 37901.620983789806, 32715.0, 32928.506072408454, 33980.66019339775, 34156.31687366289, 34278.48582271318, 24552.0, 24673.766311684703, 24948.0, 25192.0, 25590.23229303124], "value": 20148.70832836, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.3697671053091, 355.96440355964404, 365.20932181826356, 383.0595887097177, 394.7256656623646, 16410.671786564275, 20084.698729519052, 20187.09158087886, 20512.35901127908, 21260.681089783626, 19462.902685486588, 19663.0, 20017.099230534626, 20157.496062598442, 20165.294214702488, 5789.160571717099, 5904.793332233373, 6173.783917562886, 6178.011518157095, 6186.84532886677, 5190.71451070191, 5850.736716847752, 5932.525397968152, 5953.255843019622, 5995.6102853314615, 5654.180143879135, 5920.348761636216, 5931.466168044875, 5937.910931336033, 5967.731452084645, 5978.790742324019, 6032.185654936571, 6032.607880487798, 6032.909506357386, 6036.305824830135, 4992.575631071363, 5196.818111366084, 5197.1424714922, 5247.186686063628, 5330.600204984642, 12647.05147113961, 12883.67790805228, 12883.935580322131, 14237.0, 23941.0, 2042.428120126367, 2084.1975839301826, 2089.4671858676093, 2395.6646069550275, 2745.272502786763, 9547.520134379112, 9563.617455301779, 9616.326857120004, 10064.798704025952, 10117.0, 1806.1962426720115, 1864.2915692037075, 1867.9346222882134, 1870.3921225601598, 1918.88486690799, 92271.07728922692, 111505.0, 113497.0, 114457.4277128609, 114467.28299075521, 10788.327809189588, 10947.233693641529, 10977.341359518454, 11218.943905280421, 11372.247158437862, 14072.507462238773, 14073.577792666032, 14079.648008799863, 14084.15495070299, 14089.859101408854, 7979.800504987422, 8012.479188852706, 8161.755147345589, 8260.876086858701, 8300.584970751439, 6574.408303252731, 8104.1085480597085, 8176.3867709922, 8330.791730206673, 8336.416450848383, 4273.124009578091, 4309.956900431018, 4360.819590204897, 4372.562743725602, 4444.377787109807, 1813.9049397945394, 1865.7947625761155, 1871.8408935240384, 1871.9625607487774, 1875.577994951125, 778.7196609220676, 868.162223454357, 879.8768172455862, 894.1728900766894, 935.8455854784021, 15194.772078418833, 19314.55140864441, 20043.59476862786, 20123.7925724457, 20480.38558843237, 866.3502373220085, 879.6525372477836, 937.6202637931513, 941.4774799985937, 974.4932635029745, 9734.902650973541, 10234.437105959094, 10417.218708596885, 10446.63436779709, 10455.581776728846, 507054.46472768136, 513002.0, 516969.0, 603003.0, 609506.0, 118840.40579797045, 125567.21029528028, 128960.3551982234, 129270.35364823116, 129901.0, 938.6573900526396, 969.1326262994721, 1003.8142943555465, 1004.2668851738272, 1006.3408467453829, 15871.444499442465, 18674.0, 18764.87172821977, 18806.435806925812, 18904.810951890857, 39381.2123757529, 41979.37030944477, 47666.52333476621, 50913.72715682138, 54147.729261353445, 57363.0, 57692.0, 74094.14764630927, 76371.0, 76796.84804728045, 6360.809175724736, 7649.97275721923, 7848.7645370638975, 7921.683132674629, 8124.187581241828, 8896.82027903168, 11996.940015300217, 12166.75666486683, 12348.753024939271, 12520.749585008067, 9725.9027409725, 10654.786904262026, 10794.0, 10829.783404332027, 10842.166639257015, 9588.712338629852, 10443.791124177626, 10509.842352364874, 10681.412522311037, 10810.51352689115, 10656.307340022873, 10856.185786065918, 10982.231243813176, 11080.39057851826, 11083.778324433304, 7745.806354841174, 7809.258120478546, 7813.726519571787, 7886.802829929068, 8051.2351326623875, 10339.276250662382, 10685.465726713788, 10849.349039057683, 10896.673099807018, 10981.670549883516], "value": 9063.547209151851, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.6645838540364, 1491.1723993183782, 1506.7890495330653, 1703.2080082761513, 1900.1164458526782, 7808.336291415229, 8276.420650554464, 8640.481571105738, 8896.0, 8923.241524470428, 7492.700291988328, 7601.733939312126, 8721.7819554511, 8726.825463490726, 8824.338174636912, 2377.9881100594516, 2399.472116134448, 2401.0, 2401.9159329423474, 2402.0, 2337.181986304788, 2371.81025517959, 2385.0817435287454, 2385.3678775124517, 2393.293978276404, 2352.5647755165264, 2375.0381095656285, 2383.2016274548046, 2392.940176495593, 2394.365493144318, 2337.49743805081, 2353.788159065684, 2362.208660098869, 2362.929112126622, 2372.205311220726, 2319.431739223884, 2356.681847950539, 2360.433495960957, 2360.799332056777, 2364.609839376501, 7572.0, 8752.081031491729, 8782.560871956377, 8854.424462409923, 8874.890638670166, 5184.377874655028, 5409.9459005409835, 5429.837104886859, 5437.34751829783, 5445.83662490126, 3067.3558552703958, 3483.89548313551, 3708.5735140458924, 3716.1267102230954, 3721.6464435878547, 1042.3224903812506, 1074.215822449616, 1076.7523469601956, 1094.6661268313162, 1098.8241881299034, 11457.083433325313, 11497.540098396054, 11498.712532186679, 11607.941960290145, 11620.593279235187, 4367.323064924942, 4440.955590444119, 4612.031473390559, 4612.607928326062, 4620.353150558924, 7891.329237014918, 8928.508932008672, 9036.412633178823, 9045.864312035324, 9054.818903622023, 5242.370915490089, 5243.239730239094, 5245.868853278698, 5247.2653828464045, 5249.6062795289745, 4147.605977432139, 4406.184855801687, 4561.178987782231, 4577.0, 4927.7536123193695, 3689.409694448875, 3707.5736290326417, 3784.905377365588, 3792.355299599075, 3804.163084121544, 1152.2510368260698, 1158.09089864456, 1160.495184594704, 1171.0924033873816, 1173.7828501727208, 872.6291326186472, 876.3339861705023, 877.1973644115691, 899.5637115998735, 951.1439704266078, 5505.834824955257, 5563.165525171256, 5722.885542289214, 5855.707214639251, 5859.091840764689, 875.4834647557972, 882.2280504558511, 913.0732306708563, 927.5037854747677, 935.6304259817471, 3672.8163591820303, 3725.850965961331, 3811.561670407883, 3833.3291673956946, 3873.2447172801035, 10381.636642717469, 10805.13558915285, 10839.295445795999, 10841.891581084088, 10843.078338341329, 10792.974667406585, 10808.459577021275, 10809.0, 10828.729281768019, 10863.0, 8135.959320203361, 8285.42002059862, 8287.378446616527, 8310.83378332442, 8332.62503187358, 5019.372578427697, 5318.867028324323, 5376.112941364631, 5618.550515958796, 5693.658380497183, 9768.413895166028, 10028.997100290204, 10084.092431681183, 10087.646932357333, 10198.33710808795, 9357.578908948977, 9896.406215627085, 10264.0, 10367.170626350025, 10371.844422333821, 6651.0, 6853.7943861684225, 6905.37851593359, 7152.105986751656, 7172.605506697182, 8255.504669719836, 8283.792905177419, 8291.295239904675, 8367.414281000272, 8370.916290837258, 7492.700291988477, 7545.547267163988, 7586.544807311579, 7634.122075961113, 7661.0, 5798.739056742541, 7088.893666594902, 7314.0, 7376.668049937658, 7499.2500749924575, 6912.274211207952, 7073.71705131789, 7074.823129421599, 7078.646067696697, 7085.6457177141965, 4554.7039442436135, 4687.5781179693995, 4802.919343147763, 4885.682430641997, 4951.257311403318, 4198.769067701183, 4914.533119353656, 4988.875278117931, 5026.371703537058, 5058.1654027085115], "value": 4498.470600614551, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.93912747886685, 300.07576663875255, 304.9600861063772, 312.0902569011332, 315.92101974506375, 5162.889978654589, 5213.504717051874, 5240.711760853156, 5250.186221135726, 5259.474052594738, 4782.258749893772, 4882.216282381157, 4883.389576302962, 4940.802367905279, 5083.517065878736, 3341.63242043375, 3439.29494453637, 4000.399940008993, 4016.4376987221813, 4054.2904991626497, 4001.8799436016966, 4010.9398359024494, 4012.217617564576, 4035.4148648445957, 4042.8584999524874, 3830.291396091718, 3863.3818589025764, 3924.2936271471126, 3992.4610177626087, 4000.3799411091327, 3370.5338177892695, 3493.8602455901732, 3984.203159368138, 4005.9584508027833, 4009.759414435114, 3468.5664291963503, 3483.4774783782636, 3486.442169252907, 3494.5631796025496, 3528.435450327935, 4521.660875434355, 4803.0, 5093.719845408501, 5112.463191364927, 5134.358205224347, 3818.4344418788164, 4322.697411181219, 4595.977020114911, 4605.930911036337, 4632.166210082184, 5448.45515448456, 5479.4520547944885, 5481.314835645544, 5497.505224529811, 5519.530839878575, 3816.637419445148, 3838.769673819552, 3878.301905657009, 3884.6892248620043, 3891.649751522348, 4749.7387643679585, 5444.265024221719, 5720.313562372542, 5727.737543670269, 5786.855328616776, 3873.4577159197734, 3888.891665875212, 3897.2205558888336, 3912.256671232457, 3915.8086159779687, 3352.1619595101224, 3963.9009024774036, 3968.9603103969166, 3971.62269584389, 3978.6817054635558, 4200.432941552851, 4455.576720211575, 4569.527159358845, 4570.451545814523, 4581.610563102174, 4496.96454892946, 4805.639577031667, 4938.209886418156, 5395.541378982752, 5513.448655134534, 1298.3248710670398, 1327.2169420042221, 1331.7003674173234, 1332.4936524120965, 1334.1728128560355, 832.7376876284072, 853.8078932240196, 854.43607219235, 867.7266661001764, 886.9512176830207, 4775.617950563947, 5133.178691409431, 5138.3833939927445, 5153.634286913971, 5153.768080436389, 4946.911679430519, 5642.774289028475, 5663.0, 5670.688112153789, 5673.546116310686, 4282.978585107055, 4553.0, 4746.501617330199, 5111.642185047011, 5123.129068058439, 2392.33732555872, 2896.956545651817, 2935.882564697431, 2938.338873753431, 2946.6758656547763, 5480.588955828329, 5795.94204057954, 5813.110739009839, 5820.185174075633, 5825.611499285273, 4961.82633607822, 5552.194931734876, 5811.128330750421, 5889.793857215062, 5894.823155305347, 5659.651244733472, 5907.6959985605645, 5959.582829201914, 5997.820065398045, 6060.939390606214, 4467.900086959124, 5475.8500714850325, 5530.474604912527, 5726.541876649775, 5788.6526808389945, 5660.575456840836, 5672.262605861211, 5677.602567820378, 5691.430856914276, 5691.886162276648, 5206.401263854706, 5511.807086751945, 5928.79249226275, 5950.494207992369, 6000.0, 3064.5249986252165, 3568.5555394554813, 3650.3429382711365, 3682.0610744260043, 3840.137533296293, 4953.157963146202, 5776.566757493289, 5793.856273178951, 5794.478496935296, 5826.329972053099, 4942.1598328285, 5461.617686761889, 5670.914936276042, 5685.175649530712, 5688.459596338341, 4679.929801052919, 5261.368975617571, 5340.118880384848, 5555.944440555542, 5583.2871140692605, 4549.977250113729, 5176.842126303028, 5440.319960004999, 5492.423295553909, 5501.367342755634, 4645.581897629229, 5252.369715634149, 5342.973285133549, 5458.208559758892, 5545.197810711455, 4225.408442817947, 5083.415407228216, 5226.63413561047, 5418.83743487696, 5430.755615997368], "value": 4028.7793703444304, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.6645426967921, 707.9681414336354, 743.0674503498109, 804.3565147881693, 816.5264146794859, 15675.216239188023, 15964.920175399122, 16294.83705162948, 16352.345906163753, 16719.582010449743, 14576.344064517096, 14647.487337943174, 14677.192754398504, 14683.559493215194, 14717.558473245794, 667.0960848050894, 686.1526015371013, 691.9135108111486, 837.4556538250125, 838.6226198210799, 848.775074605227, 862.3790870573177, 866.9653213871469, 869.4479005831311, 871.1245198575423, 913.0002647101413, 914.6661468563959, 914.8581969794692, 915.8671992561108, 919.4437365393941, 721.6283613938825, 740.8259059121102, 915.9221466175383, 916.3173435790345, 916.812053529025, 659.5943494750694, 676.6751959059679, 679.2460368990417, 680.7379159023762, 681.1213534540437, 15382.307796149089, 15409.075455472595, 15411.306491207923, 15421.691566168614, 15487.767683484757, 13826.30868456573, 14061.929690351584, 14191.503297384645, 14253.643658908506, 14376.209308488029, 12664.240145591202, 12783.424745886457, 12783.61649150527, 13008.414621342063, 13406.329683515785, 3926.088930804431, 4482.372467854503, 4595.287730401793, 4601.700889442175, 4669.976650116761, 111739.44130279297, 113542.0, 114789.0, 116793.4160329193, 116840.41579792046, 11058.726096218723, 11096.500657470433, 11136.832947505794, 11194.440277986068, 11506.712332191762, 18934.715979260323, 22503.549929001656, 22568.322950311187, 22589.87050647461, 22609.773902260767, 7978.680852765824, 8005.039395272488, 8011.839763204704, 8038.954935858301, 8159.877601835978, 4390.07808360248, 4399.23013472641, 4446.844360447369, 4485.147821913826, 4588.151192029485, 3512.104413374573, 3629.927401451956, 3631.782093074371, 3631.891043268706, 3639.745217834726, 537.5941164420838, 647.7700416352221, 657.0833687006694, 657.135866335767, 657.2540166910591, 583.8423625621059, 600.9819705408845, 614.8401415631879, 637.8309747916805, 645.4094503529218, 7827.882581761278, 8636.568171591522, 9082.0, 9232.90767092334, 9302.86045709315, 589.3369958796354, 591.4115455122181, 620.8354785981718, 625.3951944356602, 640.8846407646575, 4469.575390337913, 4477.462704475483, 4478.686491945533, 4519.141363140992, 4568.803591268959, 97096.51451742696, 119354.0, 135121.6487835109, 158756.0, 159372.0, 130184.0, 130627.0, 136281.6371836289, 137036.0, 138289.0, 73153.6342318285, 74025.0, 75291.62354188194, 75357.62321188468, 92020.0, 7505.136909255287, 8564.272036876686, 8668.91331086681, 8746.562671866508, 8990.32572557074, 41232.38151427671, 54363.45636543584, 56143.71928140333, 56703.0, 62601.0, 80130.59934700289, 85635.57182214299, 86953.0, 87731.56134219289, 89525.55237223773, 11040.779184416106, 12848.229106253655, 13273.601791946257, 13542.458301667823, 13894.23581703016, 14750.188739619423, 14908.925455372653, 15056.397744090114, 15149.0, 15559.377624894878, 14089.577312680636, 14143.929280353532, 14240.359183836545, 14283.857161428252, 14522.85477145215, 13425.530106446227, 13857.584272471842, 13902.860971390157, 13947.4421023162, 14360.856391435951, 13349.733005340033, 13474.52839150625, 13560.321983900569, 13906.165630062229, 14292.785608216092, 9837.803243935225, 11265.943670281596, 11278.0, 11512.0, 11690.590829321272, 11280.435978201222, 11374.658760237206, 11379.431028448378, 11598.594049208237, 11621.0], "value": 7738.643501960346, "unit": "score"}], "name": "dromaeo_css", "value": 7240.356634285546, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 115.0, 115.0, 114.0, 114.0, 114.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 94.0, 110.0, 170.0, 141.0, 139.0, 111.0, 108.0, 143.0, 108.0], "value": 127.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 196.0, 215.0, 186.0, 183.0, 184.0, 180.0, 183.0, 183.0], "value": 187.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 63.0, 75.0, 112.0, 83.0, 72.0, 59.0, 59.0, 79.0, 57.0], "value": 74.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 91.0, 71.0, 69.0, 69.0, 91.0, 67.0, 68.0, 89.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 90.0, 129.0, 88.0, 83.0, 88.0, 84.0, 86.0, 87.0], "value": 90.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 93.0, 94.0, 94.0, 94.0, 93.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 84.0, 85.0, 86.0, 84.0, 86.0, 86.0, 84.0, 84.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 53.0, 53.0, 53.0, 54.0, 56.0, 54.0, 54.0, 53.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 69.0, 76.0, 71.0, 70.0, 68.0, 70.0, 71.0, 70.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 84.0, 91.0, 101.0, 101.0, 102.0, 79.0, 87.0, 91.0], "value": 91.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 138.0, 138.0, 139.0, 146.0, 149.0, 133.0, 161.0, 243.0, 150.0], "value": 153.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 166.0, 167.0, 170.0, 170.0, 164.0, 169.0, 167.0, 168.0, 167.0], "value": 167.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 67.0, 69.0, 68.0, 67.0, 68.0, 65.0, 68.0, 66.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1454.9, "alertThreshold": 2.0}]} 00:35:47 INFO - Return code: 0 00:35:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:35:47 INFO - # TBPL SUCCESS # 00:35:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:35:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:35:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:35:47 INFO - 2016-09-30 00:35:47.815 screenresolution[1684:10885] starting screenresolution argv=screenresolution get 00:35:47 INFO - 2016-09-30 00:35:47.818 screenresolution[1684:10885] Display 0: 1600x1200x32@60 00:35:47 INFO - 2016-09-30 00:35:47.825 screenresolution[1685:10888] starting screenresolution argv=screenresolution list 00:35:47 INFO - Available Modes on Display 0 00:35:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:35:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:35:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:35:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:35:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:35:48 INFO - Intel Iris: 00:35:48 INFO - Chipset Model: Intel Iris 00:35:48 INFO - Type: GPU 00:35:48 INFO - Bus: Built-In 00:35:48 INFO - VRAM (Dynamic, Max): 1536 MB 00:35:48 INFO - Vendor: Intel (0x8086) 00:35:48 INFO - Device ID: 0x0a2e 00:35:48 INFO - Revision ID: 0x0009 00:35:48 INFO - Displays: 00:35:48 INFO - Display: 00:35:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:35:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:35:48 INFO - Display Serial Number: 1600x1200 60 00:35:48 INFO - Main Display: Yes 00:35:48 INFO - Mirror: Off 00:35:48 INFO - Online: Yes 00:35:48 INFO - Rotation: Supported 00:35:48 INFO - Return code: 0 00:35:48 INFO - Running post-action listener: _resource_record_post_action 00:35:48 INFO - [mozharness: 2016-09-30 07:35:48.063886Z] Finished run-tests step (success) 00:35:48 INFO - Running post-run listener: _resource_record_post_run 00:35:48 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 32005120; Write bytes: 708332544; Read time: 196; Write time: 1994 00:35:48 INFO - TinderboxPrint: CPU usage
53.6% 00:35:48 INFO - TinderboxPrint: I/O read bytes / time
32,005,120 / 196 00:35:48 INFO - TinderboxPrint: I/O write bytes / time
708,332,544 / 1,994 00:35:48 INFO - TinderboxPrint: CPU idle
2,252.1 (46.4%) 00:35:48 INFO - TinderboxPrint: CPU system
972.9 (20.0%) 00:35:48 INFO - TinderboxPrint: CPU user
1,628.7 (33.6%) 00:35:48 INFO - TinderboxPrint: Swap in / out
435,982,336 / 0 00:35:48 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 391649792; Write bytes: 387693056; Read time: 29478; Write time: 821 00:35:48 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 31079424; Write bytes: 296374784; Read time: 185; Write time: 1119 00:35:48 INFO - Running post-run listener: _upload_blobber_files 00:35:48 INFO - Blob upload gear active. 00:35:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:35:48 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 00:35:48 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:35:48 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:35:48 INFO - (blobuploader) - INFO - Open directory for files ... 00:35:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:35:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:35:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:35:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:35:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:35:50 INFO - (blobuploader) - INFO - Done attempting. 00:35:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:35:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:35:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:35:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:35:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:35:52 INFO - (blobuploader) - INFO - Done attempting. 00:35:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:35:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:35:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:35:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:35:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:35:55 INFO - (blobuploader) - INFO - Done attempting. 00:35:55 INFO - (blobuploader) - INFO - Iteration through files over. 00:35:55 INFO - Return code: 0 00:35:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:35:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:35:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b25ef0ef5f552a3783588e9d2473b656c9e7808eb85557af5e79c9b94ac1a9fd8873f928d67e08fd901b7d91f1d87a901f94a08d8e1353b4dfca0a5c45805916", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f492f34e27741142fd5606b951c8044c7aa10a2adab66d955162376b28f6c51dc977d01800777c82b88e14767961561d2d76a3c67ed6dd8a22896e2a336e8b15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c477008b83fa2f6336e26d34cb3b7fff5296ac04a0e6af29928357efc7ba9e8c929f77f2e9f5270abfe2df62e70f317e9e023a0234df4a86ded282b625da7351"} 00:35:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:35:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:35:55 INFO - Contents: 00:35:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b25ef0ef5f552a3783588e9d2473b656c9e7808eb85557af5e79c9b94ac1a9fd8873f928d67e08fd901b7d91f1d87a901f94a08d8e1353b4dfca0a5c45805916", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f492f34e27741142fd5606b951c8044c7aa10a2adab66d955162376b28f6c51dc977d01800777c82b88e14767961561d2d76a3c67ed6dd8a22896e2a336e8b15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c477008b83fa2f6336e26d34cb3b7fff5296ac04a0e6af29928357efc7ba9e8c929f77f2e9f5270abfe2df62e70f317e9e023a0234df4a86ded282b625da7351"} 00:35:55 INFO - Running post-run listener: copy_logs_to_upload_dir 00:35:55 INFO - Copying logs to upload dir... 00:35:55 INFO - mkdir: /builds/slave/test/build/upload/logs 00:35:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.304735 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-09-30 00:35:55.410552) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 00:35:55.414389) ========= 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.bNftBeQssC/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.wzUQD9EyEN/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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/Fx-Team/sha512/b25ef0ef5f552a3783588e9d2473b656c9e7808eb85557af5e79c9b94ac1a9fd8873f928d67e08fd901b7d91f1d87a901f94a08d8e1353b4dfca0a5c45805916", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f492f34e27741142fd5606b951c8044c7aa10a2adab66d955162376b28f6c51dc977d01800777c82b88e14767961561d2d76a3c67ed6dd8a22896e2a336e8b15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c477008b83fa2f6336e26d34cb3b7fff5296ac04a0e6af29928357efc7ba9e8c929f77f2e9f5270abfe2df62e70f317e9e023a0234df4a86ded282b625da7351"} build_url:https://queue.taskcluster.net/v1/task/Sgxj9AGYRXeMR0GmZ0dW4Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010557 build_url: 'https://queue.taskcluster.net/v1/task/Sgxj9AGYRXeMR0GmZ0dW4Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b25ef0ef5f552a3783588e9d2473b656c9e7808eb85557af5e79c9b94ac1a9fd8873f928d67e08fd901b7d91f1d87a901f94a08d8e1353b4dfca0a5c45805916", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f492f34e27741142fd5606b951c8044c7aa10a2adab66d955162376b28f6c51dc977d01800777c82b88e14767961561d2d76a3c67ed6dd8a22896e2a336e8b15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c477008b83fa2f6336e26d34cb3b7fff5296ac04a0e6af29928357efc7ba9e8c929f77f2e9f5270abfe2df62e70f317e9e023a0234df4a86ded282b625da7351"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 00:35:55.451955) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 00:35:55.452748) ========= 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.bNftBeQssC/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.wzUQD9EyEN/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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.005188 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 00:35:55.504590) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 00:35:55.507952) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 00:35:55.508302) ========= ========= Total master_lag: 0.19 =========