builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0152 starttime: 1474684746.13 results: success (0) buildid: 20160923184424 builduid: 0e5b4dbf27484a76850fc9076ef74e12 revision: 735ae776c393e7c2f7c9d64a12a61b5f7689a583 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 19:39:06.127504) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 19:39:06.127915) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 19:39:06.128252) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 19:39:06.266627) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 19:39:06.266887) ========= 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.LXRezOv0hV/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.6bKt9fPpxN/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-23 19:39:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.91M=0.001s 2016-09-23 19:39:06 (8.91 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.598450 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 19:39:06.889863) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 19:39:06.890173) ========= 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.LXRezOv0hV/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.6bKt9fPpxN/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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.029305 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 19:39:06.939592) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 19:39:06.939930) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 735ae776c393e7c2f7c9d64a12a61b5f7689a583 --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 735ae776c393e7c2f7c9d64a12a61b5f7689a583 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LXRezOv0hV/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.6bKt9fPpxN/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-23 19:39:07,016 truncating revision to first 12 chars 2016-09-23 19:39:07,017 Setting DEBUG logging. 2016-09-23 19:39:07,017 attempt 1/10 2016-09-23 19:39:07,017 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/735ae776c393?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 19:39:07,829 unpacking tar archive at: autoland-735ae776c393/testing/mozharness/ program finished with exit code 0 elapsedTime=1.092504 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 19:39:08.055267) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 19:39:08.055570) ========= script_repo_revision: 735ae776c393e7c2f7c9d64a12a61b5f7689a583 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 19:39:08.055971) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 19:39:08.056260) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 19:39:08.076044) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-23 19:39:08.076670) ========= /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.LXRezOv0hV/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.6bKt9fPpxN/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 19:39:08 INFO - MultiFileLogger online at 20160923 19:39:08 in /builds/slave/test 19:39:08 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 19:39:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:39:08 INFO - {'append_to_log': False, 19:39:08 INFO - 'base_work_dir': '/builds/slave/test', 19:39:08 INFO - 'blob_upload_branch': 'Autoland', 19:39:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:39:08 INFO - 'branch': 'Autoland', 19:39:08 INFO - 'buildbot_json_path': 'buildprops.json', 19:39:08 INFO - 'config_files': ('talos/mac_config.py',), 19:39:08 INFO - 'default_actions': ('clobber', 19:39:08 INFO - 'read-buildbot-config', 19:39:08 INFO - 'download-and-extract', 19:39:08 INFO - 'populate-webroot', 19:39:08 INFO - 'create-virtualenv', 19:39:08 INFO - 'install', 19:39:08 INFO - 'run-tests'), 19:39:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:39:08 INFO - 'download_minidump_stackwalk': True, 19:39:08 INFO - 'download_symbols': 'ondemand', 19:39:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:39:08 INFO - 'tooltool.py': '/tools/tooltool.py', 19:39:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:39:08 INFO - '/tools/misc-python/virtualenv.py')}, 19:39:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:39:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:39:08 INFO - 'installer_path': 'installer.exe', 19:39:08 INFO - 'log_level': 'info', 19:39:08 INFO - 'log_name': 'talos', 19:39:08 INFO - 'log_to_console': True, 19:39:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:39:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:39:08 INFO - 'opt_config_files': (), 19:39:08 INFO - 'pip_index': False, 19:39:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:39:08 INFO - 'cmd': ('bash', 19:39:08 INFO - '-c', 19:39:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:39:08 INFO - 'enabled': True, 19:39:08 INFO - 'halt_on_failure': False, 19:39:08 INFO - 'name': 'check_screen_resolution'},), 19:39:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:39:08 INFO - 'cmd': ('bash', 19:39:08 INFO - '-c', 19:39:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:39:08 INFO - 'enabled': True, 19:39:08 INFO - 'halt_on_failure': False, 19:39:08 INFO - 'name': 'check_screen_resolution'},), 19:39:08 INFO - 'run_cmd_checks_enabled': True, 19:39:08 INFO - 'sps_profile': False, 19:39:08 INFO - 'sps_profile_interval': 0, 19:39:08 INFO - 'suite': 'dromaeojs', 19:39:08 INFO - 'system_bits': '32', 19:39:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:39:08 INFO - 'title': 't-yosemite-r7-0152', 19:39:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:39:08 INFO - 'use_talos_json': True, 19:39:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:39:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:39:08 INFO - 'work_dir': 'build'} 19:39:08 INFO - [mozharness: 2016-09-24 02:39:08.286135Z] Running clobber step. 19:39:08 INFO - Running pre-action listener: _resource_record_pre_action 19:39:08 INFO - Running main action method: clobber 19:39:08 INFO - rmtree: /builds/slave/test/build 19:39:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:39:10 INFO - Running post-action listener: _resource_record_post_action 19:39:10 INFO - [mozharness: 2016-09-24 02:39:10.450758Z] Finished clobber step (success) 19:39:10 INFO - [mozharness: 2016-09-24 02:39:10.450875Z] Running read-buildbot-config step. 19:39:10 INFO - Running pre-action listener: _resource_record_pre_action 19:39:10 INFO - Running main action method: read_buildbot_config 19:39:10 INFO - Using buildbot properties: 19:39:10 INFO - { 19:39:10 INFO - "project": "", 19:39:10 INFO - "product": "firefox", 19:39:10 INFO - "script_repo_revision": "production", 19:39:10 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 19:39:10 INFO - "repository": "", 19:39:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 19:39:10 INFO - "buildid": "20160923184424", 19:39:10 INFO - "pgo_build": "False", 19:39:10 INFO - "basedir": "/builds/slave/test", 19:39:10 INFO - "buildnumber": 190, 19:39:10 INFO - "slavename": "t-yosemite-r7-0152", 19:39:10 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 19:39:10 INFO - "platform": "yosemite_r7", 19:39:10 INFO - "scheduler": "tests-autoland-macosx64-talos", 19:39:10 INFO - "branch": "autoland", 19:39:10 INFO - "repo_path": "integration/autoland", 19:39:10 INFO - "revision": "735ae776c393e7c2f7c9d64a12a61b5f7689a583", 19:39:10 INFO - "stage_platform": "macosx64", 19:39:10 INFO - "builduid": "0e5b4dbf27484a76850fc9076ef74e12", 19:39:10 INFO - "slavebuilddir": "test" 19:39:10 INFO - } 19:39:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/R6LlDlZETNSMr8PD5gv6iQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 19:39:10 INFO - Running post-action listener: _resource_record_post_action 19:39:10 INFO - [mozharness: 2016-09-24 02:39:10.454077Z] Finished read-buildbot-config step (success) 19:39:10 INFO - [mozharness: 2016-09-24 02:39:10.454184Z] Running download-and-extract step. 19:39:10 INFO - Running pre-action listener: _resource_record_pre_action 19:39:10 INFO - Running main action method: download_and_extract 19:39:10 INFO - mkdir: /builds/slave/test/build/tests 19:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:39:10 INFO - trying https://queue.taskcluster.net/v1/task/R6LlDlZETNSMr8PD5gv6iQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 19:39:10 INFO - Downloading https://queue.taskcluster.net/v1/task/R6LlDlZETNSMr8PD5gv6iQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 19:39:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R6LlDlZETNSMr8PD5gv6iQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 19:39:11 INFO - Downloaded 1199 bytes. 19:39:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 19:39:11 INFO - Using the following test package requirements: 19:39:11 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 19:39:11 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:39:11 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 19:39:11 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:39:11 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 19:39:11 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:39:11 INFO - u'jsshell-mac.zip'], 19:39:11 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:39:11 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 19:39:11 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 19:39:11 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:39:11 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 19:39:11 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:39:11 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 19:39:11 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:39:11 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 19:39:11 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:39:11 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 19:39:11 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:39:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R6LlDlZETNSMr8PD5gv6iQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 19:39:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R6LlDlZETNSMr8PD5gv6iQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:39:11 INFO - Fetch https://queue.taskcluster.net/v1/task/R6LlDlZETNSMr8PD5gv6iQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 19:39:12 INFO - Expected file size: 16438956 19:39:19 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:39:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R6LlDlZETNSMr8PD5gv6iQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 19:39:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R6LlDlZETNSMr8PD5gv6iQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:39:19 INFO - Fetch https://queue.taskcluster.net/v1/task/R6LlDlZETNSMr8PD5gv6iQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 19:39:20 INFO - Expected file size: 16438956 19:39:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R6LlDlZETNSMr8PD5gv6iQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 19:39:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R6LlDlZETNSMr8PD5gv6iQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:39:27 INFO - Fetch https://queue.taskcluster.net/v1/task/R6LlDlZETNSMr8PD5gv6iQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 19:39:27 INFO - Expected file size: 14414059 19:39:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:39:28 INFO - trying https://queue.taskcluster.net/v1/task/R6LlDlZETNSMr8PD5gv6iQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 19:39:28 INFO - Downloading https://queue.taskcluster.net/v1/task/R6LlDlZETNSMr8PD5gv6iQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 19:39:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R6LlDlZETNSMr8PD5gv6iQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 19:39:31 INFO - Downloaded 111576455 bytes. 19:39:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R6LlDlZETNSMr8PD5gv6iQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 19:39:31 INFO - mkdir: /builds/slave/test/properties 19:39:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:39:31 INFO - Writing to file /builds/slave/test/properties/build_url 19:39:31 INFO - Contents: 19:39:31 INFO - build_url:https://queue.taskcluster.net/v1/task/R6LlDlZETNSMr8PD5gv6iQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 19:39:32 INFO - Running post-action listener: _resource_record_post_action 19:39:32 INFO - Running post-action listener: set_extra_try_arguments 19:39:32 INFO - [mozharness: 2016-09-24 02:39:32.047605Z] Finished download-and-extract step (success) 19:39:32 INFO - [mozharness: 2016-09-24 02:39:32.047721Z] Running populate-webroot step. 19:39:32 INFO - Running pre-action listener: _resource_record_pre_action 19:39:32 INFO - Running main action method: populate_webroot 19:39:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:39:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:39:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:39:32 INFO - '--tppagecycles', 19:39:32 INFO - '7'], 19:39:32 INFO - 'tests': ['tsvgm']}}, 19:39:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:39:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:39:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:39:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:39:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:39:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:39:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:32 INFO - 'talos_options': ['--disable-e10s'], 19:39:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:39:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:39:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:32 INFO - 'talos_options': ['--disable-e10s'], 19:39:32 INFO - 'tests': ['damp', 'tps']}, 19:39:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:32 INFO - 'tests': ['damp', 'tps']}, 19:39:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:39:32 INFO - 'tests': ['dromaeo_dom']}, 19:39:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:39:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:39:32 INFO - 'tests': ['basic_compositor_video']}, 19:39:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:39:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:39:32 INFO - 'tests': ['a11yr', 19:39:32 INFO - 'ts_paint', 19:39:32 INFO - 'tpaint', 19:39:32 INFO - 'sessionrestore', 19:39:32 INFO - 'sessionrestore_no_auto_restore', 19:39:32 INFO - 'tabpaint']}, 19:39:32 INFO - 'other-e10s': {'tests': ['a11yr', 19:39:32 INFO - 'ts_paint', 19:39:32 INFO - 'tpaint', 19:39:32 INFO - 'sessionrestore', 19:39:32 INFO - 'sessionrestore_no_auto_restore', 19:39:32 INFO - 'tabpaint']}, 19:39:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:39:32 INFO - 'ts_paint', 19:39:32 INFO - 'tpaint', 19:39:32 INFO - 'sessionrestore', 19:39:32 INFO - 'sessionrestore_no_auto_restore', 19:39:32 INFO - 'tabpaint']}, 19:39:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:39:32 INFO - 'ts_paint', 19:39:32 INFO - 'tpaint', 19:39:32 INFO - 'sessionrestore', 19:39:32 INFO - 'sessionrestore_no_auto_restore', 19:39:32 INFO - 'tabpaint']}, 19:39:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:39:32 INFO - 'tests': ['a11yr', 19:39:32 INFO - 'ts_paint', 19:39:32 INFO - 'tpaint', 19:39:32 INFO - 'sessionrestore', 19:39:32 INFO - 'sessionrestore_no_auto_restore', 19:39:32 INFO - 'tabpaint']}, 19:39:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:39:32 INFO - 'tests': ['a11yr', 19:39:32 INFO - 'ts_paint', 19:39:32 INFO - 'tpaint', 19:39:32 INFO - 'sessionrestore', 19:39:32 INFO - 'sessionrestore_no_auto_restore', 19:39:32 INFO - 'tabpaint']}, 19:39:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:39:32 INFO - 'tests': ['tsvgx', 19:39:32 INFO - 'tsvgr_opacity', 19:39:32 INFO - 'tart', 19:39:32 INFO - 'tscrollx', 19:39:32 INFO - 'cart']}, 19:39:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:39:32 INFO - 'tsvgr_opacity', 19:39:32 INFO - 'tart', 19:39:32 INFO - 'tscrollx', 19:39:32 INFO - 'cart']}, 19:39:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:32 INFO - 'talos_options': ['--disable-e10s'], 19:39:32 INFO - 'tests': ['tp5o']}, 19:39:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:32 INFO - 'tests': ['tp5o']}, 19:39:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:32 INFO - 'talos_options': ['--disable-e10s', 19:39:32 INFO - '--xperf_path', 19:39:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:39:32 INFO - 'tests': ['tp5n']}, 19:39:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:39:32 INFO - 'talos_options': ['--xperf_path', 19:39:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:39:32 INFO - 'tests': ['tp5n']}}, 19:39:32 INFO - 'talos.zip': {'path': '', 19:39:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:39:32 INFO - Running post-action listener: _resource_record_post_action 19:39:32 INFO - [mozharness: 2016-09-24 02:39:32.066496Z] Finished populate-webroot step (success) 19:39:32 INFO - [mozharness: 2016-09-24 02:39:32.066626Z] Running create-virtualenv step. 19:39:32 INFO - Running pre-action listener: _resource_record_pre_action 19:39:32 INFO - Running main action method: create_virtualenv 19:39:32 INFO - Creating virtualenv /builds/slave/test/build/venv 19:39:32 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 19:39:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:39:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:39:32 INFO - Using real prefix '/tools/python27' 19:39:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:39:33 INFO - Installing distribute.............................................................................................................................................................................................done. 19:39:35 INFO - Installing pip.................done. 19:39:35 INFO - Return code: 0 19:39:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:39:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:39:36 INFO - Reading from file tmpfile_stdout 19:39:36 INFO - Output received: 19:39:36 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 19:39:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:39:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:39:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:39:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:36 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 0x10ad53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdf851df10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab67d30>, '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 0x10a98ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5fb20>, '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.LXRezOv0hV/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.6bKt9fPpxN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 19:39:36 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 19:39:36 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 19:39:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LXRezOv0hV/Render', 19:39:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:39:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:39:36 INFO - 'HOME': '/Users/cltbld', 19:39:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:39:36 INFO - 'LOGNAME': 'cltbld', 19:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:36 INFO - 'MOZ_NO_REMOTE': '1', 19:39:36 INFO - 'NO_EM_RESTART': '1', 19:39:36 INFO - 'PAGER': '/bin/cat', 19:39:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:36 INFO - 'PWD': '/builds/slave/test', 19:39:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:39:36 INFO - 'SHELL': '/bin/bash', 19:39:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6bKt9fPpxN/Listeners', 19:39:36 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 19:39:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:39:36 INFO - 'USER': 'cltbld', 19:39:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:39:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:36 INFO - 'XPC_FLAGS': '0x0', 19:39:36 INFO - 'XPC_SERVICE_NAME': '0', 19:39:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:39:36 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 19:39:36 INFO - Cleaning up... 19:39:36 INFO - Return code: 0 19:39:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:39:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:39:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:39:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:36 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 0x10ad53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdf851df10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab67d30>, '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 0x10a98ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5fb20>, '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.LXRezOv0hV/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.6bKt9fPpxN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 19:39:36 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 19:39:36 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 19:39:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LXRezOv0hV/Render', 19:39:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:39:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:39:36 INFO - 'HOME': '/Users/cltbld', 19:39:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:39:36 INFO - 'LOGNAME': 'cltbld', 19:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:36 INFO - 'MOZ_NO_REMOTE': '1', 19:39:36 INFO - 'NO_EM_RESTART': '1', 19:39:36 INFO - 'PAGER': '/bin/cat', 19:39:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:36 INFO - 'PWD': '/builds/slave/test', 19:39:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:39:36 INFO - 'SHELL': '/bin/bash', 19:39:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6bKt9fPpxN/Listeners', 19:39:36 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 19:39:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:39:36 INFO - 'USER': 'cltbld', 19:39:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:39:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:36 INFO - 'XPC_FLAGS': '0x0', 19:39:36 INFO - 'XPC_SERVICE_NAME': '0', 19:39:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:39:36 INFO - Downloading/unpacking psutil>=3.1.1 19:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:39:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:39:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:39:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:39:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:39:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:39:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:39:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:39:40 INFO - Installing collected packages: psutil 19:39:40 INFO - Running setup.py install for psutil 19:39:40 INFO - building 'psutil._psutil_osx' extension 19:39:40 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 19:39:40 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 19:39:41 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 19:39:41 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 19:39:41 INFO - building 'psutil._psutil_posix' extension 19:39:41 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 19:39:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:39:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:39:41 INFO - ^ 19:39:41 INFO - 1 warning generated. 19:39:41 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 19:39:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:39:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:39:41 INFO - Successfully installed psutil 19:39:41 INFO - Cleaning up... 19:39:41 INFO - Return code: 0 19:39:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:39: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')]} 19:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:39:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39: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')]} 19:39:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:39:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:41 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 0x10ad53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdf851df10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab67d30>, '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 0x10a98ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5fb20>, '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.LXRezOv0hV/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.6bKt9fPpxN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 19:39:41 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 19:39:41 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 19:39:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LXRezOv0hV/Render', 19:39:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:39:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:39:41 INFO - 'HOME': '/Users/cltbld', 19:39:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:39:41 INFO - 'LOGNAME': 'cltbld', 19:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:41 INFO - 'MOZ_NO_REMOTE': '1', 19:39:41 INFO - 'NO_EM_RESTART': '1', 19:39:41 INFO - 'PAGER': '/bin/cat', 19:39:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:41 INFO - 'PWD': '/builds/slave/test', 19:39:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:39:41 INFO - 'SHELL': '/bin/bash', 19:39:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6bKt9fPpxN/Listeners', 19:39:41 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 19:39:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:39:41 INFO - 'USER': 'cltbld', 19:39:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:39:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:41 INFO - 'XPC_FLAGS': '0x0', 19:39:41 INFO - 'XPC_SERVICE_NAME': '0', 19:39:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:39:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:39:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:39:41 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 19:39:41 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 19:39:41 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 19:39:41 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 19:39:41 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 19:39:41 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 19:39:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:39:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:39:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:39:44 INFO - Installing collected packages: mozsystemmonitor 19:39:44 INFO - Running setup.py install for mozsystemmonitor 19:39:44 INFO - Successfully installed mozsystemmonitor 19:39:44 INFO - Cleaning up... 19:39:44 INFO - Return code: 0 19:39:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:39:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:39:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:39:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:44 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 0x10ad53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdf851df10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab67d30>, '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 0x10a98ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5fb20>, '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.LXRezOv0hV/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.6bKt9fPpxN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 19:39:44 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 19:39:44 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 19:39:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LXRezOv0hV/Render', 19:39:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:39:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:39:44 INFO - 'HOME': '/Users/cltbld', 19:39:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:39:44 INFO - 'LOGNAME': 'cltbld', 19:39:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:44 INFO - 'MOZ_NO_REMOTE': '1', 19:39:44 INFO - 'NO_EM_RESTART': '1', 19:39:44 INFO - 'PAGER': '/bin/cat', 19:39:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:39:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:44 INFO - 'PWD': '/builds/slave/test', 19:39:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:39:44 INFO - 'SHELL': '/bin/bash', 19:39:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6bKt9fPpxN/Listeners', 19:39:44 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 19:39:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:39:44 INFO - 'USER': 'cltbld', 19:39:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:39:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:39:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:44 INFO - 'XPC_FLAGS': '0x0', 19:39:44 INFO - 'XPC_SERVICE_NAME': '0', 19:39:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:39:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:39:44 INFO - Downloading/unpacking jsonschema==2.5.1 19:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:39:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:39:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:39:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:39:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:39:47 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 19:39:47 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 19:39:47 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 19:39:47 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 19:39:47 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 19:39:47 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 19:39:47 INFO - Downloading functools32-3.2.3-2.tar.gz 19:39:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:39:47 INFO - warning: no files found matching '*.txt' 19:39:47 INFO - no previously-included directories found matching 'build' 19:39:47 INFO - no previously-included directories found matching 'dist' 19:39:47 INFO - no previously-included directories found matching '.git*' 19:39:47 INFO - Installing collected packages: jsonschema, functools32 19:39:47 INFO - Running setup.py install for functools32 19:39:47 INFO - warning: no files found matching '*.txt' 19:39:47 INFO - no previously-included directories found matching 'build' 19:39:47 INFO - no previously-included directories found matching 'dist' 19:39:47 INFO - no previously-included directories found matching '.git*' 19:39:47 INFO - Successfully installed jsonschema functools32 19:39:47 INFO - Cleaning up... 19:39:48 INFO - Return code: 0 19:39:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:39:48 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')]} 19:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:39:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:48 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')]} 19:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:39:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:48 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 0x10ad53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdf851df10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab67d30>, '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 0x10a98ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5fb20>, '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.LXRezOv0hV/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.6bKt9fPpxN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 19:39:48 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 19:39:48 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 19:39:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LXRezOv0hV/Render', 19:39:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:39:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:39:48 INFO - 'HOME': '/Users/cltbld', 19:39:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:39:48 INFO - 'LOGNAME': 'cltbld', 19:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:48 INFO - 'MOZ_NO_REMOTE': '1', 19:39:48 INFO - 'NO_EM_RESTART': '1', 19:39:48 INFO - 'PAGER': '/bin/cat', 19:39:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:48 INFO - 'PWD': '/builds/slave/test', 19:39:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:39:48 INFO - 'SHELL': '/bin/bash', 19:39:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6bKt9fPpxN/Listeners', 19:39:48 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 19:39:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:39:48 INFO - 'USER': 'cltbld', 19:39:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:39:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:48 INFO - 'XPC_FLAGS': '0x0', 19:39:48 INFO - 'XPC_SERVICE_NAME': '0', 19:39:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:39:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:39:48 INFO - Cleaning up... 19:39:48 INFO - Return code: 0 19:39:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:39:48 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')]} 19:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:39:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:48 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')]} 19:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:39:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:48 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 0x10ad53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdf851df10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab67d30>, '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 0x10a98ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5fb20>, '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.LXRezOv0hV/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.6bKt9fPpxN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 19:39:48 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 19:39:48 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 19:39:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LXRezOv0hV/Render', 19:39:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:39:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:39:48 INFO - 'HOME': '/Users/cltbld', 19:39:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:39:48 INFO - 'LOGNAME': 'cltbld', 19:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:48 INFO - 'MOZ_NO_REMOTE': '1', 19:39:48 INFO - 'NO_EM_RESTART': '1', 19:39:48 INFO - 'PAGER': '/bin/cat', 19:39:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:48 INFO - 'PWD': '/builds/slave/test', 19:39:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:39:48 INFO - 'SHELL': '/bin/bash', 19:39:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6bKt9fPpxN/Listeners', 19:39:48 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 19:39:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:39:48 INFO - 'USER': 'cltbld', 19:39:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:39:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:48 INFO - 'XPC_FLAGS': '0x0', 19:39:48 INFO - 'XPC_SERVICE_NAME': '0', 19:39:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:39:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:39:48 INFO - Downloading/unpacking blobuploader==1.2.4 19:39:48 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 19:39:48 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 19:39:48 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 19:39:48 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 19:39:48 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 19:39:48 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 19:39:51 INFO - Downloading blobuploader-1.2.4.tar.gz 19:39:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:39:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:39:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:39:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:39:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:39:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:39:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:39:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:39:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:39:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:39:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:39:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:39:52 INFO - Downloading docopt-0.6.1.tar.gz 19:39:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:39:52 INFO - Installing collected packages: blobuploader, requests, docopt 19:39:52 INFO - Running setup.py install for blobuploader 19:39:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:39:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:39:52 INFO - Running setup.py install for requests 19:39:53 INFO - Running setup.py install for docopt 19:39:53 INFO - Successfully installed blobuploader requests docopt 19:39:53 INFO - Cleaning up... 19:39:53 INFO - Return code: 0 19:39:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:39:53 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')]} 19:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:39:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:53 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')]} 19:39:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:39:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:53 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 0x10ad53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdf851df10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab67d30>, '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 0x10a98ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5fb20>, '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.LXRezOv0hV/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.6bKt9fPpxN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 19:39:53 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 19:39:53 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 19:39:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LXRezOv0hV/Render', 19:39:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:39:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:39:53 INFO - 'HOME': '/Users/cltbld', 19:39:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:39:53 INFO - 'LOGNAME': 'cltbld', 19:39:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:53 INFO - 'MOZ_NO_REMOTE': '1', 19:39:53 INFO - 'NO_EM_RESTART': '1', 19:39:53 INFO - 'PAGER': '/bin/cat', 19:39:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:39:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:53 INFO - 'PWD': '/builds/slave/test', 19:39:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:39:53 INFO - 'SHELL': '/bin/bash', 19:39:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6bKt9fPpxN/Listeners', 19:39:53 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 19:39:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:39:53 INFO - 'USER': 'cltbld', 19:39:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:39:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:39:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:53 INFO - 'XPC_FLAGS': '0x0', 19:39:53 INFO - 'XPC_SERVICE_NAME': '0', 19:39:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:39:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:39:53 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-E6p55b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:39:53 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-c9ed8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:39:53 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-D4OFHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:39:53 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-4M2GpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:39:53 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-vGqZXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:39:54 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-PD7fFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:39:54 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-miLEYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:39:54 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-SDe6kC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:39:54 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-QkIEb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:39:54 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-qvQqOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:39:54 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-aX4N77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:39:54 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-Hv9PN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:39:54 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-A0p6DW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:39:54 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-tlHEgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:39:55 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-uIhM3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:39:55 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-SXAfOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:39:55 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-DCsxJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:39:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:39:55 INFO - Running setup.py install for manifestparser 19:39:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:39:55 INFO - Running setup.py install for mozcrash 19:39:55 INFO - Running setup.py install for mozdebug 19:39:55 INFO - Running setup.py install for mozdevice 19:39:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:39:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:39:55 INFO - Running setup.py install for mozfile 19:39:56 INFO - Running setup.py install for mozhttpd 19:39:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:39:56 INFO - Running setup.py install for mozinfo 19:39:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:39:56 INFO - Running setup.py install for mozInstall 19:39:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:39:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:39:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:39:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:39:56 INFO - Running setup.py install for mozleak 19:39:56 INFO - Running setup.py install for mozlog 19:39:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:39:56 INFO - Running setup.py install for moznetwork 19:39:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:39:57 INFO - Running setup.py install for mozprocess 19:39:57 INFO - Running setup.py install for mozprofile 19:39:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:39:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:39:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:39:57 INFO - Running setup.py install for mozrunner 19:39:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:39:57 INFO - Running setup.py install for mozscreenshot 19:39:57 INFO - Running setup.py install for moztest 19:39:57 INFO - Running setup.py install for mozversion 19:39:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:39:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:39:57 INFO - Cleaning up... 19:39:57 INFO - Return code: 0 19:39:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:39: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')]} 19:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:39:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39: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')]} 19:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:39:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:57 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 0x10ad53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdf851df10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab67d30>, '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 0x10a98ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5fb20>, '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.LXRezOv0hV/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.6bKt9fPpxN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 19:39:57 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 19:39:57 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 19:39:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LXRezOv0hV/Render', 19:39:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:39:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:39:57 INFO - 'HOME': '/Users/cltbld', 19:39:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:39:57 INFO - 'LOGNAME': 'cltbld', 19:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:57 INFO - 'MOZ_NO_REMOTE': '1', 19:39:57 INFO - 'NO_EM_RESTART': '1', 19:39:57 INFO - 'PAGER': '/bin/cat', 19:39:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:57 INFO - 'PWD': '/builds/slave/test', 19:39:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:39:57 INFO - 'SHELL': '/bin/bash', 19:39:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6bKt9fPpxN/Listeners', 19:39:57 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 19:39:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:39:57 INFO - 'USER': 'cltbld', 19:39:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:39:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:57 INFO - 'XPC_FLAGS': '0x0', 19:39:57 INFO - 'XPC_SERVICE_NAME': '0', 19:39:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:39:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:39:58 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-GWdx5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:39:58 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)) 19:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:39:58 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-suSqtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:39:58 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)) 19:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:39:58 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-1ISOJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:39:58 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)) 19:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:39:58 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-oPCP67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:39:58 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)) 19:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:39:58 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-nAf2pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:39:58 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)) 19:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:39:58 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-3Q8qkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:39:58 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)) 19:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:39:58 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-8BzfBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:39:58 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)) 19:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:39:59 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-cZnEdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:39:59 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)) 19:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:39:59 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-ff5oKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:39:59 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)) 19:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:39:59 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-OZr_w5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:39:59 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-T3ffRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:39:59 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)) 19:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:39:59 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-G9YOjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:39:59 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)) 19:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:39:59 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-jahJy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:39:59 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)) 19:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:39:59 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-D8MT44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:39:59 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)) 19:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:39:59 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-VBJ4my-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:39:59 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)) 19:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:39:59 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-NgSW16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:39:59 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)) 19:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:39:59 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-R2vQSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:40:00 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)) 19:40:00 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)) 19:40:00 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)) 19:40:00 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)) 19:40:00 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)) 19:40:00 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)) 19:40:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:40:00 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 19:40:00 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 19:40:00 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 19:40:00 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 19:40:00 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 19:40:00 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 19:40:02 INFO - Downloading blessings-1.6.tar.gz 19:40:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:40:02 INFO - Installing collected packages: blessings 19:40:02 INFO - Running setup.py install for blessings 19:40:02 INFO - Successfully installed blessings 19:40:02 INFO - Cleaning up... 19:40:02 INFO - Return code: 0 19:40:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:40:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:40:03 INFO - Reading from file tmpfile_stdout 19:40:03 INFO - Current package versions: 19:40:03 INFO - blessings == 1.6 19:40:03 INFO - blobuploader == 1.2.4 19:40:03 INFO - docopt == 0.6.1 19:40:03 INFO - functools32 == 3.2.3-2 19:40:03 INFO - jsonschema == 2.5.1 19:40:03 INFO - manifestparser == 1.1 19:40:03 INFO - mozInstall == 1.12 19:40:03 INFO - mozcrash == 0.17 19:40:03 INFO - mozdebug == 0.1 19:40:03 INFO - mozdevice == 0.48 19:40:03 INFO - mozfile == 1.2 19:40:03 INFO - mozhttpd == 0.7 19:40:03 INFO - mozinfo == 0.9 19:40:03 INFO - mozleak == 0.1 19:40:03 INFO - mozlog == 3.4 19:40:03 INFO - moznetwork == 0.27 19:40:03 INFO - mozprocess == 0.23 19:40:03 INFO - mozprofile == 0.28 19:40:03 INFO - mozrunner == 6.12 19:40:03 INFO - mozscreenshot == 0.1 19:40:03 INFO - mozsystemmonitor == 0.3 19:40:03 INFO - moztest == 0.7 19:40:03 INFO - mozversion == 1.4 19:40:03 INFO - psutil == 3.1.1 19:40:03 INFO - requests == 1.2.3 19:40:03 INFO - wsgiref == 0.1.2 19:40:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:03 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 0x10ad53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdf851df10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab67d30>, '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 0x10a98ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5fb20>, '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.LXRezOv0hV/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.6bKt9fPpxN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 19:40:03 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 19:40:03 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 19:40:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LXRezOv0hV/Render', 19:40:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:40:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:40:03 INFO - 'HOME': '/Users/cltbld', 19:40:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:40:03 INFO - 'LOGNAME': 'cltbld', 19:40:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:03 INFO - 'MOZ_NO_REMOTE': '1', 19:40:03 INFO - 'NO_EM_RESTART': '1', 19:40:03 INFO - 'PAGER': '/bin/cat', 19:40:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:40:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:03 INFO - 'PWD': '/builds/slave/test', 19:40:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:40:03 INFO - 'SHELL': '/bin/bash', 19:40:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6bKt9fPpxN/Listeners', 19:40:03 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 19:40:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:40:03 INFO - 'USER': 'cltbld', 19:40:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:40:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:40:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:03 INFO - 'XPC_FLAGS': '0x0', 19:40:03 INFO - 'XPC_SERVICE_NAME': '0', 19:40:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:03 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)) 19:40:03 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)) 19:40:03 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)) 19:40:03 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)) 19:40:03 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)) 19:40:03 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)) 19:40:03 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)) 19:40:03 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)) 19:40:03 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)) 19:40:03 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)) 19:40:03 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)) 19:40:03 INFO - Cleaning up... 19:40:03 INFO - Return code: 0 19:40:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:03 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 0x10ad53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdf851df10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab67d30>, '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 0x10a98ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5fb20>, '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.LXRezOv0hV/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.6bKt9fPpxN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 19:40:03 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 19:40:03 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 19:40:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LXRezOv0hV/Render', 19:40:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:40:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:40:03 INFO - 'HOME': '/Users/cltbld', 19:40:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:40:03 INFO - 'LOGNAME': 'cltbld', 19:40:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:03 INFO - 'MOZ_NO_REMOTE': '1', 19:40:03 INFO - 'NO_EM_RESTART': '1', 19:40:03 INFO - 'PAGER': '/bin/cat', 19:40:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:40:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:03 INFO - 'PWD': '/builds/slave/test', 19:40:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:40:03 INFO - 'SHELL': '/bin/bash', 19:40:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6bKt9fPpxN/Listeners', 19:40:03 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 19:40:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:40:03 INFO - 'USER': 'cltbld', 19:40:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:40:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:40:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:03 INFO - 'XPC_FLAGS': '0x0', 19:40:03 INFO - 'XPC_SERVICE_NAME': '0', 19:40:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:40:03 INFO - Cleaning up... 19:40:03 INFO - Return code: 0 19:40:03 INFO - Running post-action listener: _resource_record_post_action 19:40:03 INFO - Running post-action listener: _start_resource_monitoring 19:40:03 INFO - Starting resource monitoring. 19:40:03 INFO - [mozharness: 2016-09-24 02:40:03.700181Z] Finished create-virtualenv step (success) 19:40:03 INFO - [mozharness: 2016-09-24 02:40:03.701220Z] Running install step. 19:40:03 INFO - Running pre-action listener: _resource_record_pre_action 19:40:03 INFO - Running main action method: install 19:40:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:40:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:40:03 INFO - Reading from file tmpfile_stdout 19:40:03 INFO - Detecting whether we're running mozinstall >=1.0... 19:40:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:40:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:40:04 INFO - Reading from file tmpfile_stdout 19:40:04 INFO - Output received: 19:40:04 INFO - Usage: mozinstall [options] installer 19:40:04 INFO - Options: 19:40:04 INFO - -h, --help show this help message and exit 19:40:04 INFO - -d DEST, --destination=DEST 19:40:04 INFO - Directory to install application into. [default: 19:40:04 INFO - "/builds/slave/test"] 19:40:04 INFO - --app=APP Application being installed. [default: firefox] 19:40:04 INFO - mkdir: /builds/slave/test/build/application 19:40:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:40:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:40:38 INFO - Reading from file tmpfile_stdout 19:40:38 INFO - Output received: 19:40:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:40:38 INFO - Running post-action listener: _resource_record_post_action 19:40:38 INFO - [mozharness: 2016-09-24 02:40:38.281366Z] Finished install step (success) 19:40:38 INFO - [mozharness: 2016-09-24 02:40:38.281474Z] Running run-tests step. 19:40:38 INFO - Running pre-action listener: _resource_record_pre_action 19:40:38 INFO - Running main action method: run_tests 19:40:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:40:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:40:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:40:38 INFO - 2016-09-23 19:40:38.294 screenresolution[2712:13197] starting screenresolution argv=screenresolution get 19:40:38 INFO - 2016-09-23 19:40:38.296 screenresolution[2712:13197] Display 0: 1600x1200x32@60 19:40:38 INFO - 2016-09-23 19:40:38.302 screenresolution[2713:13199] starting screenresolution argv=screenresolution list 19:40:38 INFO - Available Modes on Display 0 19:40:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:40:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:40:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:40:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:40:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:40:38 INFO - Intel Iris: 19:40:38 INFO - Chipset Model: Intel Iris 19:40:38 INFO - Type: GPU 19:40:38 INFO - Bus: Built-In 19:40:38 INFO - VRAM (Dynamic, Max): 1536 MB 19:40:38 INFO - Vendor: Intel (0x8086) 19:40:38 INFO - Device ID: 0x0a2e 19:40:38 INFO - Revision ID: 0x0009 19:40:38 INFO - Displays: 19:40:38 INFO - Display: 19:40:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:40:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:40:38 INFO - Display Serial Number: 1600x1200 60 19:40:38 INFO - Main Display: Yes 19:40:38 INFO - Mirror: Off 19:40:38 INFO - Online: Yes 19:40:38 INFO - Rotation: Supported 19:40:38 INFO - Return code: 0 19:40:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:40:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:40:38 INFO - Python 2.7.3 19:40:38 INFO - Return code: 0 19:40:38 INFO - grabbing minidump binary from tooltool 19:40:38 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')]} 19:40:38 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 0x10ab67d30>, '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 0x10a98ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:40:38 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 19:40:38 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 19:40:38 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 19:40:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:40:38 INFO - Return code: 0 19:40:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:40:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:40:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:40:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:40:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:40:38 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/R6LlDlZETNSMr8PD5gv6iQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0152', '--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 19:40:38 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/R6LlDlZETNSMr8PD5gv6iQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0152 --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 19:40:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LXRezOv0hV/Render', 19:40:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:40:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:40:38 INFO - 'HOME': '/Users/cltbld', 19:40:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:40:38 INFO - 'LOGNAME': 'cltbld', 19:40:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:40:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:40:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:38 INFO - 'MOZ_NO_REMOTE': '1', 19:40:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:40:38 INFO - 'NO_EM_RESTART': '1', 19:40:38 INFO - 'PAGER': '/bin/cat', 19:40:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:40:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:38 INFO - 'PWD': '/builds/slave/test', 19:40:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:40:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:40:38 INFO - 'SHELL': '/bin/bash', 19:40:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6bKt9fPpxN/Listeners', 19:40:38 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 19:40:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:40:38 INFO - 'USER': 'cltbld', 19:40:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:40:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:40:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:38 INFO - 'XPC_FLAGS': '0x0', 19:40:38 INFO - 'XPC_SERVICE_NAME': '0', 19:40:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:40:38 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/R6LlDlZETNSMr8PD5gv6iQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0152', '--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 19:40:38 INFO - mozversion application_buildid: 20160923184424 19:40:38 INFO - mozversion application_changeset: 735ae776c393e7c2f7c9d64a12a61b5f7689a583 19:40:38 INFO - mozversion application_display_name: Nightly 19:40:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:40:38 INFO - mozversion application_name: Firefox 19:40:38 INFO - mozversion application_remotingname: firefox 19:40:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 19:40:38 INFO - mozversion application_vendor: Mozilla 19:40:38 INFO - mozversion application_version: 52.0a1 19:40:38 INFO - mozversion platform_buildid: 20160923184424 19:40:38 INFO - mozversion platform_changeset: 735ae776c393e7c2f7c9d64a12a61b5f7689a583 19:40:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 19:40:38 INFO - mozversion platform_version: 52.0a1 19:40:38 INFO - using testdate: 1474684838 19:40:38 INFO - actual date: 1474684838 19:40:38 INFO - starting webserver on 'localhost:49309' 19:40:38 INFO - SUITE-START | Running 2 tests 19:40:38 INFO - TEST-START | dromaeo_css 19:40:38 INFO - operating with platform_type : mac_ 19:40:38 INFO - Initialising browser for dromaeo_css test... 19:40:38 INFO - TEST-INFO | started process 2723 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmpiYckoC/profile http://localhost:49309/getInfo.html) 19:40:41 INFO - PROCESS | 2723 | __metrics Screen width/height:1600/1200 19:40:41 INFO - PROCESS | 2723 | colorDepth:24 19:40:41 INFO - PROCESS | 2723 | Browser inner width/height: 1024/689 19:40:41 INFO - PROCESS | 2723 | __metrics 19:40:41 INFO - PROCESS | 2723 | 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" 19:40:41 INFO - PROCESS | 2723 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:40:42 INFO - TEST-INFO | 2723: exit 0 19:40:42 INFO - Browser initialized. 19:40:42 INFO - Running cycle 1/1 for dromaeo_css test... 19:40:42 INFO - TEST-INFO | started process 2726 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmpiYckoC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:40:54 INFO - PROCESS | 2726 | RSS: Main: 235778048 19:40:54 INFO - PROCESS | 2726 | 19:41:45 INFO - PROCESS | 2726 | 1474684905449 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] 19:43:56 INFO - PROCESS | 2726 | Cycle 1(1): loaded http://localhost:49309/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49309/tests/dromaeo/cssquery-ext.html) 19:43:58 INFO - PROCESS | 2726 | RSS: Main: 398893056 19:43:58 INFO - PROCESS | 2726 | 19:47:01 INFO - PROCESS | 2726 | Cycle 1(1): loaded http://localhost:49309/tests/dromaeo/cssquery-ext.html (next: http://localhost:49309/tests/dromaeo/cssquery-jquery.html) 19:47:02 INFO - PROCESS | 2726 | RSS: Main: 396038144 19:47:02 INFO - PROCESS | 2726 | 19:50:04 INFO - PROCESS | 2726 | Cycle 1(1): loaded http://localhost:49309/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49309/tests/dromaeo/cssquery-mootools.html) 19:50:05 INFO - PROCESS | 2726 | RSS: Main: 343691264 19:50:05 INFO - PROCESS | 2726 | 19:53:07 INFO - PROCESS | 2726 | Cycle 1(1): loaded http://localhost:49309/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49309/tests/dromaeo/cssquery-prototype.html) 19:53:08 INFO - PROCESS | 2726 | RSS: Main: 339111936 19:53:08 INFO - PROCESS | 2726 | 19:56:11 INFO - PROCESS | 2726 | Cycle 1(1): loaded http://localhost:49309/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49309/tests/dromaeo/cssquery-yui.html) 19:56:12 INFO - PROCESS | 2726 | RSS: Main: 328515584 19:56:12 INFO - PROCESS | 2726 | 19:59:15 INFO - PROCESS | 2726 | Cycle 1(1): loaded http://localhost:49309/tests/dromaeo/cssquery-yui.html (next: http://localhost:49309/tests/dromaeo/cssquery-dojo.html) 19:59:15 INFO - PROCESS | 2726 | RSS: Main: 380612608 19:59:15 INFO - PROCESS | 2726 | 19:59:15 INFO - PROCESS | 2726 | __start_tp_report 19:59:15 INFO - PROCESS | 2726 | _x_x_mozilla_page_load 19:59:15 INFO - PROCESS | 2726 | _x_x_mozilla_page_load_details 19:59:15 INFO - PROCESS | 2726 | |i|pagename|runs| 19:59:15 INFO - PROCESS | 2726 | |0;dojo.html;3222.4844024956005;3232.0627018164732;3245.2049247934274;3286.457734473812;3295.242094318307;5360.490753378433;5403.91894121588;5440.510354068133;5457.263269458617;5466.617336786427;5453.427390124039;5454.863628409292;5467.562594992401;5467.644603100795;5474.589405794562;4930.6055515558755;5004.124278251292;5006.649534532584;5030.82392116276;5076.959223359221;5013.749312534359;5084.339035925324;5089.745512724349;5090.109230884599;5092.337996060507;4752.714837109767;4988;5018.5232402921665;5063.670861394016;5078.415982162043;4536.160810250098;5095.159298715707;5097.7960881564695;5104.259882317043;5150.150225212836;4915.606751459874;4967.230079337708;4970.850874473772;5004.124278251292;5041.092603331399;5266.8419947401635;5333.4399888011585;5402.216678581623;5417.214503896952;5417.729113544347;5863.091220860773;5875.9118613220835;5883.911741323841;5886.440788125121;5911.793087241926;5868.325142608612;5949.583529152961;5953.464188223081;5987.820365389045;6000.789972350947;5461.644993075437;5467.043267428184;5519.751611177507;5584.46947539983;5586.581006424534;6178.845528861814;6188.412100850412;6194.225721784777;6195.783147589903;6197.845053873599;5676.375598684142;5847.853803654943;5854.824355269348;5877.089051197071;5878.323992740804;5870.9412905870395;6002.969985150046;6021.277446706424;6069.848253793602;6090.573659843769;5904.7342869570975;5921.644701317849;5922.141289512996;5927.496162826122;5939.613925094942;5891.469767720926;5941.940580594139;5949.226600541989;5960.731767070492;5970.641761494324;4633.443986721615;4696.412948381452;4709.222978208626;4713.104510143062;4744.146053710365;4243.851465198765;4248.787560621957;4287.892802679896;4291.785410729451;4303.870883873489;5432.266644003009;5459.890802183934;5468.48049435303;5469.835904922858;5477.4796394342475;4527.4340707411575;5051.26756620288;5801.94198058014;5866.882662346729;5959.344472108151;4975.651704380659;5483.232347471358;5492.670439773627;5534.723263836792;5542.445755424425;5157.381114266237;5158.742062896915;5178.715170665574;5180.844574662766;5202.4277329493725;6130.908036379458;6226.221722284715;6247.687615619201;6256.186695729526;6260.436560709558;5821.76712931478;5897.026990546512;5897.941020589739;5948.196993405835;6014.278286605635;6137.310331738248;6193.907091393723;6205.751769929333;6219.937800621936;6231.657258850625;5834.416558344132;5844.912326315194;5852.619579727304;5854.151148083419;5866.208061911588;4918.819483324048;5791.913121303268;5855.473007429352;5900.793472228452;5930.9110363343725;5694.971525142348;5714.3999880012;5761.452661997104;5768.653880767168;5834.241548598655;5637;5726.828195154152;5739.397363276963;5753.194552762533;5757.712114394348;5416.458354164552;5622.465865742912;5623.550115990629;5629.240052592848;5642.125470552071;4911.582515486224;5549.9177660355845;5722.542196624343;5740.741666624928;5742.856428589152;4671.205894997791;5472.835814925558;5554.222408862682;5584.581156413204;5638.2670252866865 19:59:15 INFO - PROCESS | 2726 | |1;ext.html;491.3514161307074;507.74358948730884;514.2132537218058;521.6426747677839;524.850417630975;27736.167914962534;30991.535126973115;32364.67635323646;39696.801515992454;41033;42424.57575424245;43030.56969430305;43034.35448468268;43041.35437968425;43182.784086079526;9700.854487182698;9858.359206651545;9894.802103957953;9895.55470003848;9897.95051024744;8711.477311361306;8986.595603197838;9689.273304502156;9841.606335746561;9865.556049977733;11889;12086.879131208707;12088.697782555419;12121.757564848698;12273.631791046282;11986.340751258676;12052.517899284017;12081.395930203498;12084.697882552919;12085.879141208563;8664.696735614287;8914.242289405409;8932.062133475956;11976.88023119775;12017.399130043463;31711.84144079288;32037.51943720846;38878.805605971786;40104.79947600243;40185.39721904174;3335.149536868083;3355.4799006154085;3384.9661503384896;3564.6078931317534;3733.143159948681;30279.545806812916;30430;30951.535726964114;31026;31551.84224078865;3146.2606287522412;3192.345569158317;3242.7243684286864;3259.8533066012087;3340.131565792887;452993;455301;457209;459215;459994.9999999967;56470;56821.43178568244;56872.431275687544;56911;57013.71493142508;50264;51279.743601281756;58248;59068.704656476446;59384;15814.9209253953;15909.363625455084;15925.362985480682;15958.76061859073;15973.68052638964;12416.441260143316;12513.74972500545;12536.81194782079;12540.749185016248;12561.183523070971;13209.273489958145;13482.561946703529;13506.59480215595;13635.86364136346;13700.65748356299;5723.885522289531;6623.9006414903815;6631.734730610818;6673.4661227101715;6746.83132921671;873.8863947686888;939.4081728511131;996.9700908972742;1009.535613617744;1051.447989805343;26927.461450770876;30814.845925770227;31033.051860073258;32037.038888833373;32891.3421731564;954.8090381923643;987.2891518106951;1019.3272440189439;1025.144004756037;1032.390889375257;14622.049566778338;14687.77968330476;14951.327190276465;15202;15288.464903728316;636261;641562;641688.7915560486;643647;646021;46090.07819843584;46656;52412.47587524076;52897.471025290026;53296;1341.8792308692264;1368.6304697731557;1390.8122403475807;1392.2481859795596;1393.6028231953844;28290.43419131647;29593.260168495097;29720;30551.54172687456;30801.075967721004;48112.27831582599;48647;48675.269870951255;48678.26982595335;48762;589307;602456;606186;764852;765490;24807.50384992254;25051.49897002086;25114.24657260285;25132.74867251377;25135.497290054464;45348.8662783433;45766.542334576225;46327.76836115798;47659.52340476551;49084;38294.617053829104;38340.61659383482;38387.80806096063;39631.60368396279;39940.60059399369;30533.847330763205;36766;37135.81432092822;37816.81091594524;38318;37258.88223353304;37325.6267437333;38002.429963550014;38034;38141.618583813804;31196.844015780684;33609.72528265109;33996.49005264873;34333.193352931106;34553.82723086469;25031.374215644755;25150.49699005973;25315;25350.873245633655;26199.345016374744 19:59:15 INFO - PROCESS | 2726 | |2;jquery.html;344.631244568312;362.2031530632609;365.96157403472637;372.7614326830829;394.57780175212537;14445;15710.0573965562;20604.55768096232;20892;21673;19652.9017354913;19850;20164;20400.69398959013;20743.481412964647;5824.767009319622;5962.284525856903;5975.193348897887;6004.129401236818;6037.366076561963;4135.73117747347;4299.699021068526;4355.782210889459;5846;5937.079752638327;6500.577462464948;6515.7719479818215;6604.801855944329;6607.669616519179;6629.403353698166;6343.33394993526;6515.250746164157;6586.637734924578;6612.2726500084955;6619.867602647968;5688.146777983295;5690.260266165372;5691.48776610103;5694.259746233005;5698.715064246812;13183;13339.666508337272;23557.528849422917;23660.698661573606;24587.63118553223;2139.016052615799;2329.988350058256;2394.760523947609;2789;2839.0914907229694;8117.553534555597;9986.950065249699;10106.494675266207;14251.144931304156;15599.376024958989;1841.6132612151464;1904.3334832808546;1905.9047047647562;1938.5250613599617;1953.345629214215;91592;116868.41565792201;129262.3536882319;130746;132428;9074.682386116587;11085.778284434427;11450.427478626036;11532;11663.941680291713;12637.368131593383;13178;13216.933915330363;13332.266725330006;14146;8298.834023319621;8347.749567512985;8371.121032291643;8444.408891377545;8536.061033286334;6689.665516724144;8411.621477033548;8426.41015128935;8445.1977062179;8599.61301741423;4399.450068741407;4492.58483577672;4493.123840851068;4553.2942393929;4577.656675749332;1892.233645373626;1906.9988256165625;1912.7417798597012;1913.980860191408;1918.2327069172443;792.4809249941297;819.9918000820035;896.3098414221014;908.5003248213457;979.7893452907516;18113.637727245383;19820.70268945967;20836.895815520824;20841.957902104834;21416.78583214179;891.5230351761905;906.5920335848895;923.1460898668705;924.3945215883607;971.5482300730054;10467.371957682564;10848.02367786903;10946.960038796302;10988.890111098946;10994.34033957965;596526;600004;604457;616233;616271;130652;131902;134823;135063;135278.64721352857;956.660385563129;974.0989584634326;1000.1448761308976;1000.6497725795913;1000.7648202672366;14845.777313340093;18285.725714114033;18435.631287374446;18544.81455185431;18827.964461954725;38044.04889877775;41899;47726.32957846459;53271.46728532665;55369;75264.62367688127;76285.61857190679;77862.61068694621;80649;85011.57494212736;7803.219678032151;7876.72431464896;8123.228293312126;8134.593270336341;8213.3429325655;12456.937715311366;12808.167469114478;12857;13148.60554183376;13299.268540229994;8273.420860539705;11446.542138314375;11496.48265828023;11641.47613357384;11643.544556930383;10889.386547228449;11058.22592418523;11303.382917466331;11471.369074700971;11592.362420066976;9644.75888102803;11286.548538058714;11584.362860042442;11772.70568235801;11846.407679615812;6476.967615162082;6753.763618273337;7988.800279993046;8262.42163048581;8293.1706829319;10178.643747468803;11156.219064665396;11422;11483.8277425837;11515.30908145514 19:59:15 INFO - PROCESS | 2726 | |3;mootools.html;1372.2315503318148;1401.3553765267977;1550.1474189195942;1733.5319463744788;1919.2706771426865;7040.577565346083;7643.8089047773765;8528.744137675872;8770.517621530813;8793.472391656505;8741.562921853914;8848.690295839648;8849.380543361967;8858.069902660225;8871.802306688594;2343.03935386492;2372.8457650252763;2376.95246095078;2377.6909001829736;2379.773921477457;1936.5061909213132;2381.214199314231;2391.6651668766385;2392.342105920868;2393.150431596784;2340.1692399198296;2373.8694371809543;2374.6794182785275;2383.535210633927;2385.8329916905823;2326.8022218111482;2351.6825228594093;2360.221127028077;2368.1829768729763;2368.988155059231;2307.526956973816;2340.4382948092334;2341.3444235614056;2354.6232602783643;2357.4342157881983;8733.868991965126;8826.205641492297;8829.867551986661;8830.293576513863;8842.60208290622;5127.6154288428515;5327.813526526553;5333;5334.813281535127;5349.277847490617;3437.724982001459;3600.0999750062483;3661.1030297577;3662.8717994870053;3662.981685091584;1047.61238341814;1078.9190810689151;1083.6044843632096;1103.6413165721174;1103.8013157631624;11442.370669613169;11482.368469734161;11566.710832229262;11584.478698458674;11584.536618535249;4283.443152390169;4400.537943515948;4522.5929666330185;4560.315952607136;4568.954310456919;9054.83080921672;9056.818863622691;9064.229540489001;9074.727758167266;9080.772980675536;5133.9743301284;5143.974280128576;5144.15121504955;5151.742412879341;5151.896962060738;4060.857869974596;4331.371951067078;4458.242098843204;4458.598726114666;4819.3012013257885;3629.8185090745355;3711.9628803712158;3745.1198968242443;3795.259924314732;3798.145417281145;943.8206740719241;1088.2001728729379;1088.9401082940356;1096.6490722968733;1105.8285965675334;870.8171284030425;900.3787386703154;918.3296193778579;933.883264591926;941.9835029331898;5766.250387449605;5998.950183717832;6070.696465176724;6073.5748497604745;6358.682065896686;835.2232423845882;892.950782830172;908.2325435007408;911.1389736698756;971.5967873332488;3570.6607872252616;3967.0677390813134;4003.099302656937;4045.5752146024834;4167.604077612622;10068.546915388824;10334.844977325347;10653.627123050655;10655.946720266349;10688.465576721133;8597.441166324168;10368.170546356274;10553.788924221473;10566.577336906437;10615.416152111708;7967.561784101814;8031.277185053374;8038.758837234892;8047.034355877332;8079.192080791991;5998.190244316961;6026.367231440811;6129.877402452015;6180.690965451619;6288.119663247057;9597.664081757104;9742.171915387271;9743.658971935949;10131.392116473035;10169.745756356151;8946.507942062988;9123.27013838878;9727.708168754949;10088.092071713581;10246.538905749409;7353.485256032026;7563.659635316314;8061.798455038436;8134.308583770446;8384.203500667427;8245.752627421187;8320.70877519284;8340.499570025819;8407.369447291356;8421.70524031656;7502.062242219723;7559.395248380007;7577.772666820004;7600.885986710093;7606.543607383574;7350.154732205865;7358.300961408658;7376.4836461447185;7413.962930185315;7555.9244407555225;6961.408280296231;6963.8607227854145;7008.264132266038;7043.36609705129;7049.718011279697;4820.228763397839;5015.3480047593575;5055.393352797688;5131.897362052813;5247.895042099213;4070.9389359159045;4944.862681583328;4999.700017998932;5019.3976722793495;5202.063628546898 19:59:15 INFO - PROCESS | 2726 | |4;prototype.html;292.2066589210294;294.9557566365046;304.9832259225743;308.36015268318243;310.76226686584755;4679.906401871961;4822.035592881421;5163.81926632568;5227.477252274775;5262.47375262474;4327.783610819462;4938.728369939652;4969.950300496994;4994.7252901090515;5029.949700502993;3937.8621748238816;3985.501812273466;3988.6809055275507;4002.1995600879795;4040.919181616366;3408.931821363571;3865.4588357629814;3964.385520244367;4005.5593884672808;4012.0341032893816;3322;3937.5274967003998;3986.425361982015;3988.5213774346976;3997.3204555225534;3633.563972323338;3643.36241157799;4023.517177938666;4032;4041.4139949707424;2898.8985385511405;3458.913527161816;3481.756277060607;3498.3178280235365;3504.5794504659348;4325.653947684178;5001.799928002875;5071.746412679388;5081.822136225214;5093.439721630618;3768.8680896168503;3808.990617486368;4313.15893400787;4546.727196368229;4607.677462577621;5410.5401040911565;5418.4039755626845;5446.786396026363;5535.225068490415;5537.916931246034;3828.25349056934;3829.6936245100324;3831.597682243352;3871.664275824836;3901.921961560753;4421.712588681726;5028.918782461788;5347.652402593819;5633.943660563424;5757.366689664133;3245.253591673881;3369.578802649669;3697.299242348496;3699;3858.3826587745825;3470.687638112582;3781.865440367879;3906.277338692351;3971.801409929492;3990.920181596352;4231.386448964883;4549.6360291176625;4579.358889755437;4589.770511474413;4591.8392856249875;4691.8417527936845;5332.413434522199;5365.248865158881;5419.918701219485;5466.453354664582;1341.7048249385314;1347.528365072217;1361.4077876123918;1365.4433945302362;1366.4875671623142;869.5608717597572;905.4522014181325;910.3036177324352;937.6530683646957;953.3755390219418;4165.313697377843;4658.836940707059;5166.689998600096;5179.8446046618665;5182.5594824439595;5474.671519708831;5500.532454741312;5586.720663966786;5599.3044590570025;5599.496045355938;4584.303807591213;4745.406824146981;4773.618110551148;5041.294218809297;5108.361454818148;2662.881589732317;2882.337062475642;2886.292858249742;2890.580865774451;2932.4721550121185;5394.352677678625;5562.499375056264;5707.172459993278;5714;5737.3975732548315;4265.786710664454;4852.344933434012;5633.760587662111;5729.197912292282;5744.856378590569;5775.595708300379;5780.017397042513;5815.680137592473;5868;5870.7945221917025;4671.906561868812;5084.694918304914;5587.3015873015875;5642.689652069012;5652.134795517387;4717.844128188616;5330.253764472899;5608.513743857962;5637.577181711306;5638.85902852432;5096.311997880239;5840.853978650568;5850.94149058521;5916.970415147896;5963.970180149245;3319.0872510059926;3654.4518322251874;3656.4277360734077;3768.2463507298103;3792.241551689618;5096.827729622281;5561.524047470331;5568.638038527645;5572.275604171432;5587.720613969366;5129.179331306973;5383.461653834585;5476.58925580591;5479.863003424787;5508.20131080999;4200.789960501902;4711.2933060039895;5386.407495175449;5422.376426710821;5447.3385617387075;4154.813033413443;5273.444333921426;5292.947070529245;5316.388615309289;5325.760340784752;4619.769011549476;4771.141194585008;5283.577313814809;5349.090654588651;5402.918956215582;4279.079997800488;4604.401427814362;5278.97360513195;5339.572834173335;5341.9198712020125 19:59:15 INFO - PROCESS | 2726 | |5;yui.html;716.5664772812452;766.5132640773107;786.9055713314403;812.6383759227147;814.3226137192656;15152.545423637295;15867.365305387772;15878.841211587895;15903.204839758024;16313.673726525461;14091.840303802534;14164.716705665905;14176.85823141771;14193.929030354833;14200.289985500734;666.3170250493234;692.3284414118298;692.394155114275;831.6091437024619;840.3571267979985;847.5211505499373;855.8331125430543;863.9179277968615;864.9740507784745;865.8874346334968;887.8535041718109;912.8356895758761;913.4975763330175;913.5295322908707;916.9403988740744;693.1855070292437;718.6406796601699;900.5407242306438;902.6885724425096;903.5391950105428;652.1489456259579;677.3159109299643;679.7247114918466;680.5610381304081;681.4037716997627;15038.097714137186;15108.39566417342;15120.924395377953;15127.319270632737;15173.393064277416;13480.662983425394;13696.315184240848;13813.309334533233;13983.79024314636;14230.928845355811;11112.111031117573;11647.126465515035;11798.233114847593;11882.22765520247;11883.940580297043;4562.634989200856;4565.703229290086;4587.610053145487;4727.976360118212;4820.276958456225;106037;107930.46034769855;108344;108596;108880;10270.743231419274;10420.843687344695;10758.515866786014;10794.298370605886;11007.834882476769;20530.38408847737;20544.28095016667;20598.073086711134;20610.793892060887;20652;7695.461317707819;7740.729074482366;7876.56678882667;7934.960325198337;7978.042634883851;4343.543927887589;4455.443069616298;4492.460904691458;4514.819407223675;4579.633629309647;3339.3154403347257;3462.7056700180265;3471.965280347164;3474.4614584739406;3480.5301284326797;625.1622825413967;645.2386184302568;656.5305806348389;658.6311665467354;658.6509150150428;525.915853463444;580.2051189869906;588.2793577867078;654.5974225851163;665.6505334699322;8397.664093436195;9046.366754327133;9113.908860911439;9162.267018638493;9231.446113233227;503.45626723139657;527.3028459430064;581.7411251992822;593.7862369546959;624.8843963866608;4108.198901214294;4409.426774519292;4413.40419043425;4465.933011004772;4505.549445055468;86470.7029394547;118728;124544;130484;133455;78847.50177716673;115969;118660.40669796595;119673;120119.39940300242;72959.43365097167;105602.47198764111;106693.46653266683;107302.46348768362;110537.94620537882;9520;9890.307678462726;9914.752131196778;9922.603095876084;9982.650607228712;55410;59295.11057334057;60649.69675151596;61038.8961103886;61653.691731541054;76605.61697191701;78858.21141788509;78924.21075789169;82858.58570707108;89392;12963.675908101995;13148.40832162574;13310.933445332712;13428.328583570978;13554.59336219915;14674.853251467348;14780.704385912437;15072.321745521258;15180.544583662508;15359.078455292718;13628.250446225553;14103.858961410255;14110.223937683526;14207;14550.92724536413;13922.303884805922;13928.51250206238;13943.442262309394;13965.301734913417;14039.649008774863;13390.196588204739;13483.393247303698;13606;13611.591652250449;13888.375023123781;10996.175286853679;11141.498632561392;11237.381943992832;11683;11770.646880593597;10660.520276587416;11326.773464530499;11364.090872729996;11522.711932201762;11715.355655439032 19:59:15 INFO - PROCESS | 2726 | __end_tp_report 19:59:15 INFO - PROCESS | 2726 | __start_cc_report 19:59:15 INFO - PROCESS | 2726 | _x_x_mozilla_cycle_collect,1491 19:59:15 INFO - PROCESS | 2726 | __end_cc_report 19:59:15 INFO - PROCESS | 2726 | __startTimestamp1474685955701__endTimestamp 19:59:15 INFO - PROCESS | 2726 | 19:59:15 INFO - PROCESS | 2726 | ------- Summary: start ------- 19:59:15 INFO - PROCESS | 2726 | Number of tests: 6 19:59:15 INFO - PROCESS | 2726 | 19:59:15 INFO - PROCESS | 2726 | [#0] dojo.html Cycles:165 Average:5458.11 Median:5584.47 stddev:614.43 (11.0%) stddev-sans-first:590.75 19:59:15 INFO - PROCESS | 2726 | Values: 3222.5 3232.1 3245.2 3286.5 3295.2 5360.5 5403.9 5440.5 5457.3 5466.6 5453.4 5454.9 5467.6 5467.6 5474.6 4930.6 5004.1 5006.6 5030.8 5077.0 5013.7 5084.3 5089.7 5090.1 5092.3 4752.7 4988.0 5018.5 5063.7 5078.4 4536.2 5095.2 5097.8 5104.3 5150.2 4915.6 4967.2 4970.9 5004.1 5041.1 5266.8 5333.4 5402.2 5417.2 5417.7 5863.1 5875.9 5883.9 5886.4 5911.8 5868.3 5949.6 5953.5 5987.8 6000.8 5461.6 5467.0 5519.8 5584.5 5586.6 6178.8 6188.4 6194.2 6195.8 6197.8 5676.4 5847.9 5854.8 5877.1 5878.3 5870.9 6003.0 6021.3 6069.8 6090.6 5904.7 5921.6 5922.1 5927.5 5939.6 5891.5 5941.9 5949.2 5960.7 5970.6 4633.4 4696.4 4709.2 4713.1 4744.1 4243.9 4248.8 4287.9 4291.8 4303.9 5432.3 5459.9 5468.5 5469.8 5477.5 4527.4 5051.3 5801.9 5866.9 5959.3 4975.7 5483.2 5492.7 5534.7 5542.4 5157.4 5158.7 5178.7 5180.8 5202.4 6130.9 6226.2 6247.7 6256.2 6260.4 5821.8 5897.0 5897.9 5948.2 6014.3 6137.3 6193.9 6205.8 6219.9 6231.7 5834.4 5844.9 5852.6 5854.2 5866.2 4918.8 5791.9 5855.5 5900.8 5930.9 5695.0 5714.4 5761.5 5768.7 5834.2 5637.0 5726.8 5739.4 5753.2 5757.7 5416.5 5622.5 5623.6 5629.2 5642.1 4911.6 5549.9 5722.5 5740.7 5742.9 4671.2 5472.8 5554.2 5584.6 5638.3 19:59:15 INFO - PROCESS | 2726 | 19:59:15 INFO - PROCESS | 2726 | [#1] ext.html Cycles:180 Average:70891.77 Median:20529.38 stddev:160160.98 (780.2%) stddev-sans-first:160523.05 19:59:15 INFO - PROCESS | 2726 | Values: 491.4 507.7 514.2 521.6 524.9 27736.2 30991.5 32364.7 39696.8 41033.0 42424.6 43030.6 43034.4 43041.4 43182.8 9700.9 9858.4 9894.8 9895.6 9898.0 8711.5 8986.6 9689.3 9841.6 9865.6 11889.0 12086.9 12088.7 12121.8 12273.6 11986.3 12052.5 12081.4 12084.7 12085.9 8664.7 8914.2 8932.1 11976.9 12017.4 31711.8 32037.5 38878.8 40104.8 40185.4 3335.1 3355.5 3385.0 3564.6 3733.1 30279.5 30430.0 30951.5 31026.0 31551.8 3146.3 3192.3 3242.7 3259.9 3340.1 452993.0 455301.0 457209.0 459215.0 459995.0 56470.0 56821.4 56872.4 56911.0 57013.7 50264.0 51279.7 58248.0 59068.7 59384.0 15814.9 15909.4 15925.4 15958.8 15973.7 12416.4 12513.7 12536.8 12540.7 12561.2 13209.3 13482.6 13506.6 13635.9 13700.7 5723.9 6623.9 6631.7 6673.5 6746.8 873.9 939.4 997.0 1009.5 1051.4 26927.5 30814.8 31033.1 32037.0 32891.3 954.8 987.3 1019.3 1025.1 1032.4 14622.0 14687.8 14951.3 15202.0 15288.5 636261.0 641562.0 641688.8 643647.0 646021.0 46090.1 46656.0 52412.5 52897.5 53296.0 1341.9 1368.6 1390.8 1392.2 1393.6 28290.4 29593.3 29720.0 30551.5 30801.1 48112.3 48647.0 48675.3 48678.3 48762.0 589307.0 602456.0 606186.0 764852.0 765490.0 24807.5 25051.5 25114.2 25132.7 25135.5 45348.9 45766.5 46327.8 47659.5 49084.0 38294.6 38340.6 38387.8 39631.6 39940.6 30533.8 36766.0 37135.8 37816.8 38318.0 37258.9 37325.6 38002.4 38034.0 38141.6 31196.8 33609.7 33996.5 34333.2 34553.8 25031.4 25150.5 25315.0 25350.9 26199.3 19:59:15 INFO - PROCESS | 2726 | 19:59:15 INFO - PROCESS | 2726 | [#2] jquery.html Cycles:180 Average:35086.56 Median:2814.05 stddev:101453.72 (3605.3%) stddev-sans-first:101704.78 19:59:15 INFO - PROCESS | 2726 | Values: 344.6 362.2 366.0 372.8 394.6 14445.0 15710.1 20604.6 20892.0 21673.0 19652.9 19850.0 20164.0 20400.7 20743.5 5824.8 5962.3 5975.2 6004.1 6037.4 4135.7 4299.7 4355.8 5846.0 5937.1 6500.6 6515.8 6604.8 6607.7 6629.4 6343.3 6515.3 6586.6 6612.3 6619.9 5688.1 5690.3 5691.5 5694.3 5698.7 13183.0 13339.7 23557.5 23660.7 24587.6 2139.0 2330.0 2394.8 2789.0 2839.1 8117.6 9987.0 10106.5 14251.1 15599.4 1841.6 1904.3 1905.9 1938.5 1953.3 91592.0 116868.4 129262.4 130746.0 132428.0 9074.7 11085.8 11450.4 11532.0 11663.9 12637.4 13178.0 13216.9 13332.3 14146.0 8298.8 8347.7 8371.1 8444.4 8536.1 6689.7 8411.6 8426.4 8445.2 8599.6 4399.5 4492.6 4493.1 4553.3 4577.7 1892.2 1907.0 1912.7 1914.0 1918.2 792.5 820.0 896.3 908.5 979.8 18113.6 19820.7 20836.9 20842.0 21416.8 891.5 906.6 923.1 924.4 971.5 10467.4 10848.0 10947.0 10988.9 10994.3 596526.0 600004.0 604457.0 616233.0 616271.0 130652.0 131902.0 134823.0 135063.0 135278.6 956.7 974.1 1000.1 1000.6 1000.8 14845.8 18285.7 18435.6 18544.8 18828.0 38044.0 41899.0 47726.3 53271.5 55369.0 75264.6 76285.6 77862.6 80649.0 85011.6 7803.2 7876.7 8123.2 8134.6 8213.3 12456.9 12808.2 12857.0 13148.6 13299.3 8273.4 11446.5 11496.5 11641.5 11643.5 10889.4 11058.2 11303.4 11471.4 11592.4 9644.8 11286.5 11584.4 11772.7 11846.4 6477.0 6753.8 7988.8 8262.4 8293.2 10178.6 11156.2 11422.0 11483.8 11515.3 19:59:15 INFO - PROCESS | 2726 | 19:59:15 INFO - PROCESS | 2726 | [#3] mootools.html Cycles:180 Average:5633.05 Median:5132.94 stddev:3134.69 (61.1%) stddev-sans-first:3127.13 19:59:15 INFO - PROCESS | 2726 | Values: 1372.2 1401.4 1550.1 1733.5 1919.3 7040.6 7643.8 8528.7 8770.5 8793.5 8741.6 8848.7 8849.4 8858.1 8871.8 2343.0 2372.8 2377.0 2377.7 2379.8 1936.5 2381.2 2391.7 2392.3 2393.2 2340.2 2373.9 2374.7 2383.5 2385.8 2326.8 2351.7 2360.2 2368.2 2369.0 2307.5 2340.4 2341.3 2354.6 2357.4 8733.9 8826.2 8829.9 8830.3 8842.6 5127.6 5327.8 5333.0 5334.8 5349.3 3437.7 3600.1 3661.1 3662.9 3663.0 1047.6 1078.9 1083.6 1103.6 1103.8 11442.4 11482.4 11566.7 11584.5 11584.5 4283.4 4400.5 4522.6 4560.3 4569.0 9054.8 9056.8 9064.2 9074.7 9080.8 5134.0 5144.0 5144.2 5151.7 5151.9 4060.9 4331.4 4458.2 4458.6 4819.3 3629.8 3712.0 3745.1 3795.3 3798.1 943.8 1088.2 1088.9 1096.6 1105.8 870.8 900.4 918.3 933.9 942.0 5766.3 5999.0 6070.7 6073.6 6358.7 835.2 893.0 908.2 911.1 971.6 3570.7 3967.1 4003.1 4045.6 4167.6 10068.5 10334.8 10653.6 10655.9 10688.5 8597.4 10368.2 10553.8 10566.6 10615.4 7967.6 8031.3 8038.8 8047.0 8079.2 5998.2 6026.4 6129.9 6180.7 6288.1 9597.7 9742.2 9743.7 10131.4 10169.7 8946.5 9123.3 9727.7 10088.1 10246.5 7353.5 7563.7 8061.8 8134.3 8384.2 8245.8 8320.7 8340.5 8407.4 8421.7 7502.1 7559.4 7577.8 7600.9 7606.5 7350.2 7358.3 7376.5 7414.0 7555.9 6961.4 6963.9 7008.3 7043.4 7049.7 4820.2 5015.3 5055.4 5131.9 5247.9 4070.9 4944.9 4999.7 5019.4 5202.1 19:59:15 INFO - PROCESS | 2726 | 19:59:15 INFO - PROCESS | 2726 | [#4] prototype.html Cycles:180 Average:4393.60 Median:4837.19 stddev:1340.02 (27.7%) stddev-sans-first:1307.94 19:59:15 INFO - PROCESS | 2726 | Values: 292.2 295.0 305.0 308.4 310.8 4679.9 4822.0 5163.8 5227.5 5262.5 4327.8 4938.7 4970.0 4994.7 5029.9 3937.9 3985.5 3988.7 4002.2 4040.9 3408.9 3865.5 3964.4 4005.6 4012.0 3322.0 3937.5 3986.4 3988.5 3997.3 3633.6 3643.4 4023.5 4032.0 4041.4 2898.9 3458.9 3481.8 3498.3 3504.6 4325.7 5001.8 5071.7 5081.8 5093.4 3768.9 3809.0 4313.2 4546.7 4607.7 5410.5 5418.4 5446.8 5535.2 5537.9 3828.3 3829.7 3831.6 3871.7 3901.9 4421.7 5028.9 5347.7 5633.9 5757.4 3245.3 3369.6 3697.3 3699.0 3858.4 3470.7 3781.9 3906.3 3971.8 3990.9 4231.4 4549.6 4579.4 4589.8 4591.8 4691.8 5332.4 5365.2 5419.9 5466.5 1341.7 1347.5 1361.4 1365.4 1366.5 869.6 905.5 910.3 937.7 953.4 4165.3 4658.8 5166.7 5179.8 5182.6 5474.7 5500.5 5586.7 5599.3 5599.5 4584.3 4745.4 4773.6 5041.3 5108.4 2662.9 2882.3 2886.3 2890.6 2932.5 5394.4 5562.5 5707.2 5714.0 5737.4 4265.8 4852.3 5633.8 5729.2 5744.9 5775.6 5780.0 5815.7 5868.0 5870.8 4671.9 5084.7 5587.3 5642.7 5652.1 4717.8 5330.3 5608.5 5637.6 5638.9 5096.3 5840.9 5850.9 5917.0 5964.0 3319.1 3654.5 3656.4 3768.2 3792.2 5096.8 5561.5 5568.6 5572.3 5587.7 5129.2 5383.5 5476.6 5479.9 5508.2 4200.8 4711.3 5386.4 5422.4 5447.3 4154.8 5273.4 5292.9 5316.4 5325.8 4619.8 4771.1 5283.6 5349.1 5402.9 4279.1 4604.4 5279.0 5339.6 5341.9 19:59:15 INFO - PROCESS | 2726 | 19:59:15 INFO - PROCESS | 2726 | [#5] yui.html Cycles:180 Average:22879.17 Median:3477.50 stddev:34780.41 (1000.2%) stddev-sans-first:34838.17 19:59:15 INFO - PROCESS | 2726 | Values: 716.6 766.5 786.9 812.6 814.3 15152.5 15867.4 15878.8 15903.2 16313.7 14091.8 14164.7 14176.9 14193.9 14200.3 666.3 692.3 692.4 831.6 840.4 847.5 855.8 863.9 865.0 865.9 887.9 912.8 913.5 913.5 916.9 693.2 718.6 900.5 902.7 903.5 652.1 677.3 679.7 680.6 681.4 15038.1 15108.4 15120.9 15127.3 15173.4 13480.7 13696.3 13813.3 13983.8 14230.9 11112.1 11647.1 11798.2 11882.2 11883.9 4562.6 4565.7 4587.6 4728.0 4820.3 106037.0 107930.5 108344.0 108596.0 108880.0 10270.7 10420.8 10758.5 10794.3 11007.8 20530.4 20544.3 20598.1 20610.8 20652.0 7695.5 7740.7 7876.6 7935.0 7978.0 4343.5 4455.4 4492.5 4514.8 4579.6 3339.3 3462.7 3472.0 3474.5 3480.5 625.2 645.2 656.5 658.6 658.7 525.9 580.2 588.3 654.6 665.7 8397.7 9046.4 9113.9 9162.3 9231.4 503.5 527.3 581.7 593.8 624.9 4108.2 4409.4 4413.4 4465.9 4505.5 86470.7 118728.0 124544.0 130484.0 133455.0 78847.5 115969.0 118660.4 119673.0 120119.4 72959.4 105602.5 106693.5 107302.5 110537.9 9520.0 9890.3 9914.8 9922.6 9982.7 55410.0 59295.1 60649.7 61038.9 61653.7 76605.6 78858.2 78924.2 82858.6 89392.0 12963.7 13148.4 13310.9 13428.3 13554.6 14674.9 14780.7 15072.3 15180.5 15359.1 13628.3 14103.9 14110.2 14207.0 14550.9 13922.3 13928.5 13943.4 13965.3 14039.6 13390.2 13483.4 13606.0 13611.6 13888.4 10996.2 11141.5 11237.4 11683.0 11770.6 10660.5 11326.8 11364.1 11522.7 11715.4 19:59:15 INFO - PROCESS | 2726 | -------- Summary: end -------- 19:59:15 INFO - PROCESS | 2726 | 19:59:16 INFO - TEST-INFO | 2726: exit 0 19:59:16 INFO - TEST-OK | dromaeo_css | took 1117467ms 19:59:16 INFO - TEST-START | kraken 19:59:16 INFO - operating with platform_type : mac_ 19:59:16 INFO - Initialising browser for kraken test... 19:59:16 INFO - TEST-INFO | started process 2732 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmpzXbZ5D/profile http://localhost:49309/getInfo.html) 19:59:18 INFO - PROCESS | 2732 | __metrics Screen width/height:1600/1200 19:59:18 INFO - PROCESS | 2732 | colorDepth:24 19:59:18 INFO - PROCESS | 2732 | Browser inner width/height: 1024/689 19:59:18 INFO - PROCESS | 2732 | __metrics 19:59:18 INFO - PROCESS | 2732 | 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" 19:59:18 INFO - PROCESS | 2732 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:59:19 INFO - TEST-INFO | 2732: exit 0 19:59:19 INFO - Browser initialized. 19:59:19 INFO - Running cycle 1/1 for kraken test... 19:59:19 INFO - TEST-INFO | started process 2733 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmpzXbZ5D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:59:31 INFO - PROCESS | 2733 | RSS: Main: 235868160 19:59:31 INFO - PROCESS | 2733 | 19:59:34 INFO - PROCESS | 2733 | Cycle 1(1): loaded http://localhost:49309/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49309/tests/kraken/driver.html?testName=audio-beat-detection) 19:59:35 INFO - PROCESS | 2733 | RSS: Main: 294027264 19:59:35 INFO - PROCESS | 2733 | 19:59:38 INFO - PROCESS | 2733 | Cycle 1(1): loaded http://localhost:49309/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49309/tests/kraken/driver.html?testName=audio-dft) 19:59:38 INFO - PROCESS | 2733 | RSS: Main: 293122048 19:59:38 INFO - PROCESS | 2733 | 19:59:42 INFO - PROCESS | 2733 | Cycle 1(1): loaded http://localhost:49309/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49309/tests/kraken/driver.html?testName=audio-fft) 19:59:42 INFO - PROCESS | 2733 | RSS: Main: 384102400 19:59:42 INFO - PROCESS | 2733 | 19:59:44 INFO - PROCESS | 2733 | Cycle 1(1): loaded http://localhost:49309/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49309/tests/kraken/driver.html?testName=audio-oscillator) 19:59:45 INFO - PROCESS | 2733 | RSS: Main: 284594176 19:59:45 INFO - PROCESS | 2733 | 19:59:47 INFO - PROCESS | 2733 | Cycle 1(1): loaded http://localhost:49309/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49309/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:59:48 INFO - PROCESS | 2733 | RSS: Main: 289488896 19:59:48 INFO - PROCESS | 2733 | 19:59:50 INFO - PROCESS | 2733 | Cycle 1(1): loaded http://localhost:49309/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49309/tests/kraken/driver.html?testName=imaging-darkroom) 19:59:51 INFO - PROCESS | 2733 | RSS: Main: 327827456 19:59:51 INFO - PROCESS | 2733 | 19:59:54 INFO - PROCESS | 2733 | Cycle 1(1): loaded http://localhost:49309/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49309/tests/kraken/driver.html?testName=imaging-desaturate) 19:59:54 INFO - PROCESS | 2733 | RSS: Main: 329842688 19:59:54 INFO - PROCESS | 2733 | 19:59:57 INFO - PROCESS | 2733 | Cycle 1(1): loaded http://localhost:49309/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49309/tests/kraken/driver.html?testName=json-parse-financial) 19:59:58 INFO - PROCESS | 2733 | RSS: Main: 326905856 19:59:58 INFO - PROCESS | 2733 | 19:59:59 INFO - PROCESS | 2733 | Cycle 1(1): loaded http://localhost:49309/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49309/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:00:00 INFO - PROCESS | 2733 | RSS: Main: 304484352 20:00:00 INFO - PROCESS | 2733 | 20:00:02 INFO - PROCESS | 2733 | Cycle 1(1): loaded http://localhost:49309/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49309/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:00:03 INFO - PROCESS | 2733 | RSS: Main: 304246784 20:00:03 INFO - PROCESS | 2733 | 20:00:05 INFO - PROCESS | 2733 | Cycle 1(1): loaded http://localhost:49309/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49309/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:00:06 INFO - PROCESS | 2733 | RSS: Main: 309235712 20:00:06 INFO - PROCESS | 2733 | 20:00:08 INFO - PROCESS | 2733 | Cycle 1(1): loaded http://localhost:49309/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49309/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:00:09 INFO - PROCESS | 2733 | RSS: Main: 317374464 20:00:09 INFO - PROCESS | 2733 | 20:00:12 INFO - PROCESS | 2733 | Cycle 1(1): loaded http://localhost:49309/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49309/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:00:13 INFO - PROCESS | 2733 | RSS: Main: 319176704 20:00:13 INFO - PROCESS | 2733 | 20:00:15 INFO - PROCESS | 2733 | Cycle 1(1): loaded http://localhost:49309/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49309/tests/kraken/driver.html?testName=ai-astar) 20:00:15 INFO - PROCESS | 2733 | RSS: Main: 362475520 20:00:15 INFO - PROCESS | 2733 | 20:00:15 INFO - PROCESS | 2733 | __start_tp_report 20:00:15 INFO - PROCESS | 2733 | _x_x_mozilla_page_load 20:00:15 INFO - PROCESS | 2733 | _x_x_mozilla_page_load_details 20:00:15 INFO - PROCESS | 2733 | |i|pagename|runs| 20:00:15 INFO - PROCESS | 2733 | |0;ai-astar;113;113;114;113;112;112;111;113;112;113 20:00:15 INFO - PROCESS | 2733 | |1;audio-beat-detection;149;109;109;158;140;139;126;109;139;110 20:00:15 INFO - PROCESS | 2733 | |2;audio-dft;185;184;185;187;185;184;183;185;183;183 20:00:15 INFO - PROCESS | 2733 | |3;audio-fft;80;61;58;88;62;61;61;59;81;58 20:00:15 INFO - PROCESS | 2733 | |4;audio-oscillator;91;70;92;70;68;69;92;68;68;89 20:00:15 INFO - PROCESS | 2733 | |5;imaging-gaussian-blur;87;84;87;84;87;84;88;84;90;89 20:00:15 INFO - PROCESS | 2733 | |6;imaging-darkroom;92;92;96;94;94;93;114;151;113;93 20:00:15 INFO - PROCESS | 2733 | |7;imaging-desaturate;86;85;83;84;85;85;84;87;84;85 20:00:15 INFO - PROCESS | 2733 | |8;json-parse-financial;55;53;53;54;55;54;55;55;54;55 20:00:15 INFO - PROCESS | 2733 | |9;json-stringify-tinderbox;65;73;69;74;71;69;69;69;69;73 20:00:15 INFO - PROCESS | 2733 | |10;stanford-crypto-aes;89;87;85;86;88;84;87;94;106;107 20:00:15 INFO - PROCESS | 2733 | |11;stanford-crypto-ccm;140;138;141;140;161;154;151;138;170;138 20:00:15 INFO - PROCESS | 2733 | |12;stanford-crypto-pbkdf2;186;246;206;171;226;170;169;171;170;169 20:00:15 INFO - PROCESS | 2733 | |13;stanford-crypto-sha256-iterative;68;69;63;80;85;85;73;67;67;66 20:00:15 INFO - PROCESS | 2733 | __end_tp_report 20:00:15 INFO - PROCESS | 2733 | __start_cc_report 20:00:15 INFO - PROCESS | 2733 | _x_x_mozilla_cycle_collect,1940 20:00:15 INFO - PROCESS | 2733 | __end_cc_report 20:00:15 INFO - PROCESS | 2733 | __startTimestamp1474686015392__endTimestamp 20:00:15 INFO - PROCESS | 2733 | 20:00:15 INFO - PROCESS | 2733 | ------- Summary: start ------- 20:00:15 INFO - PROCESS | 2733 | Number of tests: 14 20:00:15 INFO - PROCESS | 2733 | 20:00:15 INFO - PROCESS | 2733 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:0.84 (0.7%) stddev-sans-first:0.88 20:00:15 INFO - PROCESS | 2733 | Values: 113.0 113.0 114.0 113.0 112.0 112.0 111.0 113.0 112.0 113.0 20:00:15 INFO - PROCESS | 2733 | 20:00:15 INFO - PROCESS | 2733 | [#1] audio-beat-detection Cycles:10 Average:128.80 Median:139.00 stddev:18.65 (13.4%) stddev-sans-first:18.30 20:00:15 INFO - PROCESS | 2733 | Values: 149.0 109.0 109.0 158.0 140.0 139.0 126.0 109.0 139.0 110.0 20:00:15 INFO - PROCESS | 2733 | 20:00:15 INFO - PROCESS | 2733 | [#2] audio-dft Cycles:10 Average:184.40 Median:185.00 stddev:1.26 (0.7%) stddev-sans-first:1.32 20:00:15 INFO - PROCESS | 2733 | Values: 185.0 184.0 185.0 187.0 185.0 184.0 183.0 185.0 183.0 183.0 20:00:15 INFO - PROCESS | 2733 | 20:00:15 INFO - PROCESS | 2733 | [#3] audio-fft Cycles:10 Average:66.90 Median:61.50 stddev:11.38 (18.5%) stddev-sans-first:11.04 20:00:15 INFO - PROCESS | 2733 | Values: 80.0 61.0 58.0 88.0 62.0 61.0 61.0 59.0 81.0 58.0 20:00:15 INFO - PROCESS | 2733 | 20:00:15 INFO - PROCESS | 2733 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:79.50 stddev:11.50 (14.5%) stddev-sans-first:11.14 20:00:15 INFO - PROCESS | 2733 | Values: 91.0 70.0 92.0 70.0 68.0 69.0 92.0 68.0 68.0 89.0 20:00:15 INFO - PROCESS | 2733 | 20:00:15 INFO - PROCESS | 2733 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:87.00 stddev:2.27 (2.6%) stddev-sans-first:2.40 20:00:15 INFO - PROCESS | 2733 | Values: 87.0 84.0 87.0 84.0 87.0 84.0 88.0 84.0 90.0 89.0 20:00:15 INFO - PROCESS | 2733 | 20:00:15 INFO - PROCESS | 2733 | [#6] imaging-darkroom Cycles:10 Average:103.20 Median:93.00 stddev:18.79 (20.2%) stddev-sans-first:19.49 20:00:15 INFO - PROCESS | 2733 | Values: 92.0 92.0 96.0 94.0 94.0 93.0 114.0 151.0 113.0 93.0 20:00:15 INFO - PROCESS | 2733 | 20:00:15 INFO - PROCESS | 2733 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:1.14 (1.3%) stddev-sans-first:1.12 20:00:15 INFO - PROCESS | 2733 | Values: 86.0 85.0 83.0 84.0 85.0 85.0 84.0 87.0 84.0 85.0 20:00:15 INFO - PROCESS | 2733 | 20:00:15 INFO - PROCESS | 2733 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:55.00 stddev:0.82 (1.5%) stddev-sans-first:0.83 20:00:15 INFO - PROCESS | 2733 | Values: 55.0 53.0 53.0 54.0 55.0 54.0 55.0 55.0 54.0 55.0 20:00:15 INFO - PROCESS | 2733 | 20:00:15 INFO - PROCESS | 2733 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.00 stddev:2.69 (3.8%) stddev-sans-first:2.12 20:00:15 INFO - PROCESS | 2733 | Values: 65.0 73.0 69.0 74.0 71.0 69.0 69.0 69.0 69.0 73.0 20:00:15 INFO - PROCESS | 2733 | 20:00:15 INFO - PROCESS | 2733 | [#10] stanford-crypto-aes Cycles:10 Average:91.30 Median:87.00 stddev:8.46 (9.7%) stddev-sans-first:8.93 20:00:15 INFO - PROCESS | 2733 | Values: 89.0 87.0 85.0 86.0 88.0 84.0 87.0 94.0 106.0 107.0 20:00:15 INFO - PROCESS | 2733 | 20:00:15 INFO - PROCESS | 2733 | [#11] stanford-crypto-ccm Cycles:10 Average:147.10 Median:146.00 stddev:11.39 (7.8%) stddev-sans-first:11.78 20:00:15 INFO - PROCESS | 2733 | Values: 140.0 138.0 141.0 140.0 161.0 154.0 151.0 138.0 170.0 138.0 20:00:15 INFO - PROCESS | 2733 | 20:00:15 INFO - PROCESS | 2733 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.40 Median:178.50 stddev:28.05 (15.7%) stddev-sans-first:29.74 20:00:15 INFO - PROCESS | 2733 | Values: 186.0 246.0 206.0 171.0 226.0 170.0 169.0 171.0 170.0 169.0 20:00:15 INFO - PROCESS | 2733 | 20:00:15 INFO - PROCESS | 2733 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:71.00 stddev:8.12 (11.4%) stddev-sans-first:8.47 20:00:15 INFO - PROCESS | 2733 | Values: 68.0 69.0 63.0 80.0 85.0 85.0 73.0 67.0 67.0 66.0 20:00:15 INFO - PROCESS | 2733 | -------- Summary: end -------- 20:00:15 INFO - PROCESS | 2733 | 20:00:16 INFO - TEST-INFO | 2733: exit 0 20:00:16 INFO - TEST-OK | kraken | took 59946ms 20:00:16 INFO - SUITE-END | took 1177s 20:00:16 INFO - Completed test suite (00:19:37) 20:00:16 INFO - javascript benchmark 20:00:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3222.4844024956005, 3232.0627018164732, 3245.2049247934274, 3286.457734473812, 3295.242094318307, 5360.490753378433, 5403.91894121588, 5440.510354068133, 5457.263269458617, 5466.617336786427, 5453.427390124039, 5454.863628409292, 5467.562594992401, 5467.644603100795, 5474.589405794562, 4930.6055515558755, 5004.124278251292, 5006.649534532584, 5030.82392116276, 5076.959223359221, 5013.749312534359, 5084.339035925324, 5089.745512724349, 5090.109230884599, 5092.337996060507, 4752.714837109767, 4988.0, 5018.5232402921665, 5063.670861394016, 5078.415982162043, 4536.160810250098, 5095.159298715707, 5097.7960881564695, 5104.259882317043, 5150.150225212836, 4915.606751459874, 4967.230079337708, 4970.850874473772, 5004.124278251292, 5041.092603331399, 5266.8419947401635, 5333.4399888011585, 5402.216678581623, 5417.214503896952, 5417.729113544347, 5863.091220860773, 5875.9118613220835, 5883.911741323841, 5886.440788125121, 5911.793087241926, 5868.325142608612, 5949.583529152961, 5953.464188223081, 5987.820365389045, 6000.789972350947, 5461.644993075437, 5467.043267428184, 5519.751611177507, 5584.46947539983, 5586.581006424534, 6178.845528861814, 6188.412100850412, 6194.225721784777, 6195.783147589903, 6197.845053873599, 5676.375598684142, 5847.853803654943, 5854.824355269348, 5877.089051197071, 5878.323992740804, 5870.9412905870395, 6002.969985150046, 6021.277446706424, 6069.848253793602, 6090.573659843769, 5904.7342869570975, 5921.644701317849, 5922.141289512996, 5927.496162826122, 5939.613925094942, 5891.469767720926, 5941.940580594139, 5949.226600541989, 5960.731767070492, 5970.641761494324, 4633.443986721615, 4696.412948381452, 4709.222978208626, 4713.104510143062, 4744.146053710365, 4243.851465198765, 4248.787560621957, 4287.892802679896, 4291.785410729451, 4303.870883873489, 5432.266644003009, 5459.890802183934, 5468.48049435303, 5469.835904922858, 5477.4796394342475, 4527.4340707411575, 5051.26756620288, 5801.94198058014, 5866.882662346729, 5959.344472108151, 4975.651704380659, 5483.232347471358, 5492.670439773627, 5534.723263836792, 5542.445755424425, 5157.381114266237, 5158.742062896915, 5178.715170665574, 5180.844574662766, 5202.4277329493725, 6130.908036379458, 6226.221722284715, 6247.687615619201, 6256.186695729526, 6260.436560709558, 5821.76712931478, 5897.026990546512, 5897.941020589739, 5948.196993405835, 6014.278286605635, 6137.310331738248, 6193.907091393723, 6205.751769929333, 6219.937800621936, 6231.657258850625, 5834.416558344132, 5844.912326315194, 5852.619579727304, 5854.151148083419, 5866.208061911588, 4918.819483324048, 5791.913121303268, 5855.473007429352, 5900.793472228452, 5930.9110363343725, 5694.971525142348, 5714.3999880012, 5761.452661997104, 5768.653880767168, 5834.241548598655, 5637.0, 5726.828195154152, 5739.397363276963, 5753.194552762533, 5757.712114394348, 5416.458354164552, 5622.465865742912, 5623.550115990629, 5629.240052592848, 5642.125470552071, 4911.582515486224, 5549.9177660355845, 5722.542196624343, 5740.741666624928, 5742.856428589152, 4671.205894997791, 5472.835814925558, 5554.222408862682, 5584.581156413204, 5638.2670252866865], "value": 5420.644247100038, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.3514161307074, 507.74358948730884, 514.2132537218058, 521.6426747677839, 524.850417630975, 27736.167914962534, 30991.535126973115, 32364.67635323646, 39696.801515992454, 41033.0, 42424.57575424245, 43030.56969430305, 43034.35448468268, 43041.35437968425, 43182.784086079526, 9700.854487182698, 9858.359206651545, 9894.802103957953, 9895.55470003848, 9897.95051024744, 8711.477311361306, 8986.595603197838, 9689.273304502156, 9841.606335746561, 9865.556049977733, 11889.0, 12086.879131208707, 12088.697782555419, 12121.757564848698, 12273.631791046282, 11986.340751258676, 12052.517899284017, 12081.395930203498, 12084.697882552919, 12085.879141208563, 8664.696735614287, 8914.242289405409, 8932.062133475956, 11976.88023119775, 12017.399130043463, 31711.84144079288, 32037.51943720846, 38878.805605971786, 40104.79947600243, 40185.39721904174, 3335.149536868083, 3355.4799006154085, 3384.9661503384896, 3564.6078931317534, 3733.143159948681, 30279.545806812916, 30430.0, 30951.535726964114, 31026.0, 31551.84224078865, 3146.2606287522412, 3192.345569158317, 3242.7243684286864, 3259.8533066012087, 3340.131565792887, 452993.0, 455301.0, 457209.0, 459215.0, 459994.9999999967, 56470.0, 56821.43178568244, 56872.431275687544, 56911.0, 57013.71493142508, 50264.0, 51279.743601281756, 58248.0, 59068.704656476446, 59384.0, 15814.9209253953, 15909.363625455084, 15925.362985480682, 15958.76061859073, 15973.68052638964, 12416.441260143316, 12513.74972500545, 12536.81194782079, 12540.749185016248, 12561.183523070971, 13209.273489958145, 13482.561946703529, 13506.59480215595, 13635.86364136346, 13700.65748356299, 5723.885522289531, 6623.9006414903815, 6631.734730610818, 6673.4661227101715, 6746.83132921671, 873.8863947686888, 939.4081728511131, 996.9700908972742, 1009.535613617744, 1051.447989805343, 26927.461450770876, 30814.845925770227, 31033.051860073258, 32037.038888833373, 32891.3421731564, 954.8090381923643, 987.2891518106951, 1019.3272440189439, 1025.144004756037, 1032.390889375257, 14622.049566778338, 14687.77968330476, 14951.327190276465, 15202.0, 15288.464903728316, 636261.0, 641562.0, 641688.7915560486, 643647.0, 646021.0, 46090.07819843584, 46656.0, 52412.47587524076, 52897.471025290026, 53296.0, 1341.8792308692264, 1368.6304697731557, 1390.8122403475807, 1392.2481859795596, 1393.6028231953844, 28290.43419131647, 29593.260168495097, 29720.0, 30551.54172687456, 30801.075967721004, 48112.27831582599, 48647.0, 48675.269870951255, 48678.26982595335, 48762.0, 589307.0, 602456.0, 606186.0, 764852.0, 765490.0, 24807.50384992254, 25051.49897002086, 25114.24657260285, 25132.74867251377, 25135.497290054464, 45348.8662783433, 45766.542334576225, 46327.76836115798, 47659.52340476551, 49084.0, 38294.617053829104, 38340.61659383482, 38387.80806096063, 39631.60368396279, 39940.60059399369, 30533.847330763205, 36766.0, 37135.81432092822, 37816.81091594524, 38318.0, 37258.88223353304, 37325.6267437333, 38002.429963550014, 38034.0, 38141.618583813804, 31196.844015780684, 33609.72528265109, 33996.49005264873, 34333.193352931106, 34553.82723086469, 25031.374215644755, 25150.49699005973, 25315.0, 25350.873245633655, 26199.345016374744], "value": 19610.33424903184, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.631244568312, 362.2031530632609, 365.96157403472637, 372.7614326830829, 394.57780175212537, 14445.0, 15710.0573965562, 20604.55768096232, 20892.0, 21673.0, 19652.9017354913, 19850.0, 20164.0, 20400.69398959013, 20743.481412964647, 5824.767009319622, 5962.284525856903, 5975.193348897887, 6004.129401236818, 6037.366076561963, 4135.73117747347, 4299.699021068526, 4355.782210889459, 5846.0, 5937.079752638327, 6500.577462464948, 6515.7719479818215, 6604.801855944329, 6607.669616519179, 6629.403353698166, 6343.33394993526, 6515.250746164157, 6586.637734924578, 6612.2726500084955, 6619.867602647968, 5688.146777983295, 5690.260266165372, 5691.48776610103, 5694.259746233005, 5698.715064246812, 13183.0, 13339.666508337272, 23557.528849422917, 23660.698661573606, 24587.63118553223, 2139.016052615799, 2329.988350058256, 2394.760523947609, 2789.0, 2839.0914907229694, 8117.553534555597, 9986.950065249699, 10106.494675266207, 14251.144931304156, 15599.376024958989, 1841.6132612151464, 1904.3334832808546, 1905.9047047647562, 1938.5250613599617, 1953.345629214215, 91592.0, 116868.41565792201, 129262.3536882319, 130746.0, 132428.0, 9074.682386116587, 11085.778284434427, 11450.427478626036, 11532.0, 11663.941680291713, 12637.368131593383, 13178.0, 13216.933915330363, 13332.266725330006, 14146.0, 8298.834023319621, 8347.749567512985, 8371.121032291643, 8444.408891377545, 8536.061033286334, 6689.665516724144, 8411.621477033548, 8426.41015128935, 8445.1977062179, 8599.61301741423, 4399.450068741407, 4492.58483577672, 4493.123840851068, 4553.2942393929, 4577.656675749332, 1892.233645373626, 1906.9988256165625, 1912.7417798597012, 1913.980860191408, 1918.2327069172443, 792.4809249941297, 819.9918000820035, 896.3098414221014, 908.5003248213457, 979.7893452907516, 18113.637727245383, 19820.70268945967, 20836.895815520824, 20841.957902104834, 21416.78583214179, 891.5230351761905, 906.5920335848895, 923.1460898668705, 924.3945215883607, 971.5482300730054, 10467.371957682564, 10848.02367786903, 10946.960038796302, 10988.890111098946, 10994.34033957965, 596526.0, 600004.0, 604457.0, 616233.0, 616271.0, 130652.0, 131902.0, 134823.0, 135063.0, 135278.64721352857, 956.660385563129, 974.0989584634326, 1000.1448761308976, 1000.6497725795913, 1000.7648202672366, 14845.777313340093, 18285.725714114033, 18435.631287374446, 18544.81455185431, 18827.964461954725, 38044.04889877775, 41899.0, 47726.32957846459, 53271.46728532665, 55369.0, 75264.62367688127, 76285.61857190679, 77862.61068694621, 80649.0, 85011.57494212736, 7803.219678032151, 7876.72431464896, 8123.228293312126, 8134.593270336341, 8213.3429325655, 12456.937715311366, 12808.167469114478, 12857.0, 13148.60554183376, 13299.268540229994, 8273.420860539705, 11446.542138314375, 11496.48265828023, 11641.47613357384, 11643.544556930383, 10889.386547228449, 11058.22592418523, 11303.382917466331, 11471.369074700971, 11592.362420066976, 9644.75888102803, 11286.548538058714, 11584.362860042442, 11772.70568235801, 11846.407679615812, 6476.967615162082, 6753.763618273337, 7988.800279993046, 8262.42163048581, 8293.1706829319, 10178.643747468803, 11156.219064665396, 11422.0, 11483.8277425837, 11515.30908145514], "value": 9442.95788639169, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1372.2315503318148, 1401.3553765267977, 1550.1474189195942, 1733.5319463744788, 1919.2706771426865, 7040.577565346083, 7643.8089047773765, 8528.744137675872, 8770.517621530813, 8793.472391656505, 8741.562921853914, 8848.690295839648, 8849.380543361967, 8858.069902660225, 8871.802306688594, 2343.03935386492, 2372.8457650252763, 2376.95246095078, 2377.6909001829736, 2379.773921477457, 1936.5061909213132, 2381.214199314231, 2391.6651668766385, 2392.342105920868, 2393.150431596784, 2340.1692399198296, 2373.8694371809543, 2374.6794182785275, 2383.535210633927, 2385.8329916905823, 2326.8022218111482, 2351.6825228594093, 2360.221127028077, 2368.1829768729763, 2368.988155059231, 2307.526956973816, 2340.4382948092334, 2341.3444235614056, 2354.6232602783643, 2357.4342157881983, 8733.868991965126, 8826.205641492297, 8829.867551986661, 8830.293576513863, 8842.60208290622, 5127.6154288428515, 5327.813526526553, 5333.0, 5334.813281535127, 5349.277847490617, 3437.724982001459, 3600.0999750062483, 3661.1030297577, 3662.8717994870053, 3662.981685091584, 1047.61238341814, 1078.9190810689151, 1083.6044843632096, 1103.6413165721174, 1103.8013157631624, 11442.370669613169, 11482.368469734161, 11566.710832229262, 11584.478698458674, 11584.536618535249, 4283.443152390169, 4400.537943515948, 4522.5929666330185, 4560.315952607136, 4568.954310456919, 9054.83080921672, 9056.818863622691, 9064.229540489001, 9074.727758167266, 9080.772980675536, 5133.9743301284, 5143.974280128576, 5144.15121504955, 5151.742412879341, 5151.896962060738, 4060.857869974596, 4331.371951067078, 4458.242098843204, 4458.598726114666, 4819.3012013257885, 3629.8185090745355, 3711.9628803712158, 3745.1198968242443, 3795.259924314732, 3798.145417281145, 943.8206740719241, 1088.2001728729379, 1088.9401082940356, 1096.6490722968733, 1105.8285965675334, 870.8171284030425, 900.3787386703154, 918.3296193778579, 933.883264591926, 941.9835029331898, 5766.250387449605, 5998.950183717832, 6070.696465176724, 6073.5748497604745, 6358.682065896686, 835.2232423845882, 892.950782830172, 908.2325435007408, 911.1389736698756, 971.5967873332488, 3570.6607872252616, 3967.0677390813134, 4003.099302656937, 4045.5752146024834, 4167.604077612622, 10068.546915388824, 10334.844977325347, 10653.627123050655, 10655.946720266349, 10688.465576721133, 8597.441166324168, 10368.170546356274, 10553.788924221473, 10566.577336906437, 10615.416152111708, 7967.561784101814, 8031.277185053374, 8038.758837234892, 8047.034355877332, 8079.192080791991, 5998.190244316961, 6026.367231440811, 6129.877402452015, 6180.690965451619, 6288.119663247057, 9597.664081757104, 9742.171915387271, 9743.658971935949, 10131.392116473035, 10169.745756356151, 8946.507942062988, 9123.27013838878, 9727.708168754949, 10088.092071713581, 10246.538905749409, 7353.485256032026, 7563.659635316314, 8061.798455038436, 8134.308583770446, 8384.203500667427, 8245.752627421187, 8320.70877519284, 8340.499570025819, 8407.369447291356, 8421.70524031656, 7502.062242219723, 7559.395248380007, 7577.772666820004, 7600.885986710093, 7606.543607383574, 7350.154732205865, 7358.300961408658, 7376.4836461447185, 7413.962930185315, 7555.9244407555225, 6961.408280296231, 6963.8607227854145, 7008.264132266038, 7043.36609705129, 7049.718011279697, 4820.228763397839, 5015.3480047593575, 5055.393352797688, 5131.897362052813, 5247.895042099213, 4070.9389359159045, 4944.862681583328, 4999.700017998932, 5019.3976722793495, 5202.063628546898], "value": 4523.130265195314, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.2066589210294, 294.9557566365046, 304.9832259225743, 308.36015268318243, 310.76226686584755, 4679.906401871961, 4822.035592881421, 5163.81926632568, 5227.477252274775, 5262.47375262474, 4327.783610819462, 4938.728369939652, 4969.950300496994, 4994.7252901090515, 5029.949700502993, 3937.8621748238816, 3985.501812273466, 3988.6809055275507, 4002.1995600879795, 4040.919181616366, 3408.931821363571, 3865.4588357629814, 3964.385520244367, 4005.5593884672808, 4012.0341032893816, 3322.0, 3937.5274967003998, 3986.425361982015, 3988.5213774346976, 3997.3204555225534, 3633.563972323338, 3643.36241157799, 4023.517177938666, 4032.0, 4041.4139949707424, 2898.8985385511405, 3458.913527161816, 3481.756277060607, 3498.3178280235365, 3504.5794504659348, 4325.653947684178, 5001.799928002875, 5071.746412679388, 5081.822136225214, 5093.439721630618, 3768.8680896168503, 3808.990617486368, 4313.15893400787, 4546.727196368229, 4607.677462577621, 5410.5401040911565, 5418.4039755626845, 5446.786396026363, 5535.225068490415, 5537.916931246034, 3828.25349056934, 3829.6936245100324, 3831.597682243352, 3871.664275824836, 3901.921961560753, 4421.712588681726, 5028.918782461788, 5347.652402593819, 5633.943660563424, 5757.366689664133, 3245.253591673881, 3369.578802649669, 3697.299242348496, 3699.0, 3858.3826587745825, 3470.687638112582, 3781.865440367879, 3906.277338692351, 3971.801409929492, 3990.920181596352, 4231.386448964883, 4549.6360291176625, 4579.358889755437, 4589.770511474413, 4591.8392856249875, 4691.8417527936845, 5332.413434522199, 5365.248865158881, 5419.918701219485, 5466.453354664582, 1341.7048249385314, 1347.528365072217, 1361.4077876123918, 1365.4433945302362, 1366.4875671623142, 869.5608717597572, 905.4522014181325, 910.3036177324352, 937.6530683646957, 953.3755390219418, 4165.313697377843, 4658.836940707059, 5166.689998600096, 5179.8446046618665, 5182.5594824439595, 5474.671519708831, 5500.532454741312, 5586.720663966786, 5599.3044590570025, 5599.496045355938, 4584.303807591213, 4745.406824146981, 4773.618110551148, 5041.294218809297, 5108.361454818148, 2662.881589732317, 2882.337062475642, 2886.292858249742, 2890.580865774451, 2932.4721550121185, 5394.352677678625, 5562.499375056264, 5707.172459993278, 5714.0, 5737.3975732548315, 4265.786710664454, 4852.344933434012, 5633.760587662111, 5729.197912292282, 5744.856378590569, 5775.595708300379, 5780.017397042513, 5815.680137592473, 5868.0, 5870.7945221917025, 4671.906561868812, 5084.694918304914, 5587.3015873015875, 5642.689652069012, 5652.134795517387, 4717.844128188616, 5330.253764472899, 5608.513743857962, 5637.577181711306, 5638.85902852432, 5096.311997880239, 5840.853978650568, 5850.94149058521, 5916.970415147896, 5963.970180149245, 3319.0872510059926, 3654.4518322251874, 3656.4277360734077, 3768.2463507298103, 3792.241551689618, 5096.827729622281, 5561.524047470331, 5568.638038527645, 5572.275604171432, 5587.720613969366, 5129.179331306973, 5383.461653834585, 5476.58925580591, 5479.863003424787, 5508.20131080999, 4200.789960501902, 4711.2933060039895, 5386.407495175449, 5422.376426710821, 5447.3385617387075, 4154.813033413443, 5273.444333921426, 5292.947070529245, 5316.388615309289, 5325.760340784752, 4619.769011549476, 4771.141194585008, 5283.577313814809, 5349.090654588651, 5402.918956215582, 4279.079997800488, 4604.401427814362, 5278.97360513195, 5339.572834173335, 5341.9198712020125], "value": 3977.2036191058496, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.5664772812452, 766.5132640773107, 786.9055713314403, 812.6383759227147, 814.3226137192656, 15152.545423637295, 15867.365305387772, 15878.841211587895, 15903.204839758024, 16313.673726525461, 14091.840303802534, 14164.716705665905, 14176.85823141771, 14193.929030354833, 14200.289985500734, 666.3170250493234, 692.3284414118298, 692.394155114275, 831.6091437024619, 840.3571267979985, 847.5211505499373, 855.8331125430543, 863.9179277968615, 864.9740507784745, 865.8874346334968, 887.8535041718109, 912.8356895758761, 913.4975763330175, 913.5295322908707, 916.9403988740744, 693.1855070292437, 718.6406796601699, 900.5407242306438, 902.6885724425096, 903.5391950105428, 652.1489456259579, 677.3159109299643, 679.7247114918466, 680.5610381304081, 681.4037716997627, 15038.097714137186, 15108.39566417342, 15120.924395377953, 15127.319270632737, 15173.393064277416, 13480.662983425394, 13696.315184240848, 13813.309334533233, 13983.79024314636, 14230.928845355811, 11112.111031117573, 11647.126465515035, 11798.233114847593, 11882.22765520247, 11883.940580297043, 4562.634989200856, 4565.703229290086, 4587.610053145487, 4727.976360118212, 4820.276958456225, 106037.0, 107930.46034769855, 108344.0, 108596.0, 108880.0, 10270.743231419274, 10420.843687344695, 10758.515866786014, 10794.298370605886, 11007.834882476769, 20530.38408847737, 20544.28095016667, 20598.073086711134, 20610.793892060887, 20652.0, 7695.461317707819, 7740.729074482366, 7876.56678882667, 7934.960325198337, 7978.042634883851, 4343.543927887589, 4455.443069616298, 4492.460904691458, 4514.819407223675, 4579.633629309647, 3339.3154403347257, 3462.7056700180265, 3471.965280347164, 3474.4614584739406, 3480.5301284326797, 625.1622825413967, 645.2386184302568, 656.5305806348389, 658.6311665467354, 658.6509150150428, 525.915853463444, 580.2051189869906, 588.2793577867078, 654.5974225851163, 665.6505334699322, 8397.664093436195, 9046.366754327133, 9113.908860911439, 9162.267018638493, 9231.446113233227, 503.45626723139657, 527.3028459430064, 581.7411251992822, 593.7862369546959, 624.8843963866608, 4108.198901214294, 4409.426774519292, 4413.40419043425, 4465.933011004772, 4505.549445055468, 86470.7029394547, 118728.0, 124544.0, 130484.0, 133455.0, 78847.50177716673, 115969.0, 118660.40669796595, 119673.0, 120119.39940300242, 72959.43365097167, 105602.47198764111, 106693.46653266683, 107302.46348768362, 110537.94620537882, 9520.0, 9890.307678462726, 9914.752131196778, 9922.603095876084, 9982.650607228712, 55410.0, 59295.11057334057, 60649.69675151596, 61038.8961103886, 61653.691731541054, 76605.61697191701, 78858.21141788509, 78924.21075789169, 82858.58570707108, 89392.0, 12963.675908101995, 13148.40832162574, 13310.933445332712, 13428.328583570978, 13554.59336219915, 14674.853251467348, 14780.704385912437, 15072.321745521258, 15180.544583662508, 15359.078455292718, 13628.250446225553, 14103.858961410255, 14110.223937683526, 14207.0, 14550.92724536413, 13922.303884805922, 13928.51250206238, 13943.442262309394, 13965.301734913417, 14039.649008774863, 13390.196588204739, 13483.393247303698, 13606.0, 13611.591652250449, 13888.375023123781, 10996.175286853679, 11141.498632561392, 11237.381943992832, 11683.0, 11770.646880593597, 10660.520276587416, 11326.773464530499, 11364.090872729996, 11522.711932201762, 11715.355655439032], "value": 7666.883057483204, "unit": "score"}], "name": "dromaeo_css", "value": 7192.633347129116, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 113.0, 112.0, 112.0, 111.0, 113.0, 112.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 109.0, 109.0, 158.0, 140.0, 139.0, 126.0, 109.0, 139.0, 110.0], "value": 128.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 185.0, 187.0, 185.0, 184.0, 183.0, 185.0, 183.0, 183.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 61.0, 58.0, 88.0, 62.0, 61.0, 61.0, 59.0, 81.0, 58.0], "value": 66.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 92.0, 70.0, 68.0, 69.0, 92.0, 68.0, 68.0, 89.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 84.0, 87.0, 84.0, 88.0, 84.0, 90.0, 89.0], "value": 86.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 96.0, 94.0, 94.0, 93.0, 114.0, 151.0, 113.0, 93.0], "value": 103.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 83.0, 84.0, 85.0, 85.0, 84.0, 87.0, 84.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 54.0, 55.0, 54.0, 55.0, 55.0, 54.0, 55.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 69.0, 74.0, 71.0, 69.0, 69.0, 69.0, 69.0, 73.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 85.0, 86.0, 88.0, 84.0, 87.0, 94.0, 106.0, 107.0], "value": 91.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 138.0, 141.0, 140.0, 161.0, 154.0, 151.0, 138.0, 170.0, 138.0], "value": 147.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 246.0, 206.0, 171.0, 226.0, 170.0, 169.0, 171.0, 170.0, 169.0], "value": 188.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 63.0, 80.0, 85.0, 85.0, 73.0, 67.0, 67.0, 66.0], "value": 72.3, "unit": "score"}], "name": "kraken", "value": 1468.3, "alertThreshold": 2.0}]} 20:00:16 INFO - Return code: 0 20:00:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:00:16 INFO - # TBPL SUCCESS # 20:00:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:00:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:00:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:00:16 INFO - 2016-09-23 20:00:16.702 screenresolution[2737:15340] starting screenresolution argv=screenresolution get 20:00:16 INFO - 2016-09-23 20:00:16.705 screenresolution[2737:15340] Display 0: 1600x1200x32@60 20:00:16 INFO - 2016-09-23 20:00:16.712 screenresolution[2738:15343] starting screenresolution argv=screenresolution list 20:00:16 INFO - Available Modes on Display 0 20:00:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:00:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:00:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:00:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:00:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:00:16 INFO - Intel Iris: 20:00:16 INFO - Chipset Model: Intel Iris 20:00:16 INFO - Type: GPU 20:00:16 INFO - Bus: Built-In 20:00:16 INFO - VRAM (Dynamic, Max): 1536 MB 20:00:16 INFO - Vendor: Intel (0x8086) 20:00:16 INFO - Device ID: 0x0a2e 20:00:16 INFO - Revision ID: 0x0009 20:00:16 INFO - Displays: 20:00:16 INFO - Display: 20:00:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:00:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:00:16 INFO - Display Serial Number: 1600x1200 60 20:00:16 INFO - Main Display: Yes 20:00:16 INFO - Mirror: Off 20:00:16 INFO - Online: Yes 20:00:16 INFO - Rotation: Supported 20:00:16 INFO - Return code: 0 20:00:16 INFO - Running post-action listener: _resource_record_post_action 20:00:16 INFO - [mozharness: 2016-09-24 03:00:16.952694Z] Finished run-tests step (success) 20:00:16 INFO - Running post-run listener: _resource_record_post_run 20:00:17 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 33086464; Write bytes: 704877056; Read time: 322; Write time: 1948 20:00:17 INFO - TinderboxPrint: CPU usage
53.4% 20:00:17 INFO - TinderboxPrint: I/O read bytes / time
33,086,464 / 322 20:00:17 INFO - TinderboxPrint: I/O write bytes / time
704,877,056 / 1,948 20:00:17 INFO - TinderboxPrint: CPU idle
2,258.3 (46.6%) 20:00:17 INFO - TinderboxPrint: CPU system
966.9 (19.9%) 20:00:17 INFO - TinderboxPrint: CPU user
1,624.4 (33.5%) 20:00:17 INFO - TinderboxPrint: Swap in / out
436,113,408 / 0 20:00:17 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 397144576; Write bytes: 388761088; Read time: 29557; Write time: 685 20:00:17 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 31280128; Write bytes: 295201792; Read time: 303; Write time: 1212 20:00:17 INFO - Running post-run listener: _upload_blobber_files 20:00:17 INFO - Blob upload gear active. 20:00:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:00:17 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 20:00:17 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'] 20:00:17 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 20:00:17 INFO - (blobuploader) - INFO - Open directory for files ... 20:00:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:00:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:00:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:00:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:00:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:00:19 INFO - (blobuploader) - INFO - Done attempting. 20:00:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:00:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:00:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:00:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:00:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:00:20 INFO - (blobuploader) - INFO - Done attempting. 20:00:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:00:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:00:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:00:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:00:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:00:22 INFO - (blobuploader) - INFO - Done attempting. 20:00:22 INFO - (blobuploader) - INFO - Iteration through files over. 20:00:22 INFO - Return code: 0 20:00:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:00:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:00:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bbae503d3868171eb0d273018ef343aa5db570b20724293d4cb81e1715441a4be76eca1b815d00d6739ac39d41b3463f4f3511262bb2e6d4fd5db8e1ba3ab14c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0c76a1b38ebdde80e7544c969e5c8f74899d93ae7067c3d006140988d446c24c0cc4e1b3b7138f8919ee6d0c0653eedd9cceb1efcb04a4e6cacea5dec7747b90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4b8db7674bbc6abdb070bd1387f1cf5e2896435c7b7a6a02cdaafc65d419a423083da9a7f77115a2d8ceb4aa1597a4a90af19fceb0343efb1b12c10879bc68d7"} 20:00:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:00:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:00:22 INFO - Contents: 20:00:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bbae503d3868171eb0d273018ef343aa5db570b20724293d4cb81e1715441a4be76eca1b815d00d6739ac39d41b3463f4f3511262bb2e6d4fd5db8e1ba3ab14c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0c76a1b38ebdde80e7544c969e5c8f74899d93ae7067c3d006140988d446c24c0cc4e1b3b7138f8919ee6d0c0653eedd9cceb1efcb04a4e6cacea5dec7747b90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4b8db7674bbc6abdb070bd1387f1cf5e2896435c7b7a6a02cdaafc65d419a423083da9a7f77115a2d8ceb4aa1597a4a90af19fceb0343efb1b12c10879bc68d7"} 20:00:22 INFO - Running post-run listener: copy_logs_to_upload_dir 20:00:22 INFO - Copying logs to upload dir... 20:00:22 INFO - mkdir: /builds/slave/test/build/upload/logs 20:00:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.405615 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-23 20:00:22.523654) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 20:00:22.527436) ========= 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.LXRezOv0hV/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.6bKt9fPpxN/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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/bbae503d3868171eb0d273018ef343aa5db570b20724293d4cb81e1715441a4be76eca1b815d00d6739ac39d41b3463f4f3511262bb2e6d4fd5db8e1ba3ab14c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0c76a1b38ebdde80e7544c969e5c8f74899d93ae7067c3d006140988d446c24c0cc4e1b3b7138f8919ee6d0c0653eedd9cceb1efcb04a4e6cacea5dec7747b90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4b8db7674bbc6abdb070bd1387f1cf5e2896435c7b7a6a02cdaafc65d419a423083da9a7f77115a2d8ceb4aa1597a4a90af19fceb0343efb1b12c10879bc68d7"} build_url:https://queue.taskcluster.net/v1/task/R6LlDlZETNSMr8PD5gv6iQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011063 build_url: 'https://queue.taskcluster.net/v1/task/R6LlDlZETNSMr8PD5gv6iQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bbae503d3868171eb0d273018ef343aa5db570b20724293d4cb81e1715441a4be76eca1b815d00d6739ac39d41b3463f4f3511262bb2e6d4fd5db8e1ba3ab14c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0c76a1b38ebdde80e7544c969e5c8f74899d93ae7067c3d006140988d446c24c0cc4e1b3b7138f8919ee6d0c0653eedd9cceb1efcb04a4e6cacea5dec7747b90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4b8db7674bbc6abdb070bd1387f1cf5e2896435c7b7a6a02cdaafc65d419a423083da9a7f77115a2d8ceb4aa1597a4a90af19fceb0343efb1b12c10879bc68d7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 20:00:22.562893) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 20:00:22.563479) ========= 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.LXRezOv0hV/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.6bKt9fPpxN/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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.005147 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 20:00:22.613842) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 20:00:22.614337) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 20:00:22.614832) ========= ========= Total master_lag: 0.18 =========