builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0180 starttime: 1472118156.96 results: success (0) buildid: 20160825004426 builduid: f6e32a7d45a04d35a2ab8bed69d25b85 revision: 93f1020581a744c085bad89986db32dabb0339bf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 02:42:36.965556) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 02:42:36.966035) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 02:42:36.966321) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 02:42:37.028873) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 02:42:37.029238) ========= 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.Z4liThkLnR/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.cmH2V0LtpX/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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-08-25 02:42:37-- 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% 41.6M=0s 2016-08-25 02:42:37 (41.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164149 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 02:42:37.217455) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 02:42:37.217864) ========= 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.Z4liThkLnR/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.cmH2V0LtpX/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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.027172 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 02:42:37.266797) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-25 02:42:37.267174) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 93f1020581a744c085bad89986db32dabb0339bf --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 93f1020581a744c085bad89986db32dabb0339bf --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Z4liThkLnR/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.cmH2V0LtpX/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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-08-25 02:42:37,343 truncating revision to first 12 chars 2016-08-25 02:42:37,343 Setting DEBUG logging. 2016-08-25 02:42:37,343 attempt 1/10 2016-08-25 02:42:37,343 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/93f1020581a7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-25 02:42:38,489 unpacking tar archive at: autoland-93f1020581a7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.398111 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-25 02:42:38.687791) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 02:42:38.688105) ========= script_repo_revision: 93f1020581a744c085bad89986db32dabb0339bf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 02:42:38.688532) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 02:42:38.688839) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 02:42:38.709514) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 8 secs) (at 2016-08-25 02:42:38.709920) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Z4liThkLnR/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.cmH2V0LtpX/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 02:42:38 INFO - MultiFileLogger online at 20160825 02:42:38 in /builds/slave/test 02:42:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 02:42:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:42:38 INFO - {'append_to_log': False, 02:42:38 INFO - 'base_work_dir': '/builds/slave/test', 02:42:38 INFO - 'blob_upload_branch': 'Autoland', 02:42:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:42:38 INFO - 'branch': 'Autoland', 02:42:38 INFO - 'buildbot_json_path': 'buildprops.json', 02:42:38 INFO - 'config_files': ('talos/mac_config.py',), 02:42:38 INFO - 'default_actions': ('clobber', 02:42:38 INFO - 'read-buildbot-config', 02:42:38 INFO - 'download-and-extract', 02:42:38 INFO - 'populate-webroot', 02:42:38 INFO - 'create-virtualenv', 02:42:38 INFO - 'install', 02:42:38 INFO - 'run-tests'), 02:42:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:42:38 INFO - 'download_minidump_stackwalk': True, 02:42:38 INFO - 'download_symbols': 'ondemand', 02:42:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:42:38 INFO - 'tooltool.py': '/tools/tooltool.py', 02:42:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:42:38 INFO - '/tools/misc-python/virtualenv.py')}, 02:42:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:42:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:42:38 INFO - 'installer_path': 'installer.exe', 02:42:38 INFO - 'log_level': 'info', 02:42:38 INFO - 'log_name': 'talos', 02:42:38 INFO - 'log_to_console': True, 02:42:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:42:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:42:38 INFO - 'opt_config_files': (), 02:42:38 INFO - 'pip_index': False, 02:42:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:42:38 INFO - 'cmd': ('bash', 02:42:38 INFO - '-c', 02:42:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:42:38 INFO - 'enabled': True, 02:42:38 INFO - 'halt_on_failure': False, 02:42:38 INFO - 'name': 'check_screen_resolution'},), 02:42:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:42:38 INFO - 'cmd': ('bash', 02:42:38 INFO - '-c', 02:42:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:42:38 INFO - 'enabled': True, 02:42:38 INFO - 'halt_on_failure': False, 02:42:38 INFO - 'name': 'check_screen_resolution'},), 02:42:38 INFO - 'run_cmd_checks_enabled': True, 02:42:38 INFO - 'sps_profile': False, 02:42:38 INFO - 'sps_profile_interval': 0, 02:42:38 INFO - 'suite': 'dromaeojs', 02:42:38 INFO - 'system_bits': '32', 02:42:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:42:38 INFO - 'title': 't-yosemite-r7-0180', 02:42:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:42:38 INFO - 'use_talos_json': True, 02:42:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:42:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:42:38 INFO - 'work_dir': 'build'} 02:42:38 INFO - [mozharness: 2016-08-25 09:42:38.908959Z] Running clobber step. 02:42:38 INFO - Running pre-action listener: _resource_record_pre_action 02:42:38 INFO - Running main action method: clobber 02:42:38 INFO - rmtree: /builds/slave/test/build 02:42:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:42:41 INFO - Running post-action listener: _resource_record_post_action 02:42:41 INFO - [mozharness: 2016-08-25 09:42:41.041448Z] Finished clobber step (success) 02:42:41 INFO - [mozharness: 2016-08-25 09:42:41.041612Z] Running read-buildbot-config step. 02:42:41 INFO - Running pre-action listener: _resource_record_pre_action 02:42:41 INFO - Running main action method: read_buildbot_config 02:42:41 INFO - Using buildbot properties: 02:42:41 INFO - { 02:42:41 INFO - "project": "", 02:42:41 INFO - "product": "firefox", 02:42:41 INFO - "script_repo_revision": "production", 02:42:41 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 02:42:41 INFO - "repository": "", 02:42:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 02:42:41 INFO - "buildid": "20160825004426", 02:42:41 INFO - "pgo_build": "False", 02:42:41 INFO - "basedir": "/builds/slave/test", 02:42:41 INFO - "buildnumber": 141, 02:42:41 INFO - "slavename": "t-yosemite-r7-0180", 02:42:41 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:42:41 INFO - "platform": "yosemite_r7", 02:42:41 INFO - "scheduler": "tests-autoland-macosx64-talos", 02:42:41 INFO - "branch": "autoland", 02:42:41 INFO - "repo_path": "integration/autoland", 02:42:41 INFO - "revision": "93f1020581a744c085bad89986db32dabb0339bf", 02:42:41 INFO - "stage_platform": "macosx64", 02:42:41 INFO - "builduid": "f6e32a7d45a04d35a2ab8bed69d25b85", 02:42:41 INFO - "slavebuilddir": "test" 02:42:41 INFO - } 02:42:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/bMagraWMTKWjs4tOXJ9r3g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 02:42:41 INFO - Running post-action listener: _resource_record_post_action 02:42:41 INFO - [mozharness: 2016-08-25 09:42:41.046931Z] Finished read-buildbot-config step (success) 02:42:41 INFO - [mozharness: 2016-08-25 09:42:41.047108Z] Running download-and-extract step. 02:42:41 INFO - Running pre-action listener: _resource_record_pre_action 02:42:41 INFO - Running main action method: download_and_extract 02:42:41 INFO - mkdir: /builds/slave/test/build/tests 02:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:41 INFO - trying https://queue.taskcluster.net/v1/task/bMagraWMTKWjs4tOXJ9r3g/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 02:42:41 INFO - Downloading https://queue.taskcluster.net/v1/task/bMagraWMTKWjs4tOXJ9r3g/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 02:42:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bMagraWMTKWjs4tOXJ9r3g/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 02:42:41 INFO - Downloaded 1199 bytes. 02:42:41 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 02:42:41 INFO - Using the following test package requirements: 02:42:41 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 02:42:41 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:42:41 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 02:42:41 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:42:41 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 02:42:41 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:42:41 INFO - u'jsshell-mac.zip'], 02:42:41 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:42:41 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 02:42:41 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 02:42:41 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:42:41 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 02:42:41 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:42:41 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 02:42:41 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:42:41 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 02:42:41 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:42:41 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 02:42:41 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:41 INFO - trying https://queue.taskcluster.net/v1/task/bMagraWMTKWjs4tOXJ9r3g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 02:42:41 INFO - Downloading https://queue.taskcluster.net/v1/task/bMagraWMTKWjs4tOXJ9r3g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 02:42:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bMagraWMTKWjs4tOXJ9r3g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:42:42 INFO - Downloaded 16345857 bytes. 02:42:42 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 02:42:49 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 02:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:49 INFO - trying https://queue.taskcluster.net/v1/task/bMagraWMTKWjs4tOXJ9r3g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 02:42:49 INFO - Downloading https://queue.taskcluster.net/v1/task/bMagraWMTKWjs4tOXJ9r3g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 02:42:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bMagraWMTKWjs4tOXJ9r3g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:42:50 INFO - Downloaded 16345857 bytes. 02:42:50 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 02:42: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')]} 02:42:57 INFO - trying https://queue.taskcluster.net/v1/task/bMagraWMTKWjs4tOXJ9r3g/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 02:42:57 INFO - Downloading https://queue.taskcluster.net/v1/task/bMagraWMTKWjs4tOXJ9r3g/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 02:42:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bMagraWMTKWjs4tOXJ9r3g/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:42:58 INFO - Downloaded 14413981 bytes. 02:42:58 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 02:42:58 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')]} 02:42:58 INFO - trying https://queue.taskcluster.net/v1/task/bMagraWMTKWjs4tOXJ9r3g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 02:42:58 INFO - Downloading https://queue.taskcluster.net/v1/task/bMagraWMTKWjs4tOXJ9r3g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 02:42:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bMagraWMTKWjs4tOXJ9r3g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 02:43:01 INFO - Downloaded 111454697 bytes. 02:43:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bMagraWMTKWjs4tOXJ9r3g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 02:43:01 INFO - mkdir: /builds/slave/test/properties 02:43:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:43:01 INFO - Writing to file /builds/slave/test/properties/build_url 02:43:01 INFO - Contents: 02:43:01 INFO - build_url:https://queue.taskcluster.net/v1/task/bMagraWMTKWjs4tOXJ9r3g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 02:43:02 INFO - Running post-action listener: _resource_record_post_action 02:43:02 INFO - Running post-action listener: set_extra_try_arguments 02:43:02 INFO - [mozharness: 2016-08-25 09:43:02.430850Z] Finished download-and-extract step (success) 02:43:02 INFO - [mozharness: 2016-08-25 09:43:02.430963Z] Running populate-webroot step. 02:43:02 INFO - Running pre-action listener: _resource_record_pre_action 02:43:02 INFO - Running main action method: populate_webroot 02:43:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:43:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:43:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:43:02 INFO - '--tppagecycles', 02:43:02 INFO - '7'], 02:43:02 INFO - 'tests': ['tsvgm']}}, 02:43:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:43:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:43:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:43:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:43:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:43:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:43:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:43:02 INFO - 'talos_options': ['--disable-e10s'], 02:43:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:43:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:43:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:43:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:43:02 INFO - 'talos_options': ['--disable-e10s'], 02:43:02 INFO - 'tests': ['damp', 'tps']}, 02:43:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:43:02 INFO - 'tests': ['damp', 'tps']}, 02:43:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:43:02 INFO - 'tests': ['dromaeo_dom']}, 02:43:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:43:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:43:02 INFO - 'tests': ['basic_compositor_video']}, 02:43:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:43:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:43:02 INFO - 'tests': ['a11yr', 02:43:02 INFO - 'ts_paint', 02:43:02 INFO - 'tpaint', 02:43:02 INFO - 'sessionrestore', 02:43:02 INFO - 'sessionrestore_no_auto_restore', 02:43:02 INFO - 'tabpaint']}, 02:43:02 INFO - 'other-e10s': {'tests': ['a11yr', 02:43:02 INFO - 'ts_paint', 02:43:02 INFO - 'tpaint', 02:43:02 INFO - 'sessionrestore', 02:43:02 INFO - 'sessionrestore_no_auto_restore', 02:43:02 INFO - 'tabpaint']}, 02:43:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:43:02 INFO - 'ts_paint', 02:43:02 INFO - 'tpaint', 02:43:02 INFO - 'sessionrestore', 02:43:02 INFO - 'sessionrestore_no_auto_restore', 02:43:02 INFO - 'tabpaint']}, 02:43:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:43:02 INFO - 'ts_paint', 02:43:02 INFO - 'tpaint', 02:43:02 INFO - 'sessionrestore', 02:43:02 INFO - 'sessionrestore_no_auto_restore', 02:43:02 INFO - 'tabpaint']}, 02:43:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:43:02 INFO - 'tests': ['a11yr', 02:43:02 INFO - 'ts_paint', 02:43:02 INFO - 'tpaint', 02:43:02 INFO - 'sessionrestore', 02:43:02 INFO - 'sessionrestore_no_auto_restore', 02:43:02 INFO - 'tabpaint']}, 02:43:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:43:02 INFO - 'tests': ['a11yr', 02:43:02 INFO - 'ts_paint', 02:43:02 INFO - 'tpaint', 02:43:02 INFO - 'sessionrestore', 02:43:02 INFO - 'sessionrestore_no_auto_restore', 02:43:02 INFO - 'tabpaint']}, 02:43:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:43:02 INFO - 'tests': ['tsvgx', 02:43:02 INFO - 'tsvgr_opacity', 02:43:02 INFO - 'tart', 02:43:02 INFO - 'tscrollx', 02:43:02 INFO - 'cart']}, 02:43:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:43:02 INFO - 'tsvgr_opacity', 02:43:02 INFO - 'tart', 02:43:02 INFO - 'tscrollx', 02:43:02 INFO - 'cart']}, 02:43:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:43:02 INFO - 'talos_options': ['--disable-e10s'], 02:43:02 INFO - 'tests': ['tp5o']}, 02:43:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:43:02 INFO - 'tests': ['tp5o']}, 02:43:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:43:02 INFO - 'talos_options': ['--disable-e10s', 02:43:02 INFO - '--xperf_path', 02:43:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:43:02 INFO - 'tests': ['tp5n']}, 02:43:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:43:02 INFO - 'talos_options': ['--xperf_path', 02:43:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:43:02 INFO - 'tests': ['tp5n']}}, 02:43:02 INFO - 'talos.zip': {'path': '', 02:43:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:43:02 INFO - Running post-action listener: _resource_record_post_action 02:43:02 INFO - [mozharness: 2016-08-25 09:43:02.449470Z] Finished populate-webroot step (success) 02:43:02 INFO - [mozharness: 2016-08-25 09:43:02.449602Z] Running create-virtualenv step. 02:43:02 INFO - Running pre-action listener: _resource_record_pre_action 02:43:02 INFO - Running main action method: create_virtualenv 02:43:02 INFO - Creating virtualenv /builds/slave/test/build/venv 02:43:02 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 02:43:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:43:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:43:02 INFO - Using real prefix '/tools/python27' 02:43:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:43:03 INFO - Installing distribute.............................................................................................................................................................................................done. 02:43:06 INFO - Installing pip.................done. 02:43:06 INFO - Return code: 0 02:43:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:43:06 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')]} 02:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:06 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')]} 02:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:06 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 0x105de3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e78618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e93d6a0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d47d30>, '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 0x105aacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d3fb20>, '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.Z4liThkLnR/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.cmH2V0LtpX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 02:43:06 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 02:43:06 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 02:43:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4liThkLnR/Render', 02:43:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:43:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:43:06 INFO - 'HOME': '/Users/cltbld', 02:43:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:43:06 INFO - 'LOGNAME': 'cltbld', 02:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:06 INFO - 'MOZ_NO_REMOTE': '1', 02:43:06 INFO - 'NO_EM_RESTART': '1', 02:43:06 INFO - 'PAGER': '/bin/cat', 02:43:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:06 INFO - 'PWD': '/builds/slave/test', 02:43:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:43:06 INFO - 'SHELL': '/bin/bash', 02:43:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cmH2V0LtpX/Listeners', 02:43:06 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 02:43:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:43:06 INFO - 'USER': 'cltbld', 02:43:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:43:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:06 INFO - 'XPC_FLAGS': '0x0', 02:43:06 INFO - 'XPC_SERVICE_NAME': '0', 02:43:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:06 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 02:43:06 INFO - Cleaning up... 02:43:06 INFO - Return code: 0 02:43:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:43:06 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')]} 02:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:06 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')]} 02:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:06 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 0x105de3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e78618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e93d6a0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d47d30>, '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 0x105aacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d3fb20>, '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.Z4liThkLnR/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.cmH2V0LtpX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 02:43:06 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 02:43:06 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 02:43:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4liThkLnR/Render', 02:43:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:43:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:43:06 INFO - 'HOME': '/Users/cltbld', 02:43:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:43:06 INFO - 'LOGNAME': 'cltbld', 02:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:06 INFO - 'MOZ_NO_REMOTE': '1', 02:43:06 INFO - 'NO_EM_RESTART': '1', 02:43:06 INFO - 'PAGER': '/bin/cat', 02:43:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:06 INFO - 'PWD': '/builds/slave/test', 02:43:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:43:06 INFO - 'SHELL': '/bin/bash', 02:43:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cmH2V0LtpX/Listeners', 02:43:06 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 02:43:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:43:06 INFO - 'USER': 'cltbld', 02:43:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:43:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:06 INFO - 'XPC_FLAGS': '0x0', 02:43:06 INFO - 'XPC_SERVICE_NAME': '0', 02:43:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:06 INFO - Downloading/unpacking psutil>=3.1.1 02:43:06 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 02:43:06 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 02:43:06 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 02:43:06 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 02:43:06 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 02:43:06 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 02:43:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:43:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:43:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:43:10 INFO - Installing collected packages: psutil 02:43:10 INFO - Running setup.py install for psutil 02:43:10 INFO - building 'psutil._psutil_osx' extension 02:43: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_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:43:11 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 02:43:11 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 02:43:11 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 02:43:11 INFO - building 'psutil._psutil_posix' extension 02:43:11 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 02:43:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:43:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:43:11 INFO - ^ 02:43:11 INFO - 1 warning generated. 02:43:11 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 02:43:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:43:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:43:11 INFO - Successfully installed psutil 02:43:11 INFO - Cleaning up... 02:43:11 INFO - Return code: 0 02:43:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:43:11 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')]} 02:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:11 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')]} 02:43:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:11 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 0x105de3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e78618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e93d6a0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d47d30>, '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 0x105aacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d3fb20>, '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.Z4liThkLnR/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.cmH2V0LtpX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 02:43:11 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 02:43:11 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 02:43:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4liThkLnR/Render', 02:43:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:43:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:43:11 INFO - 'HOME': '/Users/cltbld', 02:43:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:43:11 INFO - 'LOGNAME': 'cltbld', 02:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:11 INFO - 'MOZ_NO_REMOTE': '1', 02:43:11 INFO - 'NO_EM_RESTART': '1', 02:43:11 INFO - 'PAGER': '/bin/cat', 02:43:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:43:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:11 INFO - 'PWD': '/builds/slave/test', 02:43:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:43:11 INFO - 'SHELL': '/bin/bash', 02:43:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cmH2V0LtpX/Listeners', 02:43:11 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 02:43:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:43:11 INFO - 'USER': 'cltbld', 02:43:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:43:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:11 INFO - 'XPC_FLAGS': '0x0', 02:43:11 INFO - 'XPC_SERVICE_NAME': '0', 02:43:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:43:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:43:11 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 02:43:11 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 02:43:11 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 02:43:11 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 02:43:11 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 02:43:11 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 02:43:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:43:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:43:14 INFO - Installing collected packages: mozsystemmonitor 02:43:14 INFO - Running setup.py install for mozsystemmonitor 02:43:14 INFO - Successfully installed mozsystemmonitor 02:43:14 INFO - Cleaning up... 02:43:14 INFO - Return code: 0 02:43:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:43:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105de3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e78618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e93d6a0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d47d30>, '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 0x105aacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d3fb20>, '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.Z4liThkLnR/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.cmH2V0LtpX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 02:43:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:43:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:43:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4liThkLnR/Render', 02:43:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:43:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:43:14 INFO - 'HOME': '/Users/cltbld', 02:43:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:43:14 INFO - 'LOGNAME': 'cltbld', 02:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:14 INFO - 'MOZ_NO_REMOTE': '1', 02:43:14 INFO - 'NO_EM_RESTART': '1', 02:43:14 INFO - 'PAGER': '/bin/cat', 02:43:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:14 INFO - 'PWD': '/builds/slave/test', 02:43:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:43:14 INFO - 'SHELL': '/bin/bash', 02:43:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cmH2V0LtpX/Listeners', 02:43:14 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 02:43:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:43:14 INFO - 'USER': 'cltbld', 02:43:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:43:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:14 INFO - 'XPC_FLAGS': '0x0', 02:43:14 INFO - 'XPC_SERVICE_NAME': '0', 02:43:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:43:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:14 INFO - Downloading/unpacking jsonschema==2.5.1 02:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:43:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:43:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:43:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:43:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:43:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:43:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:43: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 02:43: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 02:43: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 02:43: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 02:43: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 02:43: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 02:43:17 INFO - Downloading functools32-3.2.3-2.tar.gz 02:43:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:43:17 INFO - warning: no files found matching '*.txt' 02:43:17 INFO - no previously-included directories found matching 'build' 02:43:17 INFO - no previously-included directories found matching 'dist' 02:43:17 INFO - no previously-included directories found matching '.git*' 02:43:17 INFO - Installing collected packages: jsonschema, functools32 02:43:17 INFO - Running setup.py install for functools32 02:43:17 INFO - warning: no files found matching '*.txt' 02:43:17 INFO - no previously-included directories found matching 'build' 02:43:17 INFO - no previously-included directories found matching 'dist' 02:43:17 INFO - no previously-included directories found matching '.git*' 02:43:17 INFO - Successfully installed jsonschema functools32 02:43:17 INFO - Cleaning up... 02:43:18 INFO - Return code: 0 02:43:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:43:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:18 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 0x105de3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e78618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e93d6a0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d47d30>, '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 0x105aacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d3fb20>, '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.Z4liThkLnR/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.cmH2V0LtpX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 02:43:18 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 02:43:18 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 02:43:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4liThkLnR/Render', 02:43:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:43:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:43:18 INFO - 'HOME': '/Users/cltbld', 02:43:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:43:18 INFO - 'LOGNAME': 'cltbld', 02:43:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:18 INFO - 'MOZ_NO_REMOTE': '1', 02:43:18 INFO - 'NO_EM_RESTART': '1', 02:43:18 INFO - 'PAGER': '/bin/cat', 02:43:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:43:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:18 INFO - 'PWD': '/builds/slave/test', 02:43:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:43:18 INFO - 'SHELL': '/bin/bash', 02:43:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cmH2V0LtpX/Listeners', 02:43:18 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 02:43:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:43:18 INFO - 'USER': 'cltbld', 02:43:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:43:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:43:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:18 INFO - 'XPC_FLAGS': '0x0', 02:43:18 INFO - 'XPC_SERVICE_NAME': '0', 02:43:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:43:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:43:18 INFO - Cleaning up... 02:43:18 INFO - Return code: 0 02:43:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:43:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:18 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 0x105de3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e78618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e93d6a0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d47d30>, '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 0x105aacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d3fb20>, '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.Z4liThkLnR/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.cmH2V0LtpX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 02:43:18 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 02:43:18 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 02:43:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4liThkLnR/Render', 02:43:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:43:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:43:18 INFO - 'HOME': '/Users/cltbld', 02:43:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:43:18 INFO - 'LOGNAME': 'cltbld', 02:43:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:18 INFO - 'MOZ_NO_REMOTE': '1', 02:43:18 INFO - 'NO_EM_RESTART': '1', 02:43:18 INFO - 'PAGER': '/bin/cat', 02:43:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:43:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:18 INFO - 'PWD': '/builds/slave/test', 02:43:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:43:18 INFO - 'SHELL': '/bin/bash', 02:43:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cmH2V0LtpX/Listeners', 02:43:18 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 02:43:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:43:18 INFO - 'USER': 'cltbld', 02:43:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:43:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:43:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:18 INFO - 'XPC_FLAGS': '0x0', 02:43:18 INFO - 'XPC_SERVICE_NAME': '0', 02:43:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:43:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:18 INFO - Downloading/unpacking blobuploader==1.2.4 02:43:18 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 02:43:18 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 02:43:18 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 02:43:18 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 02:43:18 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 02:43:18 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 02:43:21 INFO - Downloading blobuploader-1.2.4.tar.gz 02:43:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:43:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:43:21 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 02:43:21 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 02:43:21 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 02:43:21 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 02:43:21 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 02:43:21 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 02:43:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:43:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:43:21 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 02:43:21 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 02:43:21 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 02:43:21 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 02:43:21 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 02:43:21 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 02:43:22 INFO - Downloading docopt-0.6.1.tar.gz 02:43:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:43:22 INFO - Installing collected packages: blobuploader, requests, docopt 02:43:22 INFO - Running setup.py install for blobuploader 02:43:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:43:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:43:22 INFO - Running setup.py install for requests 02:43:22 INFO - Running setup.py install for docopt 02:43:23 INFO - Successfully installed blobuploader requests docopt 02:43:23 INFO - Cleaning up... 02:43:23 INFO - Return code: 0 02:43:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:43:23 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')]} 02:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:23 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')]} 02:43:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:23 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 0x105de3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e78618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e93d6a0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d47d30>, '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 0x105aacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d3fb20>, '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.Z4liThkLnR/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.cmH2V0LtpX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 02:43:23 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 02:43:23 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 02:43:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4liThkLnR/Render', 02:43:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:43:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:43:23 INFO - 'HOME': '/Users/cltbld', 02:43:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:43:23 INFO - 'LOGNAME': 'cltbld', 02:43:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:23 INFO - 'MOZ_NO_REMOTE': '1', 02:43:23 INFO - 'NO_EM_RESTART': '1', 02:43:23 INFO - 'PAGER': '/bin/cat', 02:43:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:43:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:23 INFO - 'PWD': '/builds/slave/test', 02:43:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:43:23 INFO - 'SHELL': '/bin/bash', 02:43:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cmH2V0LtpX/Listeners', 02:43:23 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 02:43:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:43:23 INFO - 'USER': 'cltbld', 02:43:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:43:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:43:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:23 INFO - 'XPC_FLAGS': '0x0', 02:43:23 INFO - 'XPC_SERVICE_NAME': '0', 02:43:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:43:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:43:23 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-gagw0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:43:23 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-nlod3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:43:23 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-8RHUC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:43:23 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-v55InM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:43:23 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-UT2zop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:43:23 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-tv5sLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:43:24 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-XHGWpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:43:24 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-ZhPR_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:43:24 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-p1BP7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:43:24 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-JXu1Tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:43:24 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-clMtcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:43:24 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-OXSXeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:43:24 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-SrhQ2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:43:24 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-R6PNjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:43:24 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-y6qKV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:43:24 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-XDCI5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:43:25 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-g2AolE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:43:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:43:25 INFO - Running setup.py install for manifestparser 02:43:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:43:25 INFO - Running setup.py install for mozcrash 02:43:25 INFO - Running setup.py install for mozdebug 02:43:25 INFO - Running setup.py install for mozdevice 02:43:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:43:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:43:25 INFO - Running setup.py install for mozfile 02:43:25 INFO - Running setup.py install for mozhttpd 02:43:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:43:26 INFO - Running setup.py install for mozinfo 02:43:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:43:26 INFO - Running setup.py install for mozInstall 02:43:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:43:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:43:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:43:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:43:26 INFO - Running setup.py install for mozleak 02:43:26 INFO - Running setup.py install for mozlog 02:43:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:43:26 INFO - Running setup.py install for moznetwork 02:43:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:43:26 INFO - Running setup.py install for mozprocess 02:43:26 INFO - Running setup.py install for mozprofile 02:43:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:43:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:43:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:43:27 INFO - Running setup.py install for mozrunner 02:43:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:43:27 INFO - Running setup.py install for mozscreenshot 02:43:27 INFO - Running setup.py install for moztest 02:43:27 INFO - Running setup.py install for mozversion 02:43:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:43:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:43:27 INFO - Cleaning up... 02:43:27 INFO - Return code: 0 02:43:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:43:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:27 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 0x105de3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e78618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e93d6a0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d47d30>, '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 0x105aacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d3fb20>, '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.Z4liThkLnR/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.cmH2V0LtpX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 02:43:27 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 02:43:27 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 02:43:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4liThkLnR/Render', 02:43:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:43:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:43:27 INFO - 'HOME': '/Users/cltbld', 02:43:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:43:27 INFO - 'LOGNAME': 'cltbld', 02:43:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:27 INFO - 'MOZ_NO_REMOTE': '1', 02:43:27 INFO - 'NO_EM_RESTART': '1', 02:43:27 INFO - 'PAGER': '/bin/cat', 02:43:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:43:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:27 INFO - 'PWD': '/builds/slave/test', 02:43:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:43:27 INFO - 'SHELL': '/bin/bash', 02:43:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cmH2V0LtpX/Listeners', 02:43:27 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 02:43:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:43:27 INFO - 'USER': 'cltbld', 02:43:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:43:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:43:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:27 INFO - 'XPC_FLAGS': '0x0', 02:43:27 INFO - 'XPC_SERVICE_NAME': '0', 02:43:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:43:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:43:28 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-GGFKma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:43:28 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)) 02:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:43:28 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-JwzlHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:43:28 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)) 02:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:43:28 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-q9Gjzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:43:28 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)) 02:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:43:28 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Ft4xeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:43:28 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)) 02:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:43:28 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-_JRoRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:43:28 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)) 02:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:43:28 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-IL8kbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:43:28 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)) 02:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:43:28 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-e7JOUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:43:28 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)) 02:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:43:28 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-xwKVaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:43: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)) 02:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:43:28 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-R_uL_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:43:29 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)) 02:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:43:29 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-QmXyhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:43:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 02:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:43:29 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-cPKL_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:43:29 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)) 02:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:43:29 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-l_6EQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:43:29 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)) 02:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:43:29 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-S2Gr97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:43:29 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)) 02:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:43:29 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-n9xRob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:43:29 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)) 02:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:43:29 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-VrRbnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:43:29 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)) 02:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:43:29 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-3f0Gjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:43:29 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)) 02:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:43:29 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-uyV_ZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:43: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)) 02:43: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)) 02:43: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)) 02:43: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)) 02:43: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)) 02:43: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)) 02:43:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:43: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 02:43: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 02:43: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 02:43: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 02:43: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 02:43: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 02:43:32 INFO - Downloading blessings-1.6.tar.gz 02:43:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:43:32 INFO - Installing collected packages: blessings 02:43:32 INFO - Running setup.py install for blessings 02:43:32 INFO - Successfully installed blessings 02:43:32 INFO - Cleaning up... 02:43:32 INFO - Return code: 0 02:43:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:43:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:43:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:43:33 INFO - Reading from file tmpfile_stdout 02:43:33 INFO - Current package versions: 02:43:33 INFO - blessings == 1.6 02:43:33 INFO - blobuploader == 1.2.4 02:43:33 INFO - docopt == 0.6.1 02:43:33 INFO - functools32 == 3.2.3-2 02:43:33 INFO - jsonschema == 2.5.1 02:43:33 INFO - manifestparser == 1.1 02:43:33 INFO - mozInstall == 1.12 02:43:33 INFO - mozcrash == 0.17 02:43:33 INFO - mozdebug == 0.1 02:43:33 INFO - mozdevice == 0.48 02:43:33 INFO - mozfile == 1.2 02:43:33 INFO - mozhttpd == 0.7 02:43:33 INFO - mozinfo == 0.9 02:43:33 INFO - mozleak == 0.1 02:43:33 INFO - mozlog == 3.3 02:43:33 INFO - moznetwork == 0.27 02:43:33 INFO - mozprocess == 0.23 02:43:33 INFO - mozprofile == 0.28 02:43:33 INFO - mozrunner == 6.12 02:43:33 INFO - mozscreenshot == 0.1 02:43:33 INFO - mozsystemmonitor == 0.3 02:43:33 INFO - moztest == 0.7 02:43:33 INFO - mozversion == 1.4 02:43:33 INFO - psutil == 3.1.1 02:43:33 INFO - requests == 1.2.3 02:43:33 INFO - wsgiref == 0.1.2 02:43:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:43: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')]} 02:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43: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')]} 02:43:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43: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 0x105de3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e78618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e93d6a0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d47d30>, '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 0x105aacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d3fb20>, '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.Z4liThkLnR/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.cmH2V0LtpX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 02:43: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 02:43: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 02:43:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4liThkLnR/Render', 02:43:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:43:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:43:33 INFO - 'HOME': '/Users/cltbld', 02:43:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:43:33 INFO - 'LOGNAME': 'cltbld', 02:43:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:33 INFO - 'MOZ_NO_REMOTE': '1', 02:43:33 INFO - 'NO_EM_RESTART': '1', 02:43:33 INFO - 'PAGER': '/bin/cat', 02:43:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:43:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:33 INFO - 'PWD': '/builds/slave/test', 02:43:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:43:33 INFO - 'SHELL': '/bin/bash', 02:43:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cmH2V0LtpX/Listeners', 02:43:33 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 02:43:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:43:33 INFO - 'USER': 'cltbld', 02:43:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:43:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:43:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:33 INFO - 'XPC_FLAGS': '0x0', 02:43:33 INFO - 'XPC_SERVICE_NAME': '0', 02:43:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:43:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43: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)) 02:43: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)) 02:43: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)) 02:43: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)) 02:43: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)) 02:43: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)) 02:43: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)) 02:43: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)) 02:43: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)) 02:43: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)) 02:43: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)) 02:43:33 INFO - Cleaning up... 02:43:33 INFO - Return code: 0 02:43:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:43: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')]} 02:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:43:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43: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')]} 02:43:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:43:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:43:33 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 0x105de3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e78618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e93d6a0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d47d30>, '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 0x105aacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d3fb20>, '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.Z4liThkLnR/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.cmH2V0LtpX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 02:43:33 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 02:43:33 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 02:43:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4liThkLnR/Render', 02:43:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:43:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:43:33 INFO - 'HOME': '/Users/cltbld', 02:43:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:43:33 INFO - 'LOGNAME': 'cltbld', 02:43:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:33 INFO - 'MOZ_NO_REMOTE': '1', 02:43:33 INFO - 'NO_EM_RESTART': '1', 02:43:33 INFO - 'PAGER': '/bin/cat', 02:43:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:43:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:33 INFO - 'PWD': '/builds/slave/test', 02:43:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:43:33 INFO - 'SHELL': '/bin/bash', 02:43:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cmH2V0LtpX/Listeners', 02:43:33 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 02:43:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:43:33 INFO - 'USER': 'cltbld', 02:43:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:43:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:43:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:33 INFO - 'XPC_FLAGS': '0x0', 02:43:33 INFO - 'XPC_SERVICE_NAME': '0', 02:43:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:43:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:43:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:43:33 INFO - Cleaning up... 02:43:33 INFO - Return code: 0 02:43:33 INFO - Running post-action listener: _resource_record_post_action 02:43:33 INFO - Running post-action listener: _start_resource_monitoring 02:43:33 INFO - Starting resource monitoring. 02:43:33 INFO - [mozharness: 2016-08-25 09:43:33.633409Z] Finished create-virtualenv step (success) 02:43:33 INFO - [mozharness: 2016-08-25 09:43:33.634355Z] Running install step. 02:43:33 INFO - Running pre-action listener: _resource_record_pre_action 02:43:33 INFO - Running main action method: install 02:43:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:43:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:43:33 INFO - Reading from file tmpfile_stdout 02:43:33 INFO - Detecting whether we're running mozinstall >=1.0... 02:43:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:43:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:43:33 INFO - Reading from file tmpfile_stdout 02:43:33 INFO - Output received: 02:43:33 INFO - Usage: mozinstall [options] installer 02:43:33 INFO - Options: 02:43:33 INFO - -h, --help show this help message and exit 02:43:33 INFO - -d DEST, --destination=DEST 02:43:33 INFO - Directory to install application into. [default: 02:43:33 INFO - "/builds/slave/test"] 02:43:33 INFO - --app=APP Application being installed. [default: firefox] 02:43:33 INFO - mkdir: /builds/slave/test/build/application 02:43:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:43:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 02:44:07 INFO - Reading from file tmpfile_stdout 02:44:07 INFO - Output received: 02:44:07 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:44:07 INFO - Running post-action listener: _resource_record_post_action 02:44:07 INFO - [mozharness: 2016-08-25 09:44:07.977846Z] Finished install step (success) 02:44:07 INFO - [mozharness: 2016-08-25 09:44:07.977977Z] Running run-tests step. 02:44:07 INFO - Running pre-action listener: _resource_record_pre_action 02:44:07 INFO - Running main action method: run_tests 02:44:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:44:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:44:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:44:07 INFO - 2016-08-25 02:44:07.992 screenresolution[1648:8157] starting screenresolution argv=screenresolution get 02:44:07 INFO - 2016-08-25 02:44:07.994 screenresolution[1648:8157] Display 0: 1600x1200x32@60 02:44:08 INFO - 2016-08-25 02:44:08.000 screenresolution[1649:8159] starting screenresolution argv=screenresolution list 02:44:08 INFO - Available Modes on Display 0 02:44:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:44:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:44:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:44:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:44:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:44:08 INFO - Intel Iris: 02:44:08 INFO - Chipset Model: Intel Iris 02:44:08 INFO - Type: GPU 02:44:08 INFO - Bus: Built-In 02:44:08 INFO - VRAM (Dynamic, Max): 1536 MB 02:44:08 INFO - Vendor: Intel (0x8086) 02:44:08 INFO - Device ID: 0x0a2e 02:44:08 INFO - Revision ID: 0x0009 02:44:08 INFO - Displays: 02:44:08 INFO - Display: 02:44:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:44:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:44:08 INFO - Display Serial Number: 1600x1200 60 02:44:08 INFO - Main Display: Yes 02:44:08 INFO - Mirror: Off 02:44:08 INFO - Online: Yes 02:44:08 INFO - Rotation: Supported 02:44:08 INFO - Return code: 0 02:44:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:44:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:44:08 INFO - Python 2.7.3 02:44:08 INFO - Return code: 0 02:44:08 INFO - grabbing minidump binary from tooltool 02:44:08 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')]} 02:44:08 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 0x105d47d30>, '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 0x105aacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d3fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:44:08 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 02:44:08 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 02:44:08 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 02:44:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:44:08 INFO - Return code: 0 02:44:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:44:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:44:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:44:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:44:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:44:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bMagraWMTKWjs4tOXJ9r3g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0180', '--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 02:44:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bMagraWMTKWjs4tOXJ9r3g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0180 --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 02:44:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4liThkLnR/Render', 02:44:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:44:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:44:08 INFO - 'HOME': '/Users/cltbld', 02:44:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:44:08 INFO - 'LOGNAME': 'cltbld', 02:44:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:44:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:08 INFO - 'MOZ_NO_REMOTE': '1', 02:44:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:44:08 INFO - 'NO_EM_RESTART': '1', 02:44:08 INFO - 'PAGER': '/bin/cat', 02:44:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:08 INFO - 'PWD': '/builds/slave/test', 02:44:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:44:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:44:08 INFO - 'SHELL': '/bin/bash', 02:44:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cmH2V0LtpX/Listeners', 02:44:08 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 02:44:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:44:08 INFO - 'USER': 'cltbld', 02:44:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:44:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:08 INFO - 'XPC_FLAGS': '0x0', 02:44:08 INFO - 'XPC_SERVICE_NAME': '0', 02:44:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:44:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bMagraWMTKWjs4tOXJ9r3g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0180', '--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 02:44:08 INFO - mozversion application_buildid: 20160825004426 02:44:08 INFO - mozversion application_changeset: 93f1020581a744c085bad89986db32dabb0339bf 02:44:08 INFO - mozversion application_display_name: Nightly 02:44:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:44:08 INFO - mozversion application_name: Firefox 02:44:08 INFO - mozversion application_remotingname: firefox 02:44:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 02:44:08 INFO - mozversion application_vendor: Mozilla 02:44:08 INFO - mozversion application_version: 51.0a1 02:44:08 INFO - mozversion platform_buildid: 20160825004426 02:44:08 INFO - mozversion platform_changeset: 93f1020581a744c085bad89986db32dabb0339bf 02:44:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 02:44:08 INFO - mozversion platform_version: 51.0a1 02:44:08 INFO - using testdate: 1472118248 02:44:08 INFO - actual date: 1472118248 02:44:08 INFO - starting webserver on 'localhost:49262' 02:44:08 INFO - SUITE-START | Running 2 tests 02:44:08 INFO - TEST-START | dromaeo_css 02:44:08 INFO - operating with platform_type : mac_ 02:44:08 INFO - Initialising browser for dromaeo_css test... 02:44:08 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmp9wAtY1/profile http://localhost:49262/getInfo.html) 02:44:11 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 02:44:11 INFO - PROCESS | 1659 | colorDepth:24 02:44:11 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 02:44:11 INFO - PROCESS | 1659 | __metrics 02:44:11 INFO - PROCESS | 1659 | 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" 02:44:11 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:44:11 INFO - TEST-INFO | 1659: exit 0 02:44:11 INFO - Browser initialized. 02:44:11 INFO - Running cycle 1/1 for dromaeo_css test... 02:44:11 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmp9wAtY1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:44:23 INFO - PROCESS | 1662 | RSS: Main: 234348544 02:44:23 INFO - PROCESS | 1662 | 02:45:15 INFO - PROCESS | 1662 | 1472118315396 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] 02:47:26 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49262/tests/dromaeo/cssquery-ext.html) 02:47:28 INFO - PROCESS | 1662 | RSS: Main: 379428864 02:47:28 INFO - PROCESS | 1662 | 02:50:31 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-ext.html (next: http://localhost:49262/tests/dromaeo/cssquery-jquery.html) 02:50:32 INFO - PROCESS | 1662 | RSS: Main: 370929664 02:50:32 INFO - PROCESS | 1662 | 02:53:34 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49262/tests/dromaeo/cssquery-mootools.html) 02:53:35 INFO - PROCESS | 1662 | RSS: Main: 338653184 02:53:35 INFO - PROCESS | 1662 | 02:56:37 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49262/tests/dromaeo/cssquery-prototype.html) 02:56:38 INFO - PROCESS | 1662 | RSS: Main: 332816384 02:56:38 INFO - PROCESS | 1662 | 02:59:41 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49262/tests/dromaeo/cssquery-yui.html) 02:59:42 INFO - PROCESS | 1662 | RSS: Main: 331628544 02:59:42 INFO - PROCESS | 1662 | 03:02:45 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-yui.html (next: http://localhost:49262/tests/dromaeo/cssquery-dojo.html) 03:02:46 INFO - PROCESS | 1662 | RSS: Main: 443269120 03:02:46 INFO - PROCESS | 1662 | 03:02:46 INFO - PROCESS | 1662 | __start_tp_report 03:02:46 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 03:02:46 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 03:02:46 INFO - PROCESS | 1662 | |i|pagename|runs| 03:02:46 INFO - PROCESS | 1662 | |0;dojo.html;3339.382214290356;3369.578802649669;3405.506201600768;3437.7765445246073;3462.0825481247457;4656.674032817704;5595.272614560102;5698.886022279552;5734.885302293957;5765.394633563473;5669.518090962263;5697.230873832032;5806.245188125548;5854.121881717744;5885.352611212763;5097.362829646294;5173.689578625275;5178.922316165242;5179.378474583055;5281.8415447536445;5288.338957630296;5293.814716484924;5310.787568497275;5317.468253174671;5333.413324534317;5144.4083930348115;5189.844304670866;5191.688498690053;5248.186531087668;5277.12927366984;4370.300751879716;5187.299714538527;5255.343082114736;5261.263423120766;5266.972940276648;5140.383154021504;5157.510036546522;5217.3999990000875;5282.550983166436;5285.947140528622;5691.573132015115;5705.657660540381;5746.02317606008;5749.482546570787;5758.078707406795;5172.586193104543;6303.747850085991;6306.400891915261;6310.0850376695125;6313.431791138773;5067.695938243717;6182.659953702545;6202.62784232943;6210.937890621081;6283.654399008053;5886.264216972879;5897.941020589825;5914.053751399799;5924.289085309791;5951.226340575698;6269.373062693785;6286.622802631857;6286.622802631857;6287.1198032275515;6289.7169627366875;6078.635281883101;6086.107819020229;6139.890808645427;6154.892119418548;6204.5967012144065;6303.023031430135;6308.053791931247;6316.242050953915;6317.084022816666;6336.271328797156;6253.749850005949;6283.7800676977;6286.277078135981;6290.622562646256;6292.2134733158355;5184.9740751296;6091.664958427329;6163.414475624809;6200.689965501707;6274.529410294246;4983.8504844854715;4996.200607902718;4999.47505511916;4999.500049994971;5002.499750024968;4484.68607197493;4487.304467807429;4487.304467807495;4487.977560112244;4523.570260825217;5628.943710562924;5671;5708.429157084258;5751.769929202868;5772.682502462405;6233.096201050822;6241.563090583706;6257.5932564383165;6266.498680105672;6269.185005949197;5713.685747283939;5733.082706766897;5745.2818397700285;5746.683932383676;5799.101139323411;5348.545373643206;5403.351597808288;5414.83755487336;5420.512153906167;5460.836174914759;6214.689265536796;6331.398517140864;6344.492440604833;6355.745770169141;6356.173697419306;6260.718267677874;6267.467265282502;6271.027990661455;6281.277653069956;6299.496040316855;6184.072389141665;6203.4416902479;6356.68216589178;6368.808935731936;6379.393957574023;6155.47678447337;6206.503479721521;6241.843953901007;6285.371462853678;6293.433590976834;6245.313015568375;6305.243370795534;6322.525810564318;6328.430441260309;6338.492920566436;6029.728662210124;6142.692865356804;6167.290761562478;6183.134361189347;6210.72051757681;6035.637861728311;6097.725602347994;6105.490073363355;6125.662799505599;6193;6070.921985815603;6079.422454866781;6080.363685304527;6108.602940808833;6133.26400831903;6136.2636483622255;6183.196184495987;6194.938050619617;6202.7829025985675;6215.627062376272;5856.912146317723;5919.852003699942;5944.048952167633;5954.702264886825;6029.246344206974 03:02:46 INFO - PROCESS | 1662 | |1;ext.html;485.4514398729435;506.52386756448936;526.3841305672363;532.2016974538191;548.2406866489911;27388.86305568472;41563.960900977494;42612.78693606528;42672.93317667056;45315.64053078405;44393.334099988526;44644.77677611607;44733.7763311183;44885.55114448863;44933.55066449343;8849.601767920427;9782.999999999982;9974.850377244347;9981.90018099817;10002.749931251705;7560.4707670463085;9023.278137748965;9027.864582031274;9029.503377314246;12140.817887731691;12205.694857628587;12499.937500312486;12503.312317822516;12532.93733531331;12570.560030398938;12383.690407739834;12504.937080348182;12517.937410312936;12523.749525009449;12537.31044792536;12247.652758196591;12328.75342493145;12337.568185113567;12339.753204935942;12366.876331236663;41653;41852;41888.581114188775;41980.79009604932;42101.57898421007;3513.2622149348667;3519.4896739972814;3535;3723.3484140275345;3735.6637902588895;31900.680993190002;32219.51670724941;32232.033039008867;32244.355112897847;32458.02625921226;3264.722498587623;3334.816585087819;3351.6648335166533;3355.2786150977413;3458.170039190576;502641;504262;504805;504977;509787.9999999963;61836.690816545626;62212.68893655593;62235;62252;62359.06461403082;34697.30605387878;35322.470162947575;35423.291534169686;36691.266174676355;65631.67184164049;16539.173041347884;16682.416115435903;16747.581310467092;16753.413630522875;16756.07841568701;12779.105462617528;12871.549495767604;12872.742545149045;12883.355832208352;12885;16812.663746724997;17069.7439538407;18973.65124109323;19218.519537011685;19573.608527829365;7747;7796.727114550963;7867.449278550446;7913.8740197622765;7973.362131029504;857.7383897911197;992.4095163377779;1010.1111022300329;1041.3439533094102;1082.3668154129764;29703.702962970525;30717.23206919845;30831.537526937114;31452.52821207684;31458.213544661565;1002.4636819301638;1023.6877752285625;1055.456439933435;1090.4384242115316;1156.8380426740264;12617.369131543386;15567.455139070305;15927.362905483651;16007.359705611645;16244.51266462008;699647;755070;760967;762775;973467;62003;62723;62881.685591571746;63158.68420657959;63167.36832631707;1385.7990591364196;1394.372532360442;1426.1158081989233;1426.137187001849;1426.3153686230667;24036.63945040861;29217.85391073031;31952.201194970312;32042;32868;57857.4214257852;59198.70400647969;59351.70324148352;63588.36411636009;63676;425017;504531;507183;507824;509903;36362.09094772546;36995.815020924725;42798.35802463028;44395.77802110969;44733.55266447294;38798.6120138795;48841.755791220814;49060.509394905595;49443.76390590264;50318.748406257735;40052.399214012396;40150.59849401469;40248.79875600721;41432;41788;38957.02607434837;40325.1934961305;40583.3912491307;41334.586654133076;41545.58454415538;39257.803710981265;39362;39996.20007599774;40330.59669403268;41192.588074120074;34417.65582344145;35012.12469688278;35636.46545301771;35804.10489737777;35922.64077359193;23620.645690314315;25750.356241094123;25851;25895.22314330573;26289.07988220403 03:02:46 INFO - PROCESS | 1662 | |2;jquery.html;350.2277478160656;368.1716138687952;372.44319741985737;376.8963535027867;402.663775747251;15585.142817145052;16229.918850405746;19966.900165499188;20566.38300850975;20594;18082.095895205253;21309.36071917841;21322.786772132313;21817.01823417946;22049.11803527857;5746.425357464262;5853.297604287492;5968.074948382986;6136.723847426854;6142.570020098595;4178.958210417887;5928.614640048383;6041.033434650457;6041.365656606059;6059.818205453844;6313.431791138796;6572.93427065728;6617.933820661804;6676.098726671886;6694.297098804628;6626.602403855784;6667.066610674485;6707.3628005339415;8003.279704826536;8061.395395345314;7456.142543607501;7685.077790665156;7735.922640773577;7768.611569421563;7768.7669369918995;24412.511749764904;29468.410631787458;29846.85076574625;30031.249218769488;30518.302655446114;2302.976970230293;2394.7126344838557;2467.198160597795;2653.6815582130266;2965.184574242079;16270.023798572005;16690;17177.055261960588;17249.741253881202;18250.269989200417;1995.740553728006;2063.587282543497;2069.9379018629465;2092.184048221195;2114.143771772435;118984.40507797405;120323;128126.51557195453;131070;147252.26373868063;17320.480385588453;20678.379648610266;21565.24521641735;21566.245181418573;21795.67306490404;34937.30125397529;35020;35116.473252901225;35173.64826351755;35179;9362.970073291932;10455.320404173704;10827.187960902964;10962.218034777989;11187;8952.373333866566;8976.775580610407;8980.955095224614;9136.08639136081;9175.128362805523;9589.520523973913;9842;10008.549615267331;10012.599496020077;10029.348092373972;3346.782459140148;3476.991672415022;3681.687056600219;3783.129880127531;3784.7729136251914;890.6125835261682;902.7878448564582;910.8523260691576;928.3084102343797;1025.9897401025894;20077;20987.16051357959;21674.34976950694;21700.782992169876;21721.34835954924;934.72425634438;937.4328531238639;947.3747326764302;947.7683188797935;993.7515621094726;10483.737906552396;10917.290376125526;10923.126149907988;10956.28784129029;10958.232923695265;605379;618316;621784;622872;623690.1047916156;104872.47563762132;121808;124489;131452.02821957678;131887.34056329657;819.6680344460503;976.3068221562628;1026.5431882812077;1043.7286305560608;1049.9685009449577;19154.329598463988;19607.803921960596;19847.702284465457;19890.90054549718;19913;52852;56575.434245657016;56675.433245667016;57157.714211428676;57304.85390292088;54012.729936350064;76994;79372;79502;80004;7107.609081500567;7132.821679458055;7409.62951852416;7415.369693576106;8115.918840811516;10777;11556.94221528887;12087.879121209027;12809;13194.208347499181;10814.783704326026;10832.350058996486;11085.722856928318;11260;11304.49129789145;10614.575416983544;10822.56709731602;10921.453927303763;11287.830682539605;11498.425078745862;9768.902310976799;11276.210665253353;11346.829797553208;11557.82663260035;11691.356975366436;7378.335949764547;7389.778306650809;7462.96268518654;7620.390368770374;7697.307242348215;9497.952510237405;10093.444860532742;10141.391516509033;10955.890441095806;11242.494087766234 03:02:46 INFO - PROCESS | 1662 | |3;mootools.html;1471.9926400367997;1474.2849717886822;1512.2665507228992;1825.5983683589623;1885.1705249690126;8492.787680307996;9014.68448604299;9015.143561361676;9034.503102329369;9036.774080647987;7805.765827025199;8098.635561399737;8471.06818249992;8751.649934002633;8792.461319269118;2376.477175021497;2401.6037353836596;2402.1112188490197;2408.50625621748;2411.5297516984197;2367.348979030763;2377.5958087125146;2410.843295185807;2416.0094361311867;2424.745401732819;2101.6112019276484;2188.3434969509162;2320.9535809283802;2390.474095698952;2398.436367453647;2385.8687772172525;2386.522695460906;2411.794997425221;2415.323709361373;2415.842970206931;1850.4171186076478;2236.7875051870046;2345.2143531916827;2361.3034154924167;2408.759124087595;8879.556022198864;8936.017038125801;8966.820663586692;8971.416857904216;8978.551072446351;5256.579473642138;5446.428125046853;5449.128139497701;5452.2094296327205;5479.780808767645;2838.7445129938196;3611.693006094485;3746.6253374662588;3750.6999440044733;3759.812009399519;1112.7885701716648;1134.73901002769;1785.749995000701;1842.4656849513758;1875.6530041942285;11178.664640060812;11563.942180289128;11656.18406711522;11668;11697.23967942081;4445.26653102241;4511.278195488706;4689.953100468952;4693.530646935279;4696;9259.796226490513;9260.351775375793;9267.76830579241;9270.351075424656;9281.90718092824;4895.7271109511785;5010.699358038456;5293.311869457023;5293.550048245942;5295.205719142159;4783.4499032611;4930.704157750546;4958.975205123951;4959.776810043557;4960.627952903546;3651.214988777426;3657.231981283907;3697.7226707997006;3726.087108658396;3740.4202348636004;1095.1786160379716;1133.325671225636;1147.7704459108045;1166.5916929074926;1169.1348402182493;769.383895690258;846.6571038729325;919.8298314811648;928.6378312458147;979.3177652028425;4934.432540257916;5876.471117599436;5953.880922381615;6027.698615069229;6118.541109416811;864.8140649760206;952.5999080386116;957.2724729205854;960;973.2165606686543;3379.642530154066;3997;4027.9930017495626;4068.0336671744813;4108.876733697994;10615.416152111708;10829.24195306321;10879.945600272107;10896.945515272373;10905.83641245382;10038.64864729731;10613.787724245472;10617.150627949746;10782.245242833083;10856.945715271373;7919.960400198077;8148.551829649307;8161.959190204129;8177.182281771894;8179.79550511242;5084.898302034013;5683.2895888014;5880.735366908585;6078.939210608014;6178.567500275118;8527.488350698977;9723.367981081206;9934.850977235492;10149.137323327304;10266.743331416774;10001.2999090063;10291.742706432398;10354.223433242387;10420.583176672848;10436.373817570666;7596.8480630385975;7705.807354816175;7709.575973321297;7718.189590092959;7734.381249500139;8100.189981001853;8432.53621050848;8472.02571704262;8595.31237501011;8595.785105372415;7411.4070874328845;7558.508696934681;7647.808804779925;7648.770536883902;7717.922820771945;7487;7499.2500749924575;7518.022657054548;7573.848523029619;7583.544987300779;6794;7035.824104397431;7129.39400150993;7156.3559279662995;7195.244499327495;5015.498450155102;5050.747462626928;5064.215046667772;5108.438071812024;5173.1464308388695;4956.578690811177;5034.823781167642;5157.252198431132;5211.296474975981;5271.024860400838 03:02:46 INFO - PROCESS | 1662 | |4;prototype.html;255.80942198062445;260.9386794103385;296.7625899280575;309.24852608162166;309.2608665289956;4432.312991486321;4884.706917584938;5306.548943339816;5354.89290214196;5392.649477783942;5089.796408143679;5174.404943431507;5315.973420132894;5371.328583927009;5372.516473517383;3859.633334833193;3893.3770596704535;4034.273830710471;4130.56629053948;4209.536950935395;4072.470578824749;4078.3474644056955;4081.9387709184384;4091.4272001919753;4165.458490396244;3462.671046250602;3586.399860101432;3969.027588240885;4053.9391909121387;4073.8796830871597;3191.2341038150907;3868.3617203161443;4059.4722686050623;4084.9183016339507;4119;3108.3161704424992;3245.123816569513;3526.1008442847165;3529.2235708144167;3530.122949795908;5215.713135777531;5220.4779522047875;5227.895442091137;5301.575873930076;5311.548518375904;4464.308032255006;4610.377599024156;4628.675992680513;4647.512011238839;4665.626749860037;4242.745435273893;5265.605079619044;5595.524380427669;5620.91568626471;5680.46035626619;3651.2697460508007;3856.975088078753;3865.0530619998;3868.458415821787;3893.240818040483;5125.436202017775;5875.324337701134;5896.469317761422;5902.439268269508;5914.852128696774;3390.0846771371594;3391.440412331987;3759.191773768598;3876.7867767272505;3885.572587015426;3300.3564304960782;3478.756487045933;3914.8629797957506;3923.313420151462;3948.6446219840354;4581.289900065495;4585.518520555361;4587.977060114678;4602.769861506911;4607.055553611569;4708.929366059512;5336.866578335495;5650.5479561634975;5652.830415087554;5692.686902220417;1318.558282975214;1331.7003674173427;1335.5926442434957;1343.4156142078227;1347.6091933339417;776.7397921696182;801.3949468151508;821.9383546234056;822.2024636102971;829.1915382502133;4308.793537809418;5064.265681476165;5266.815661451831;5270.525652691276;5305.946940530623;5128.615353848401;5773.5958482906635;5773.758641892014;5865.442782935615;5888.263967004124;4614.238650622677;4663.067386522641;4962.627802914796;5257.763400646903;5307;2981.6571094323995;3047.7866549341334;3054.8930787422332;3056.6463822856276;3057.3885222955496;5321.494458026481;5327.493888080626;5741.971290143522;6062.181605483203;6128.3258841527395;5576.21561100444;5753.634124037401;5840.334875171077;6022.711369679494;6088.634681919099;5943.3462319144855;6061.727222275008;6072.848178795653;6077.756889724362;6093.69531523422;4672.948586567995;5728.083506638918;5781.306243250837;5807.8548036299435;5851.834821116215;4839.395075615548;5655.1517272409465;5676.886462270814;5783.363829978614;5803.187553742395;5748.425157484218;5951.732172052355;5995.400459953969;6045.848853778691;6085.9695701521205;3627.673509384168;3792.79139647311;3848.441975913533;3860.9227815442973;3875.2830726314596;5701.230333904869;5707.800226992035;5740.253767010262;5758.452946970031;5777.364489906191;5367.4364191759305;5609.9158512621525;5661.575381846295;5664.603477756517;5665;5248.501392367719;5548.112302031655;5560.833175004756;5564.360098588552;5627.606067575231;4881.487443818348;5505.394406615349;5524.33707955048;5524.861878453071;5552.250446189874;4489.420790793438;5197.818076367309;5253.973730131325;5519.806806761744;5604.943950560442;4554.997900461893;4847.636427267898;5519.69641669712;5528.226048353154;5550.916736249041 03:02:46 INFO - PROCESS | 1662 | |5;yui.html;711.8611870685216;718.360238859727;776.5107981971361;823.6087858267324;837.4389159263301;15504.844951550482;16637.168141592934;16640.251188696508;16648.83351166488;16668.999860008407;14865.777013344808;15020.774688379683;15036.248187590603;15040.548783536511;15041.841213345211;662.7812821768805;683.7196749332775;829.3779665251046;831.5634291996689;838.7190291252438;852.7143406958676;856.1010938514565;856.824351008045;859.5916939453772;862.4652715316481;913.127962795532;913.6482454255126;916;916.4959272400154;916.8808054952847;908.0646933658343;909.077286554148;910.7586489580267;911.5077857956695;913.8674892140668;523.0976565424612;528.4424931697058;529.8251576979587;531.917552779316;531.9175527793199;14486.492972745904;14978.62553436162;15008.24958752058;15011.699766004727;15070.321835517429;14281.64295892611;14628.853711462856;14855.628609284746;14916;14974.775378369333;11846.881531184665;11869.703257418634;11950.88049119515;12015.759684806342;12224.511019559208;3878.825452854628;3900.102976315435;3944.7238693291483;3976.741511801724;4085.9795701021603;110640;111581.88418115796;111889.44055279753;112172.87827121707;112332;11385.08919286455;11519.48162332697;11545.88454115448;11587.594434194763;11917.165798394202;22267.665985010237;22487.55024899493;22587.887060564593;22666.546669066527;22828.201012964466;7993.600319983978;8203.7949051273;8231.876521852177;8309;8531.01893282268;4437.201303765289;4649.302604609268;4671.0891376182;4754.595859351924;4809.134355815987;3619.4570814378053;3758.642928921748;3765.7175711821724;3767.566729826105;3770.0763312988493;597.7608956417381;651.7295322441229;660.1253339325413;680.0683064202075;680.2279412866433;592.8517870532366;613.5980932489226;632.2223664892208;647.439964430764;692.1989181919737;9075.954620226856;9083.409578377385;9495;9500.287478439144;9659.420434773936;645.6965226343611;670.5004771445305;671.1275342055309;674.3795707948699;682.3722175598461;3946.8223929923224;4158.6465150461945;4186.193981788801;4553.795079221443;4767.976160119178;116034.41982790032;144484.27757861142;176722;178277;178504;139443.30278348544;143544;144443;146972;149491;74640.50718985699;75579.62210188914;76470.61764691141;104850.4757476223;108543;8959.969603495681;9849.261305402268;9954.352967057119;9984.550695218588;10020.549075291776;59187;61935;62040;63048;63513;91081.54459227927;97160;97697;98824.50587747303;99246.5037674807;13002.349882506027;13305.334733263104;13316.46734130624;13445.327733613085;13746.381412836647;14841.777373339193;14872.62818429548;14999.625009374853;15049.398024078915;15723.213839308217;13718.314084295545;13722.039457237897;13879.375428105961;13985.090969086978;14110.012299138962;14104.435822567393;14112.50606228777;14128.434862605793;14130.858691412954;14248;13648.112872663245;13687;13725.725485490035;13823.723525529233;13835.723285534434;11250.718732031764;11299.774004520028;11385.544578216779;11476.655700329004;11770.58802941893;9615.615375385187;9973.900260997298;9983.750406239611;10296.433696146485;10301.536430860779 03:02:46 INFO - PROCESS | 1662 | __end_tp_report 03:02:46 INFO - PROCESS | 1662 | __start_cc_report 03:02:46 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1365 03:02:46 INFO - PROCESS | 1662 | __end_cc_report 03:02:46 INFO - PROCESS | 1662 | __startTimestamp1472119366095__endTimestamp 03:02:46 INFO - PROCESS | 1662 | 03:02:46 INFO - PROCESS | 1662 | ------- Summary: start ------- 03:02:46 INFO - PROCESS | 1662 | Number of tests: 6 03:02:46 INFO - PROCESS | 1662 | 03:02:46 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5754.62 Median:6029.25 stddev:652.26 (10.8%) stddev-sans-first:626.13 03:02:46 INFO - PROCESS | 1662 | Values: 3339.4 3369.6 3405.5 3437.8 3462.1 4656.7 5595.3 5698.9 5734.9 5765.4 5669.5 5697.2 5806.2 5854.1 5885.4 5097.4 5173.7 5178.9 5179.4 5281.8 5288.3 5293.8 5310.8 5317.5 5333.4 5144.4 5189.8 5191.7 5248.2 5277.1 4370.3 5187.3 5255.3 5261.3 5267.0 5140.4 5157.5 5217.4 5282.6 5285.9 5691.6 5705.7 5746.0 5749.5 5758.1 5172.6 6303.7 6306.4 6310.1 6313.4 5067.7 6182.7 6202.6 6210.9 6283.7 5886.3 5897.9 5914.1 5924.3 5951.2 6269.4 6286.6 6286.6 6287.1 6289.7 6078.6 6086.1 6139.9 6154.9 6204.6 6303.0 6308.1 6316.2 6317.1 6336.3 6253.7 6283.8 6286.3 6290.6 6292.2 5185.0 6091.7 6163.4 6200.7 6274.5 4983.9 4996.2 4999.5 4999.5 5002.5 4484.7 4487.3 4487.3 4488.0 4523.6 5628.9 5671.0 5708.4 5751.8 5772.7 6233.1 6241.6 6257.6 6266.5 6269.2 5713.7 5733.1 5745.3 5746.7 5799.1 5348.5 5403.4 5414.8 5420.5 5460.8 6214.7 6331.4 6344.5 6355.7 6356.2 6260.7 6267.5 6271.0 6281.3 6299.5 6184.1 6203.4 6356.7 6368.8 6379.4 6155.5 6206.5 6241.8 6285.4 6293.4 6245.3 6305.2 6322.5 6328.4 6338.5 6029.7 6142.7 6167.3 6183.1 6210.7 6035.6 6097.7 6105.5 6125.7 6193.0 6070.9 6079.4 6080.4 6108.6 6133.3 6136.3 6183.2 6194.9 6202.8 6215.6 5856.9 5919.9 5944.0 5954.7 6029.2 03:02:46 INFO - PROCESS | 1662 | 03:02:46 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:73395.57 Median:3729.51 stddev:164713.85 (4416.5%) stddev-sans-first:165084.95 03:02:46 INFO - PROCESS | 1662 | Values: 485.5 506.5 526.4 532.2 548.2 27388.9 41564.0 42612.8 42672.9 45315.6 44393.3 44644.8 44733.8 44885.6 44933.6 8849.6 9783.0 9974.9 9981.9 10002.7 7560.5 9023.3 9027.9 9029.5 12140.8 12205.7 12499.9 12503.3 12532.9 12570.6 12383.7 12504.9 12517.9 12523.7 12537.3 12247.7 12328.8 12337.6 12339.8 12366.9 41653.0 41852.0 41888.6 41980.8 42101.6 3513.3 3519.5 3535.0 3723.3 3735.7 31900.7 32219.5 32232.0 32244.4 32458.0 3264.7 3334.8 3351.7 3355.3 3458.2 502641.0 504262.0 504805.0 504977.0 509788.0 61836.7 62212.7 62235.0 62252.0 62359.1 34697.3 35322.5 35423.3 36691.3 65631.7 16539.2 16682.4 16747.6 16753.4 16756.1 12779.1 12871.5 12872.7 12883.4 12885.0 16812.7 17069.7 18973.7 19218.5 19573.6 7747.0 7796.7 7867.4 7913.9 7973.4 857.7 992.4 1010.1 1041.3 1082.4 29703.7 30717.2 30831.5 31452.5 31458.2 1002.5 1023.7 1055.5 1090.4 1156.8 12617.4 15567.5 15927.4 16007.4 16244.5 699647.0 755070.0 760967.0 762775.0 973467.0 62003.0 62723.0 62881.7 63158.7 63167.4 1385.8 1394.4 1426.1 1426.1 1426.3 24036.6 29217.9 31952.2 32042.0 32868.0 57857.4 59198.7 59351.7 63588.4 63676.0 425017.0 504531.0 507183.0 507824.0 509903.0 36362.1 36995.8 42798.4 44395.8 44733.6 38798.6 48841.8 49060.5 49443.8 50318.7 40052.4 40150.6 40248.8 41432.0 41788.0 38957.0 40325.2 40583.4 41334.6 41545.6 39257.8 39362.0 39996.2 40330.6 41192.6 34417.7 35012.1 35636.5 35804.1 35922.6 23620.6 25750.4 25851.0 25895.2 26289.1 03:02:46 INFO - PROCESS | 1662 | 03:02:46 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:37171.54 Median:16406.02 stddev:102925.58 (627.4%) stddev-sans-first:103177.18 03:02:46 INFO - PROCESS | 1662 | Values: 350.2 368.2 372.4 376.9 402.7 15585.1 16229.9 19966.9 20566.4 20594.0 18082.1 21309.4 21322.8 21817.0 22049.1 5746.4 5853.3 5968.1 6136.7 6142.6 4179.0 5928.6 6041.0 6041.4 6059.8 6313.4 6572.9 6617.9 6676.1 6694.3 6626.6 6667.1 6707.4 8003.3 8061.4 7456.1 7685.1 7735.9 7768.6 7768.8 24412.5 29468.4 29846.9 30031.2 30518.3 2303.0 2394.7 2467.2 2653.7 2965.2 16270.0 16690.0 17177.1 17249.7 18250.3 1995.7 2063.6 2069.9 2092.2 2114.1 118984.4 120323.0 128126.5 131070.0 147252.3 17320.5 20678.4 21565.2 21566.2 21795.7 34937.3 35020.0 35116.5 35173.6 35179.0 9363.0 10455.3 10827.2 10962.2 11187.0 8952.4 8976.8 8981.0 9136.1 9175.1 9589.5 9842.0 10008.5 10012.6 10029.3 3346.8 3477.0 3681.7 3783.1 3784.8 890.6 902.8 910.9 928.3 1026.0 20077.0 20987.2 21674.3 21700.8 21721.3 934.7 937.4 947.4 947.8 993.8 10483.7 10917.3 10923.1 10956.3 10958.2 605379.0 618316.0 621784.0 622872.0 623690.1 104872.5 121808.0 124489.0 131452.0 131887.3 819.7 976.3 1026.5 1043.7 1050.0 19154.3 19607.8 19847.7 19890.9 19913.0 52852.0 56575.4 56675.4 57157.7 57304.9 54012.7 76994.0 79372.0 79502.0 80004.0 7107.6 7132.8 7409.6 7415.4 8115.9 10777.0 11556.9 12087.9 12809.0 13194.2 10814.8 10832.4 11085.7 11260.0 11304.5 10614.6 10822.6 10921.5 11287.8 11498.4 9768.9 11276.2 11346.8 11557.8 11691.4 7378.3 7389.8 7463.0 7620.4 7697.3 9498.0 10093.4 10141.4 10955.9 11242.5 03:02:46 INFO - PROCESS | 1662 | 03:02:46 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5717.89 Median:5013.10 stddev:3178.50 (63.4%) stddev-sans-first:3171.40 03:02:46 INFO - PROCESS | 1662 | Values: 1472.0 1474.3 1512.3 1825.6 1885.2 8492.8 9014.7 9015.1 9034.5 9036.8 7805.8 8098.6 8471.1 8751.6 8792.5 2376.5 2401.6 2402.1 2408.5 2411.5 2367.3 2377.6 2410.8 2416.0 2424.7 2101.6 2188.3 2321.0 2390.5 2398.4 2385.9 2386.5 2411.8 2415.3 2415.8 1850.4 2236.8 2345.2 2361.3 2408.8 8879.6 8936.0 8966.8 8971.4 8978.6 5256.6 5446.4 5449.1 5452.2 5479.8 2838.7 3611.7 3746.6 3750.7 3759.8 1112.8 1134.7 1785.7 1842.5 1875.7 11178.7 11563.9 11656.2 11668.0 11697.2 4445.3 4511.3 4690.0 4693.5 4696.0 9259.8 9260.4 9267.8 9270.4 9281.9 4895.7 5010.7 5293.3 5293.6 5295.2 4783.4 4930.7 4959.0 4959.8 4960.6 3651.2 3657.2 3697.7 3726.1 3740.4 1095.2 1133.3 1147.8 1166.6 1169.1 769.4 846.7 919.8 928.6 979.3 4934.4 5876.5 5953.9 6027.7 6118.5 864.8 952.6 957.3 960.0 973.2 3379.6 3997.0 4028.0 4068.0 4108.9 10615.4 10829.2 10879.9 10896.9 10905.8 10038.6 10613.8 10617.2 10782.2 10856.9 7920.0 8148.6 8162.0 8177.2 8179.8 5084.9 5683.3 5880.7 6078.9 6178.6 8527.5 9723.4 9934.9 10149.1 10266.7 10001.3 10291.7 10354.2 10420.6 10436.4 7596.8 7705.8 7709.6 7718.2 7734.4 8100.2 8432.5 8472.0 8595.3 8595.8 7411.4 7558.5 7647.8 7648.8 7717.9 7487.0 7499.3 7518.0 7573.8 7583.5 6794.0 7035.8 7129.4 7156.4 7195.2 5015.5 5050.7 5064.2 5108.4 5173.1 4956.6 5034.8 5157.3 5211.3 5271.0 03:02:46 INFO - PROCESS | 1662 | 03:02:46 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:4554.21 Median:5218.10 stddev:1423.21 (27.3%) stddev-sans-first:1390.15 03:02:46 INFO - PROCESS | 1662 | Values: 255.8 260.9 296.8 309.2 309.3 4432.3 4884.7 5306.5 5354.9 5392.6 5089.8 5174.4 5316.0 5371.3 5372.5 3859.6 3893.4 4034.3 4130.6 4209.5 4072.5 4078.3 4081.9 4091.4 4165.5 3462.7 3586.4 3969.0 4053.9 4073.9 3191.2 3868.4 4059.5 4084.9 4119.0 3108.3 3245.1 3526.1 3529.2 3530.1 5215.7 5220.5 5227.9 5301.6 5311.5 4464.3 4610.4 4628.7 4647.5 4665.6 4242.7 5265.6 5595.5 5620.9 5680.5 3651.3 3857.0 3865.1 3868.5 3893.2 5125.4 5875.3 5896.5 5902.4 5914.9 3390.1 3391.4 3759.2 3876.8 3885.6 3300.4 3478.8 3914.9 3923.3 3948.6 4581.3 4585.5 4588.0 4602.8 4607.1 4708.9 5336.9 5650.5 5652.8 5692.7 1318.6 1331.7 1335.6 1343.4 1347.6 776.7 801.4 821.9 822.2 829.2 4308.8 5064.3 5266.8 5270.5 5305.9 5128.6 5773.6 5773.8 5865.4 5888.3 4614.2 4663.1 4962.6 5257.8 5307.0 2981.7 3047.8 3054.9 3056.6 3057.4 5321.5 5327.5 5742.0 6062.2 6128.3 5576.2 5753.6 5840.3 6022.7 6088.6 5943.3 6061.7 6072.8 6077.8 6093.7 4672.9 5728.1 5781.3 5807.9 5851.8 4839.4 5655.2 5676.9 5783.4 5803.2 5748.4 5951.7 5995.4 6045.8 6086.0 3627.7 3792.8 3848.4 3860.9 3875.3 5701.2 5707.8 5740.3 5758.5 5777.4 5367.4 5609.9 5661.6 5664.6 5665.0 5248.5 5548.1 5560.8 5564.4 5627.6 4881.5 5505.4 5524.3 5524.9 5552.3 4489.4 5197.8 5254.0 5519.8 5604.9 4555.0 4847.6 5519.7 5528.2 5550.9 03:02:46 INFO - PROCESS | 1662 | 03:02:46 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:25326.14 Median:3889.46 stddev:41168.45 (1058.5%) stddev-sans-first:41242.46 03:02:46 INFO - PROCESS | 1662 | Values: 711.9 718.4 776.5 823.6 837.4 15504.8 16637.2 16640.3 16648.8 16669.0 14865.8 15020.8 15036.2 15040.5 15041.8 662.8 683.7 829.4 831.6 838.7 852.7 856.1 856.8 859.6 862.5 913.1 913.6 916.0 916.5 916.9 908.1 909.1 910.8 911.5 913.9 523.1 528.4 529.8 531.9 531.9 14486.5 14978.6 15008.2 15011.7 15070.3 14281.6 14628.9 14855.6 14916.0 14974.8 11846.9 11869.7 11950.9 12015.8 12224.5 3878.8 3900.1 3944.7 3976.7 4086.0 110640.0 111581.9 111889.4 112172.9 112332.0 11385.1 11519.5 11545.9 11587.6 11917.2 22267.7 22487.6 22587.9 22666.5 22828.2 7993.6 8203.8 8231.9 8309.0 8531.0 4437.2 4649.3 4671.1 4754.6 4809.1 3619.5 3758.6 3765.7 3767.6 3770.1 597.8 651.7 660.1 680.1 680.2 592.9 613.6 632.2 647.4 692.2 9076.0 9083.4 9495.0 9500.3 9659.4 645.7 670.5 671.1 674.4 682.4 3946.8 4158.6 4186.2 4553.8 4768.0 116034.4 144484.3 176722.0 178277.0 178504.0 139443.3 143544.0 144443.0 146972.0 149491.0 74640.5 75579.6 76470.6 104850.5 108543.0 8960.0 9849.3 9954.4 9984.6 10020.5 59187.0 61935.0 62040.0 63048.0 63513.0 91081.5 97160.0 97697.0 98824.5 99246.5 13002.3 13305.3 13316.5 13445.3 13746.4 14841.8 14872.6 14999.6 15049.4 15723.2 13718.3 13722.0 13879.4 13985.1 14110.0 14104.4 14112.5 14128.4 14130.9 14248.0 13648.1 13687.0 13725.7 13823.7 13835.7 11250.7 11299.8 11385.5 11476.7 11770.6 9615.6 9973.9 9983.8 10296.4 10301.5 03:02:46 INFO - PROCESS | 1662 | -------- Summary: end -------- 03:02:46 INFO - PROCESS | 1662 | 03:02:46 INFO - TEST-INFO | 1662: exit 0 03:02:46 INFO - TEST-OK | dromaeo_css | took 1118153ms 03:02:46 INFO - TEST-START | kraken 03:02:46 INFO - operating with platform_type : mac_ 03:02:46 INFO - Initialising browser for kraken test... 03:02:46 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpuRtbQY/profile http://localhost:49262/getInfo.html) 03:02:48 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 03:02:48 INFO - PROCESS | 1668 | colorDepth:24 03:02:48 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 03:02:48 INFO - PROCESS | 1668 | __metrics 03:02:49 INFO - PROCESS | 1668 | 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" 03:02:49 INFO - PROCESS | 1668 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:02:49 INFO - TEST-INFO | 1668: exit 0 03:02:49 INFO - Browser initialized. 03:02:49 INFO - Running cycle 1/1 for kraken test... 03:02:49 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpuRtbQY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:03:01 INFO - PROCESS | 1669 | RSS: Main: 234278912 03:03:01 INFO - PROCESS | 1669 | 03:03:04 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection) 03:03:05 INFO - PROCESS | 1669 | RSS: Main: 294109184 03:03:05 INFO - PROCESS | 1669 | 03:03:07 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-dft) 03:03:08 INFO - PROCESS | 1669 | RSS: Main: 290545664 03:03:08 INFO - PROCESS | 1669 | 03:03:12 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-fft) 03:03:13 INFO - PROCESS | 1669 | RSS: Main: 377360384 03:03:13 INFO - PROCESS | 1669 | 03:03:15 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator) 03:03:15 INFO - PROCESS | 1669 | RSS: Main: 281833472 03:03:15 INFO - PROCESS | 1669 | 03:03:18 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:03:18 INFO - PROCESS | 1669 | RSS: Main: 285118464 03:03:18 INFO - PROCESS | 1669 | 03:03:21 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom) 03:03:22 INFO - PROCESS | 1669 | RSS: Main: 325918720 03:03:22 INFO - PROCESS | 1669 | 03:03:24 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate) 03:03:25 INFO - PROCESS | 1669 | RSS: Main: 328175616 03:03:25 INFO - PROCESS | 1669 | 03:03:28 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial) 03:03:29 INFO - PROCESS | 1669 | RSS: Main: 328175616 03:03:29 INFO - PROCESS | 1669 | 03:03:30 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:03:31 INFO - PROCESS | 1669 | RSS: Main: 299089920 03:03:31 INFO - PROCESS | 1669 | 03:03:33 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:03:33 INFO - PROCESS | 1669 | RSS: Main: 305807360 03:03:33 INFO - PROCESS | 1669 | 03:03:36 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:03:36 INFO - PROCESS | 1669 | RSS: Main: 302190592 03:03:36 INFO - PROCESS | 1669 | 03:03:39 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:03:40 INFO - PROCESS | 1669 | RSS: Main: 312172544 03:03:40 INFO - PROCESS | 1669 | 03:03:43 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:03:43 INFO - PROCESS | 1669 | RSS: Main: 315482112 03:03:43 INFO - PROCESS | 1669 | 03:03:45 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49262/tests/kraken/driver.html?testName=ai-astar) 03:03:45 INFO - PROCESS | 1669 | RSS: Main: 358166528 03:03:45 INFO - PROCESS | 1669 | 03:03:45 INFO - PROCESS | 1669 | __start_tp_report 03:03:45 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 03:03:45 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 03:03:45 INFO - PROCESS | 1669 | |i|pagename|runs| 03:03:45 INFO - PROCESS | 1669 | |0;ai-astar;121;166;170;113;114;113;112;112;112;110 03:03:45 INFO - PROCESS | 1669 | |1;audio-beat-detection;153;111;129;183;134;159;129;113;198;97 03:03:45 INFO - PROCESS | 1669 | |2;audio-dft;187;184;187;184;257;169;248;266;183;180 03:03:45 INFO - PROCESS | 1669 | |3;audio-fft;78;73;77;150;57;57;57;67;138;57 03:03:45 INFO - PROCESS | 1669 | |4;audio-oscillator;84;109;173;99;70;75;144;100;98;148 03:03:45 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;89;85;91;86;88;84;88;85;88;84 03:03:45 INFO - PROCESS | 1669 | |6;imaging-darkroom;93;93;93;95;93;93;93;96;93;95 03:03:45 INFO - PROCESS | 1669 | |7;imaging-desaturate;84;87;84;84;84;86;87;84;85;86 03:03:45 INFO - PROCESS | 1669 | |8;json-parse-financial;56;56;57;55;53;54;55;54;55;52 03:03:45 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;66;65;76;76;72;75;69;68;68;68 03:03:45 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;87;86;96;106;81;85;85;83;87;96 03:03:45 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;123;138;140;137;136;136;137;139;220;142 03:03:45 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;168;166;166;167;167;167;176;167;165;168 03:03:45 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;67;68;68;68;66;66;67;67;66;67 03:03:45 INFO - PROCESS | 1669 | __end_tp_report 03:03:45 INFO - PROCESS | 1669 | __start_cc_report 03:03:45 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,2187 03:03:45 INFO - PROCESS | 1669 | __end_cc_report 03:03:45 INFO - PROCESS | 1669 | __startTimestamp1472119425743__endTimestamp 03:03:45 INFO - PROCESS | 1669 | 03:03:45 INFO - PROCESS | 1669 | ------- Summary: start ------- 03:03:45 INFO - PROCESS | 1669 | Number of tests: 14 03:03:45 INFO - PROCESS | 1669 | 03:03:45 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:124.30 Median:113.50 stddev:23.23 (20.5%) stddev-sans-first:24.61 03:03:45 INFO - PROCESS | 1669 | Values: 121.0 166.0 170.0 113.0 114.0 113.0 112.0 112.0 112.0 110.0 03:03:45 INFO - PROCESS | 1669 | 03:03:45 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:156.00 stddev:32.38 (20.8%) stddev-sans-first:34.03 03:03:45 INFO - PROCESS | 1669 | Values: 153.0 111.0 129.0 183.0 134.0 159.0 129.0 113.0 198.0 97.0 03:03:45 INFO - PROCESS | 1669 | 03:03:45 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:204.50 Median:187.00 stddev:36.83 (19.7%) stddev-sans-first:38.51 03:03:45 INFO - PROCESS | 1669 | Values: 187.0 184.0 187.0 184.0 257.0 169.0 248.0 266.0 183.0 180.0 03:03:45 INFO - PROCESS | 1669 | 03:03:45 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:81.10 Median:62.00 stddev:34.32 (55.3%) stddev-sans-first:36.38 03:03:45 INFO - PROCESS | 1669 | Values: 78.0 73.0 77.0 150.0 57.0 57.0 57.0 67.0 138.0 57.0 03:03:45 INFO - PROCESS | 1669 | 03:03:45 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:72.50 stddev:34.05 (47.0%) stddev-sans-first:34.79 03:03:45 INFO - PROCESS | 1669 | Values: 84.0 109.0 173.0 99.0 70.0 75.0 144.0 100.0 98.0 148.0 03:03:45 INFO - PROCESS | 1669 | 03:03:45 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:88.00 stddev:2.35 (2.7%) stddev-sans-first:2.35 03:03:45 INFO - PROCESS | 1669 | Values: 89.0 85.0 91.0 86.0 88.0 84.0 88.0 85.0 88.0 84.0 03:03:45 INFO - PROCESS | 1669 | 03:03:45 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:93.70 Median:93.00 stddev:1.16 (1.2%) stddev-sans-first:1.20 03:03:45 INFO - PROCESS | 1669 | Values: 93.0 93.0 93.0 95.0 93.0 93.0 93.0 96.0 93.0 95.0 03:03:45 INFO - PROCESS | 1669 | 03:03:45 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.50 stddev:1.29 (1.5%) stddev-sans-first:1.30 03:03:45 INFO - PROCESS | 1669 | Values: 84.0 87.0 84.0 84.0 84.0 86.0 87.0 84.0 85.0 86.0 03:03:45 INFO - PROCESS | 1669 | 03:03:45 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.49 (2.7%) stddev-sans-first:1.51 03:03:45 INFO - PROCESS | 1669 | Values: 56.0 56.0 57.0 55.0 53.0 54.0 55.0 54.0 55.0 52.0 03:03:45 INFO - PROCESS | 1669 | 03:03:45 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:70.50 stddev:4.14 (5.9%) stddev-sans-first:4.09 03:03:45 INFO - PROCESS | 1669 | Values: 66.0 65.0 76.0 76.0 72.0 75.0 69.0 68.0 68.0 68.0 03:03:45 INFO - PROCESS | 1669 | 03:03:45 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:89.20 Median:86.50 stddev:7.71 (8.9%) stddev-sans-first:8.14 03:03:45 INFO - PROCESS | 1669 | Values: 87.0 86.0 96.0 106.0 81.0 85.0 85.0 83.0 87.0 96.0 03:03:45 INFO - PROCESS | 1669 | 03:03:45 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:144.80 Median:138.50 stddev:26.91 (19.4%) stddev-sans-first:27.36 03:03:45 INFO - PROCESS | 1669 | Values: 123.0 138.0 140.0 137.0 136.0 136.0 137.0 139.0 220.0 142.0 03:03:45 INFO - PROCESS | 1669 | 03:03:45 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.70 Median:167.00 stddev:3.06 (1.8%) stddev-sans-first:3.24 03:03:45 INFO - PROCESS | 1669 | Values: 168.0 166.0 166.0 167.0 167.0 167.0 176.0 167.0 165.0 168.0 03:03:45 INFO - PROCESS | 1669 | 03:03:45 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 03:03:45 INFO - PROCESS | 1669 | Values: 67.0 68.0 68.0 68.0 66.0 66.0 67.0 67.0 66.0 67.0 03:03:45 INFO - PROCESS | 1669 | -------- Summary: end -------- 03:03:45 INFO - PROCESS | 1669 | 03:03:46 INFO - TEST-INFO | 1669: exit 0 03:03:46 INFO - TEST-OK | kraken | took 59845ms 03:03:46 INFO - SUITE-END | took 1178s 03:03:46 INFO - Completed test suite (00:19:38) 03:03:46 INFO - javascript benchmark 03:03:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3339.382214290356, 3369.578802649669, 3405.506201600768, 3437.7765445246073, 3462.0825481247457, 4656.674032817704, 5595.272614560102, 5698.886022279552, 5734.885302293957, 5765.394633563473, 5669.518090962263, 5697.230873832032, 5806.245188125548, 5854.121881717744, 5885.352611212763, 5097.362829646294, 5173.689578625275, 5178.922316165242, 5179.378474583055, 5281.8415447536445, 5288.338957630296, 5293.814716484924, 5310.787568497275, 5317.468253174671, 5333.413324534317, 5144.4083930348115, 5189.844304670866, 5191.688498690053, 5248.186531087668, 5277.12927366984, 4370.300751879716, 5187.299714538527, 5255.343082114736, 5261.263423120766, 5266.972940276648, 5140.383154021504, 5157.510036546522, 5217.3999990000875, 5282.550983166436, 5285.947140528622, 5691.573132015115, 5705.657660540381, 5746.02317606008, 5749.482546570787, 5758.078707406795, 5172.586193104543, 6303.747850085991, 6306.400891915261, 6310.0850376695125, 6313.431791138773, 5067.695938243717, 6182.659953702545, 6202.62784232943, 6210.937890621081, 6283.654399008053, 5886.264216972879, 5897.941020589825, 5914.053751399799, 5924.289085309791, 5951.226340575698, 6269.373062693785, 6286.622802631857, 6286.622802631857, 6287.1198032275515, 6289.7169627366875, 6078.635281883101, 6086.107819020229, 6139.890808645427, 6154.892119418548, 6204.5967012144065, 6303.023031430135, 6308.053791931247, 6316.242050953915, 6317.084022816666, 6336.271328797156, 6253.749850005949, 6283.7800676977, 6286.277078135981, 6290.622562646256, 6292.2134733158355, 5184.9740751296, 6091.664958427329, 6163.414475624809, 6200.689965501707, 6274.529410294246, 4983.8504844854715, 4996.200607902718, 4999.47505511916, 4999.500049994971, 5002.499750024968, 4484.68607197493, 4487.304467807429, 4487.304467807495, 4487.977560112244, 4523.570260825217, 5628.943710562924, 5671.0, 5708.429157084258, 5751.769929202868, 5772.682502462405, 6233.096201050822, 6241.563090583706, 6257.5932564383165, 6266.498680105672, 6269.185005949197, 5713.685747283939, 5733.082706766897, 5745.2818397700285, 5746.683932383676, 5799.101139323411, 5348.545373643206, 5403.351597808288, 5414.83755487336, 5420.512153906167, 5460.836174914759, 6214.689265536796, 6331.398517140864, 6344.492440604833, 6355.745770169141, 6356.173697419306, 6260.718267677874, 6267.467265282502, 6271.027990661455, 6281.277653069956, 6299.496040316855, 6184.072389141665, 6203.4416902479, 6356.68216589178, 6368.808935731936, 6379.393957574023, 6155.47678447337, 6206.503479721521, 6241.843953901007, 6285.371462853678, 6293.433590976834, 6245.313015568375, 6305.243370795534, 6322.525810564318, 6328.430441260309, 6338.492920566436, 6029.728662210124, 6142.692865356804, 6167.290761562478, 6183.134361189347, 6210.72051757681, 6035.637861728311, 6097.725602347994, 6105.490073363355, 6125.662799505599, 6193.0, 6070.921985815603, 6079.422454866781, 6080.363685304527, 6108.602940808833, 6133.26400831903, 6136.2636483622255, 6183.196184495987, 6194.938050619617, 6202.7829025985675, 6215.627062376272, 5856.912146317723, 5919.852003699942, 5944.048952167633, 5954.702264886825, 6029.246344206974], "value": 5713.986867041937, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [485.4514398729435, 506.52386756448936, 526.3841305672363, 532.2016974538191, 548.2406866489911, 27388.86305568472, 41563.960900977494, 42612.78693606528, 42672.93317667056, 45315.64053078405, 44393.334099988526, 44644.77677611607, 44733.7763311183, 44885.55114448863, 44933.55066449343, 8849.601767920427, 9782.999999999982, 9974.850377244347, 9981.90018099817, 10002.749931251705, 7560.4707670463085, 9023.278137748965, 9027.864582031274, 9029.503377314246, 12140.817887731691, 12205.694857628587, 12499.937500312486, 12503.312317822516, 12532.93733531331, 12570.560030398938, 12383.690407739834, 12504.937080348182, 12517.937410312936, 12523.749525009449, 12537.31044792536, 12247.652758196591, 12328.75342493145, 12337.568185113567, 12339.753204935942, 12366.876331236663, 41653.0, 41852.0, 41888.581114188775, 41980.79009604932, 42101.57898421007, 3513.2622149348667, 3519.4896739972814, 3535.0, 3723.3484140275345, 3735.6637902588895, 31900.680993190002, 32219.51670724941, 32232.033039008867, 32244.355112897847, 32458.02625921226, 3264.722498587623, 3334.816585087819, 3351.6648335166533, 3355.2786150977413, 3458.170039190576, 502641.0, 504262.0, 504805.0, 504977.0, 509787.9999999963, 61836.690816545626, 62212.68893655593, 62235.0, 62252.0, 62359.06461403082, 34697.30605387878, 35322.470162947575, 35423.291534169686, 36691.266174676355, 65631.67184164049, 16539.173041347884, 16682.416115435903, 16747.581310467092, 16753.413630522875, 16756.07841568701, 12779.105462617528, 12871.549495767604, 12872.742545149045, 12883.355832208352, 12885.0, 16812.663746724997, 17069.7439538407, 18973.65124109323, 19218.519537011685, 19573.608527829365, 7747.0, 7796.727114550963, 7867.449278550446, 7913.8740197622765, 7973.362131029504, 857.7383897911197, 992.4095163377779, 1010.1111022300329, 1041.3439533094102, 1082.3668154129764, 29703.702962970525, 30717.23206919845, 30831.537526937114, 31452.52821207684, 31458.213544661565, 1002.4636819301638, 1023.6877752285625, 1055.456439933435, 1090.4384242115316, 1156.8380426740264, 12617.369131543386, 15567.455139070305, 15927.362905483651, 16007.359705611645, 16244.51266462008, 699647.0, 755070.0, 760967.0, 762775.0, 973467.0, 62003.0, 62723.0, 62881.685591571746, 63158.68420657959, 63167.36832631707, 1385.7990591364196, 1394.372532360442, 1426.1158081989233, 1426.137187001849, 1426.3153686230667, 24036.63945040861, 29217.85391073031, 31952.201194970312, 32042.0, 32868.0, 57857.4214257852, 59198.70400647969, 59351.70324148352, 63588.36411636009, 63676.0, 425017.0, 504531.0, 507183.0, 507824.0, 509903.0, 36362.09094772546, 36995.815020924725, 42798.35802463028, 44395.77802110969, 44733.55266447294, 38798.6120138795, 48841.755791220814, 49060.509394905595, 49443.76390590264, 50318.748406257735, 40052.399214012396, 40150.59849401469, 40248.79875600721, 41432.0, 41788.0, 38957.02607434837, 40325.1934961305, 40583.3912491307, 41334.586654133076, 41545.58454415538, 39257.803710981265, 39362.0, 39996.20007599774, 40330.59669403268, 41192.588074120074, 34417.65582344145, 35012.12469688278, 35636.46545301771, 35804.10489737777, 35922.64077359193, 23620.645690314315, 25750.356241094123, 25851.0, 25895.22314330573, 26289.07988220403], "value": 20986.17715569637, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.2277478160656, 368.1716138687952, 372.44319741985737, 376.8963535027867, 402.663775747251, 15585.142817145052, 16229.918850405746, 19966.900165499188, 20566.38300850975, 20594.0, 18082.095895205253, 21309.36071917841, 21322.786772132313, 21817.01823417946, 22049.11803527857, 5746.425357464262, 5853.297604287492, 5968.074948382986, 6136.723847426854, 6142.570020098595, 4178.958210417887, 5928.614640048383, 6041.033434650457, 6041.365656606059, 6059.818205453844, 6313.431791138796, 6572.93427065728, 6617.933820661804, 6676.098726671886, 6694.297098804628, 6626.602403855784, 6667.066610674485, 6707.3628005339415, 8003.279704826536, 8061.395395345314, 7456.142543607501, 7685.077790665156, 7735.922640773577, 7768.611569421563, 7768.7669369918995, 24412.511749764904, 29468.410631787458, 29846.85076574625, 30031.249218769488, 30518.302655446114, 2302.976970230293, 2394.7126344838557, 2467.198160597795, 2653.6815582130266, 2965.184574242079, 16270.023798572005, 16690.0, 17177.055261960588, 17249.741253881202, 18250.269989200417, 1995.740553728006, 2063.587282543497, 2069.9379018629465, 2092.184048221195, 2114.143771772435, 118984.40507797405, 120323.0, 128126.51557195453, 131070.0, 147252.26373868063, 17320.480385588453, 20678.379648610266, 21565.24521641735, 21566.245181418573, 21795.67306490404, 34937.30125397529, 35020.0, 35116.473252901225, 35173.64826351755, 35179.0, 9362.970073291932, 10455.320404173704, 10827.187960902964, 10962.218034777989, 11187.0, 8952.373333866566, 8976.775580610407, 8980.955095224614, 9136.08639136081, 9175.128362805523, 9589.520523973913, 9842.0, 10008.549615267331, 10012.599496020077, 10029.348092373972, 3346.782459140148, 3476.991672415022, 3681.687056600219, 3783.129880127531, 3784.7729136251914, 890.6125835261682, 902.7878448564582, 910.8523260691576, 928.3084102343797, 1025.9897401025894, 20077.0, 20987.16051357959, 21674.34976950694, 21700.782992169876, 21721.34835954924, 934.72425634438, 937.4328531238639, 947.3747326764302, 947.7683188797935, 993.7515621094726, 10483.737906552396, 10917.290376125526, 10923.126149907988, 10956.28784129029, 10958.232923695265, 605379.0, 618316.0, 621784.0, 622872.0, 623690.1047916156, 104872.47563762132, 121808.0, 124489.0, 131452.02821957678, 131887.34056329657, 819.6680344460503, 976.3068221562628, 1026.5431882812077, 1043.7286305560608, 1049.9685009449577, 19154.329598463988, 19607.803921960596, 19847.702284465457, 19890.90054549718, 19913.0, 52852.0, 56575.434245657016, 56675.433245667016, 57157.714211428676, 57304.85390292088, 54012.729936350064, 76994.0, 79372.0, 79502.0, 80004.0, 7107.609081500567, 7132.821679458055, 7409.62951852416, 7415.369693576106, 8115.918840811516, 10777.0, 11556.94221528887, 12087.879121209027, 12809.0, 13194.208347499181, 10814.783704326026, 10832.350058996486, 11085.722856928318, 11260.0, 11304.49129789145, 10614.575416983544, 10822.56709731602, 10921.453927303763, 11287.830682539605, 11498.425078745862, 9768.902310976799, 11276.210665253353, 11346.829797553208, 11557.82663260035, 11691.356975366436, 7378.335949764547, 7389.778306650809, 7462.96268518654, 7620.390368770374, 7697.307242348215, 9497.952510237405, 10093.444860532742, 10141.391516509033, 10955.890441095806, 11242.494087766234], "value": 10832.024171875777, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1471.9926400367997, 1474.2849717886822, 1512.2665507228992, 1825.5983683589623, 1885.1705249690126, 8492.787680307996, 9014.68448604299, 9015.143561361676, 9034.503102329369, 9036.774080647987, 7805.765827025199, 8098.635561399737, 8471.06818249992, 8751.649934002633, 8792.461319269118, 2376.477175021497, 2401.6037353836596, 2402.1112188490197, 2408.50625621748, 2411.5297516984197, 2367.348979030763, 2377.5958087125146, 2410.843295185807, 2416.0094361311867, 2424.745401732819, 2101.6112019276484, 2188.3434969509162, 2320.9535809283802, 2390.474095698952, 2398.436367453647, 2385.8687772172525, 2386.522695460906, 2411.794997425221, 2415.323709361373, 2415.842970206931, 1850.4171186076478, 2236.7875051870046, 2345.2143531916827, 2361.3034154924167, 2408.759124087595, 8879.556022198864, 8936.017038125801, 8966.820663586692, 8971.416857904216, 8978.551072446351, 5256.579473642138, 5446.428125046853, 5449.128139497701, 5452.2094296327205, 5479.780808767645, 2838.7445129938196, 3611.693006094485, 3746.6253374662588, 3750.6999440044733, 3759.812009399519, 1112.7885701716648, 1134.73901002769, 1785.749995000701, 1842.4656849513758, 1875.6530041942285, 11178.664640060812, 11563.942180289128, 11656.18406711522, 11668.0, 11697.23967942081, 4445.26653102241, 4511.278195488706, 4689.953100468952, 4693.530646935279, 4696.0, 9259.796226490513, 9260.351775375793, 9267.76830579241, 9270.351075424656, 9281.90718092824, 4895.7271109511785, 5010.699358038456, 5293.311869457023, 5293.550048245942, 5295.205719142159, 4783.4499032611, 4930.704157750546, 4958.975205123951, 4959.776810043557, 4960.627952903546, 3651.214988777426, 3657.231981283907, 3697.7226707997006, 3726.087108658396, 3740.4202348636004, 1095.1786160379716, 1133.325671225636, 1147.7704459108045, 1166.5916929074926, 1169.1348402182493, 769.383895690258, 846.6571038729325, 919.8298314811648, 928.6378312458147, 979.3177652028425, 4934.432540257916, 5876.471117599436, 5953.880922381615, 6027.698615069229, 6118.541109416811, 864.8140649760206, 952.5999080386116, 957.2724729205854, 960.0, 973.2165606686543, 3379.642530154066, 3997.0, 4027.9930017495626, 4068.0336671744813, 4108.876733697994, 10615.416152111708, 10829.24195306321, 10879.945600272107, 10896.945515272373, 10905.83641245382, 10038.64864729731, 10613.787724245472, 10617.150627949746, 10782.245242833083, 10856.945715271373, 7919.960400198077, 8148.551829649307, 8161.959190204129, 8177.182281771894, 8179.79550511242, 5084.898302034013, 5683.2895888014, 5880.735366908585, 6078.939210608014, 6178.567500275118, 8527.488350698977, 9723.367981081206, 9934.850977235492, 10149.137323327304, 10266.743331416774, 10001.2999090063, 10291.742706432398, 10354.223433242387, 10420.583176672848, 10436.373817570666, 7596.8480630385975, 7705.807354816175, 7709.575973321297, 7718.189590092959, 7734.381249500139, 8100.189981001853, 8432.53621050848, 8472.02571704262, 8595.31237501011, 8595.785105372415, 7411.4070874328845, 7558.508696934681, 7647.808804779925, 7648.770536883902, 7717.922820771945, 7487.0, 7499.2500749924575, 7518.022657054548, 7573.848523029619, 7583.544987300779, 6794.0, 7035.824104397431, 7129.39400150993, 7156.3559279662995, 7195.244499327495, 5015.498450155102, 5050.747462626928, 5064.215046667772, 5108.438071812024, 5173.1464308388695, 4956.578690811177, 5034.823781167642, 5157.252198431132, 5211.296474975981, 5271.024860400838], "value": 4620.458214885596, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [255.80942198062445, 260.9386794103385, 296.7625899280575, 309.24852608162166, 309.2608665289956, 4432.312991486321, 4884.706917584938, 5306.548943339816, 5354.89290214196, 5392.649477783942, 5089.796408143679, 5174.404943431507, 5315.973420132894, 5371.328583927009, 5372.516473517383, 3859.633334833193, 3893.3770596704535, 4034.273830710471, 4130.56629053948, 4209.536950935395, 4072.470578824749, 4078.3474644056955, 4081.9387709184384, 4091.4272001919753, 4165.458490396244, 3462.671046250602, 3586.399860101432, 3969.027588240885, 4053.9391909121387, 4073.8796830871597, 3191.2341038150907, 3868.3617203161443, 4059.4722686050623, 4084.9183016339507, 4119.0, 3108.3161704424992, 3245.123816569513, 3526.1008442847165, 3529.2235708144167, 3530.122949795908, 5215.713135777531, 5220.4779522047875, 5227.895442091137, 5301.575873930076, 5311.548518375904, 4464.308032255006, 4610.377599024156, 4628.675992680513, 4647.512011238839, 4665.626749860037, 4242.745435273893, 5265.605079619044, 5595.524380427669, 5620.91568626471, 5680.46035626619, 3651.2697460508007, 3856.975088078753, 3865.0530619998, 3868.458415821787, 3893.240818040483, 5125.436202017775, 5875.324337701134, 5896.469317761422, 5902.439268269508, 5914.852128696774, 3390.0846771371594, 3391.440412331987, 3759.191773768598, 3876.7867767272505, 3885.572587015426, 3300.3564304960782, 3478.756487045933, 3914.8629797957506, 3923.313420151462, 3948.6446219840354, 4581.289900065495, 4585.518520555361, 4587.977060114678, 4602.769861506911, 4607.055553611569, 4708.929366059512, 5336.866578335495, 5650.5479561634975, 5652.830415087554, 5692.686902220417, 1318.558282975214, 1331.7003674173427, 1335.5926442434957, 1343.4156142078227, 1347.6091933339417, 776.7397921696182, 801.3949468151508, 821.9383546234056, 822.2024636102971, 829.1915382502133, 4308.793537809418, 5064.265681476165, 5266.815661451831, 5270.525652691276, 5305.946940530623, 5128.615353848401, 5773.5958482906635, 5773.758641892014, 5865.442782935615, 5888.263967004124, 4614.238650622677, 4663.067386522641, 4962.627802914796, 5257.763400646903, 5307.0, 2981.6571094323995, 3047.7866549341334, 3054.8930787422332, 3056.6463822856276, 3057.3885222955496, 5321.494458026481, 5327.493888080626, 5741.971290143522, 6062.181605483203, 6128.3258841527395, 5576.21561100444, 5753.634124037401, 5840.334875171077, 6022.711369679494, 6088.634681919099, 5943.3462319144855, 6061.727222275008, 6072.848178795653, 6077.756889724362, 6093.69531523422, 4672.948586567995, 5728.083506638918, 5781.306243250837, 5807.8548036299435, 5851.834821116215, 4839.395075615548, 5655.1517272409465, 5676.886462270814, 5783.363829978614, 5803.187553742395, 5748.425157484218, 5951.732172052355, 5995.400459953969, 6045.848853778691, 6085.9695701521205, 3627.673509384168, 3792.79139647311, 3848.441975913533, 3860.9227815442973, 3875.2830726314596, 5701.230333904869, 5707.800226992035, 5740.253767010262, 5758.452946970031, 5777.364489906191, 5367.4364191759305, 5609.9158512621525, 5661.575381846295, 5664.603477756517, 5665.0, 5248.501392367719, 5548.112302031655, 5560.833175004756, 5564.360098588552, 5627.606067575231, 4881.487443818348, 5505.394406615349, 5524.33707955048, 5524.861878453071, 5552.250446189874, 4489.420790793438, 5197.818076367309, 5253.973730131325, 5519.806806761744, 5604.943950560442, 4554.997900461893, 4847.636427267898, 5519.69641669712, 5528.226048353154, 5550.916736249041], "value": 4088.122780537333, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.8611870685216, 718.360238859727, 776.5107981971361, 823.6087858267324, 837.4389159263301, 15504.844951550482, 16637.168141592934, 16640.251188696508, 16648.83351166488, 16668.999860008407, 14865.777013344808, 15020.774688379683, 15036.248187590603, 15040.548783536511, 15041.841213345211, 662.7812821768805, 683.7196749332775, 829.3779665251046, 831.5634291996689, 838.7190291252438, 852.7143406958676, 856.1010938514565, 856.824351008045, 859.5916939453772, 862.4652715316481, 913.127962795532, 913.6482454255126, 916.0, 916.4959272400154, 916.8808054952847, 908.0646933658343, 909.077286554148, 910.7586489580267, 911.5077857956695, 913.8674892140668, 523.0976565424612, 528.4424931697058, 529.8251576979587, 531.917552779316, 531.9175527793199, 14486.492972745904, 14978.62553436162, 15008.24958752058, 15011.699766004727, 15070.321835517429, 14281.64295892611, 14628.853711462856, 14855.628609284746, 14916.0, 14974.775378369333, 11846.881531184665, 11869.703257418634, 11950.88049119515, 12015.759684806342, 12224.511019559208, 3878.825452854628, 3900.102976315435, 3944.7238693291483, 3976.741511801724, 4085.9795701021603, 110640.0, 111581.88418115796, 111889.44055279753, 112172.87827121707, 112332.0, 11385.08919286455, 11519.48162332697, 11545.88454115448, 11587.594434194763, 11917.165798394202, 22267.665985010237, 22487.55024899493, 22587.887060564593, 22666.546669066527, 22828.201012964466, 7993.600319983978, 8203.7949051273, 8231.876521852177, 8309.0, 8531.01893282268, 4437.201303765289, 4649.302604609268, 4671.0891376182, 4754.595859351924, 4809.134355815987, 3619.4570814378053, 3758.642928921748, 3765.7175711821724, 3767.566729826105, 3770.0763312988493, 597.7608956417381, 651.7295322441229, 660.1253339325413, 680.0683064202075, 680.2279412866433, 592.8517870532366, 613.5980932489226, 632.2223664892208, 647.439964430764, 692.1989181919737, 9075.954620226856, 9083.409578377385, 9495.0, 9500.287478439144, 9659.420434773936, 645.6965226343611, 670.5004771445305, 671.1275342055309, 674.3795707948699, 682.3722175598461, 3946.8223929923224, 4158.6465150461945, 4186.193981788801, 4553.795079221443, 4767.976160119178, 116034.41982790032, 144484.27757861142, 176722.0, 178277.0, 178504.0, 139443.30278348544, 143544.0, 144443.0, 146972.0, 149491.0, 74640.50718985699, 75579.62210188914, 76470.61764691141, 104850.4757476223, 108543.0, 8959.969603495681, 9849.261305402268, 9954.352967057119, 9984.550695218588, 10020.549075291776, 59187.0, 61935.0, 62040.0, 63048.0, 63513.0, 91081.54459227927, 97160.0, 97697.0, 98824.50587747303, 99246.5037674807, 13002.349882506027, 13305.334733263104, 13316.46734130624, 13445.327733613085, 13746.381412836647, 14841.777373339193, 14872.62818429548, 14999.625009374853, 15049.398024078915, 15723.213839308217, 13718.314084295545, 13722.039457237897, 13879.375428105961, 13985.090969086978, 14110.012299138962, 14104.435822567393, 14112.50606228777, 14128.434862605793, 14130.858691412954, 14248.0, 13648.112872663245, 13687.0, 13725.725485490035, 13823.723525529233, 13835.723285534434, 11250.718732031764, 11299.774004520028, 11385.544578216779, 11476.655700329004, 11770.58802941893, 9615.615375385187, 9973.900260997298, 9983.750406239611, 10296.433696146485, 10301.536430860779], "value": 7897.513671939696, "unit": "score"}], "name": "dromaeo_css", "value": 7607.147473430258, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 166.0, 170.0, 113.0, 114.0, 113.0, 112.0, 112.0, 112.0, 110.0], "value": 124.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 111.0, 129.0, 183.0, 134.0, 159.0, 129.0, 113.0, 198.0, 97.0], "value": 140.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 184.0, 187.0, 184.0, 257.0, 169.0, 248.0, 266.0, 183.0, 180.0], "value": 204.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 73.0, 77.0, 150.0, 57.0, 57.0, 57.0, 67.0, 138.0, 57.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 109.0, 173.0, 99.0, 70.0, 75.0, 144.0, 100.0, 98.0, 148.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 91.0, 86.0, 88.0, 84.0, 88.0, 85.0, 88.0, 84.0], "value": 86.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 95.0, 93.0, 93.0, 93.0, 96.0, 93.0, 95.0], "value": 93.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 84.0, 84.0, 84.0, 86.0, 87.0, 84.0, 85.0, 86.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 55.0, 53.0, 54.0, 55.0, 54.0, 55.0, 52.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 76.0, 76.0, 72.0, 75.0, 69.0, 68.0, 68.0, 68.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 96.0, 106.0, 81.0, 85.0, 85.0, 83.0, 87.0, 96.0], "value": 89.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 138.0, 140.0, 137.0, 136.0, 136.0, 137.0, 139.0, 220.0, 142.0], "value": 144.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 166.0, 167.0, 167.0, 167.0, 176.0, 167.0, 165.0, 168.0], "value": 167.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 68.0, 66.0, 66.0, 67.0, 67.0, 66.0, 67.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1519.8000000000002, "alertThreshold": 2.0}]} 03:03:46 INFO - Return code: 0 03:03:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:03:47 INFO - # TBPL SUCCESS # 03:03:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:03:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:03:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:03:47 INFO - 2016-08-25 03:03:47.056 screenresolution[1673:10431] starting screenresolution argv=screenresolution get 03:03:47 INFO - 2016-08-25 03:03:47.059 screenresolution[1673:10431] Display 0: 1600x1200x32@60 03:03:47 INFO - 2016-08-25 03:03:47.065 screenresolution[1674:10434] starting screenresolution argv=screenresolution list 03:03:47 INFO - Available Modes on Display 0 03:03:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:03:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:03:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:03:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:03:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:03:47 INFO - Intel Iris: 03:03:47 INFO - Chipset Model: Intel Iris 03:03:47 INFO - Type: GPU 03:03:47 INFO - Bus: Built-In 03:03:47 INFO - VRAM (Dynamic, Max): 1536 MB 03:03:47 INFO - Vendor: Intel (0x8086) 03:03:47 INFO - Device ID: 0x0a2e 03:03:47 INFO - Revision ID: 0x0009 03:03:47 INFO - Displays: 03:03:47 INFO - Display: 03:03:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:03:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:03:47 INFO - Display Serial Number: 1600x1200 60 03:03:47 INFO - Main Display: Yes 03:03:47 INFO - Mirror: Off 03:03:47 INFO - Online: Yes 03:03:47 INFO - Rotation: Supported 03:03:47 INFO - Return code: 0 03:03:47 INFO - Running post-action listener: _resource_record_post_action 03:03:47 INFO - [mozharness: 2016-08-25 10:03:47.310864Z] Finished run-tests step (success) 03:03:47 INFO - Running post-run listener: _resource_record_post_run 03:03:47 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 32730112; Write bytes: 704904192; Read time: 305; Write time: 2065 03:03:47 INFO - TinderboxPrint: CPU usage
53.6% 03:03:47 INFO - TinderboxPrint: I/O read bytes / time
32,730,112 / 305 03:03:47 INFO - TinderboxPrint: I/O write bytes / time
704,904,192 / 2,065 03:03:47 INFO - TinderboxPrint: CPU idle
2,251.6 (46.4%) 03:03:47 INFO - TinderboxPrint: CPU system
971.3 (20.0%) 03:03:47 INFO - TinderboxPrint: CPU user
1,630.7 (33.6%) 03:03:47 INFO - TinderboxPrint: Swap in / out
434,249,728 / 0 03:03:47 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 401289728; Write bytes: 394716672; Read time: 29700; Write time: 687 03:03:47 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 30653440; Write bytes: 296257024; Read time: 282; Write time: 1341 03:03:47 INFO - Running post-run listener: _upload_blobber_files 03:03:47 INFO - Blob upload gear active. 03:03:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:03:47 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 03:03:47 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:03:47 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:03:48 INFO - (blobuploader) - INFO - Open directory for files ... 03:03:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:03:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:03:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:03:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:03:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:03:49 INFO - (blobuploader) - INFO - Done attempting. 03:03:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:03:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:03:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:03:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:03:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:03:50 INFO - (blobuploader) - INFO - Done attempting. 03:03:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:03:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:03:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:03:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:03:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:03:52 INFO - (blobuploader) - INFO - Done attempting. 03:03:52 INFO - (blobuploader) - INFO - Iteration through files over. 03:03:52 INFO - Return code: 0 03:03:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:03:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:03:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a2f05f744fa0fb2b4127398266a0aed9dd7e2a3995ce6507515b9d5c111ea19b473dfeeead6f28b9b4b4e897fd55ad33a3f3a8c2b8615243afbebf66e1937459", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/46ed101cd78ee68931010e78bc885523fe7ea09864fc70171580fc795f215f145a63ae0c6bd7794a09e736d30a93b75806c99a306b442334fa39252ea6e590d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8d6bfaa9a396b838e427d86fb5bc42a76dcdbced1a4d70dbdb6a012a24850f1cbafe20c0e89498385770cd8cbc63bccb6488987cc64a3610c6ed3dd1ada50f3f"} 03:03:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:03:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:03:52 INFO - Contents: 03:03:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a2f05f744fa0fb2b4127398266a0aed9dd7e2a3995ce6507515b9d5c111ea19b473dfeeead6f28b9b4b4e897fd55ad33a3f3a8c2b8615243afbebf66e1937459", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/46ed101cd78ee68931010e78bc885523fe7ea09864fc70171580fc795f215f145a63ae0c6bd7794a09e736d30a93b75806c99a306b442334fa39252ea6e590d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8d6bfaa9a396b838e427d86fb5bc42a76dcdbced1a4d70dbdb6a012a24850f1cbafe20c0e89498385770cd8cbc63bccb6488987cc64a3610c6ed3dd1ada50f3f"} 03:03:52 INFO - Running post-run listener: copy_logs_to_upload_dir 03:03:52 INFO - Copying logs to upload dir... 03:03:52 INFO - mkdir: /builds/slave/test/build/upload/logs 03:03:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.809564 ========= master_lag: 54.19 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 8 secs) (at 2016-08-25 03:04:46.714001) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 03:04:46.717970) ========= 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.Z4liThkLnR/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.cmH2V0LtpX/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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/Autoland/sha512/a2f05f744fa0fb2b4127398266a0aed9dd7e2a3995ce6507515b9d5c111ea19b473dfeeead6f28b9b4b4e897fd55ad33a3f3a8c2b8615243afbebf66e1937459", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/46ed101cd78ee68931010e78bc885523fe7ea09864fc70171580fc795f215f145a63ae0c6bd7794a09e736d30a93b75806c99a306b442334fa39252ea6e590d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8d6bfaa9a396b838e427d86fb5bc42a76dcdbced1a4d70dbdb6a012a24850f1cbafe20c0e89498385770cd8cbc63bccb6488987cc64a3610c6ed3dd1ada50f3f"} build_url:https://queue.taskcluster.net/v1/task/bMagraWMTKWjs4tOXJ9r3g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011801 build_url: 'https://queue.taskcluster.net/v1/task/bMagraWMTKWjs4tOXJ9r3g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a2f05f744fa0fb2b4127398266a0aed9dd7e2a3995ce6507515b9d5c111ea19b473dfeeead6f28b9b4b4e897fd55ad33a3f3a8c2b8615243afbebf66e1937459", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/46ed101cd78ee68931010e78bc885523fe7ea09864fc70171580fc795f215f145a63ae0c6bd7794a09e736d30a93b75806c99a306b442334fa39252ea6e590d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8d6bfaa9a396b838e427d86fb5bc42a76dcdbced1a4d70dbdb6a012a24850f1cbafe20c0e89498385770cd8cbc63bccb6488987cc64a3610c6ed3dd1ada50f3f"}' ========= master_lag: 0.79 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 03:04:47.517993) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 25 secs) (at 2016-08-25 03:04:47.518311) ========= 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.Z4liThkLnR/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.cmH2V0LtpX/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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.005043 ========= master_lag: 25.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 25 secs) (at 2016-08-25 03:05:12.529386) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 03:05:12.529688) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 03:05:13.129826) ========= ========= Total master_lag: 80.06 =========