builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0277 starttime: 1474507968.15 results: success (0) buildid: 20160921160459 builduid: c98c6180e2064d4886f343d26d5048ef revision: 1da8daaf2082616b3c19b31603eea886555aa2a2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 18:32:48.152684) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 18:32:48.153117) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 18:32:48.153410) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 18:32:48.180876) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 18:32:48.181162) ========= 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.iKX0SOlHPt/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.WstQzb8QvR/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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-21 18:32:48-- 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% 13.6M=0.001s 2016-09-21 18:32:48 (13.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.143457 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 18:32:48.350648) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 18:32:48.351332) ========= 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.iKX0SOlHPt/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.WstQzb8QvR/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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.031393 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 18:32:48.406085) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 18:32:48.406459) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 1da8daaf2082616b3c19b31603eea886555aa2a2 --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 1da8daaf2082616b3c19b31603eea886555aa2a2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iKX0SOlHPt/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.WstQzb8QvR/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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-21 18:32:48,491 truncating revision to first 12 chars 2016-09-21 18:32:48,491 Setting DEBUG logging. 2016-09-21 18:32:48,491 attempt 1/10 2016-09-21 18:32:48,491 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/1da8daaf2082?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-21 18:32:49,799 unpacking tar archive at: autoland-1da8daaf2082/testing/mozharness/ program finished with exit code 0 elapsedTime=1.573837 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 18:32:50.002838) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 18:32:50.003240) ========= script_repo_revision: 1da8daaf2082616b3c19b31603eea886555aa2a2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 18:32:50.003680) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 18:32:50.003954) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 18:32:50.023173) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-21 18:32:50.023484) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.iKX0SOlHPt/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.WstQzb8QvR/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 18:32:50 INFO - MultiFileLogger online at 20160921 18:32:50 in /builds/slave/test 18:32:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 18:32:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:32:50 INFO - {'append_to_log': False, 18:32:50 INFO - 'base_work_dir': '/builds/slave/test', 18:32:50 INFO - 'blob_upload_branch': 'Autoland', 18:32:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:32:50 INFO - 'branch': 'Autoland', 18:32:50 INFO - 'buildbot_json_path': 'buildprops.json', 18:32:50 INFO - 'config_files': ('talos/mac_config.py',), 18:32:50 INFO - 'default_actions': ('clobber', 18:32:50 INFO - 'read-buildbot-config', 18:32:50 INFO - 'download-and-extract', 18:32:50 INFO - 'populate-webroot', 18:32:50 INFO - 'create-virtualenv', 18:32:50 INFO - 'install', 18:32:50 INFO - 'run-tests'), 18:32:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:32:50 INFO - 'download_minidump_stackwalk': True, 18:32:50 INFO - 'download_symbols': 'ondemand', 18:32:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:32:50 INFO - 'tooltool.py': '/tools/tooltool.py', 18:32:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:32:50 INFO - '/tools/misc-python/virtualenv.py')}, 18:32:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:32:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:32:50 INFO - 'installer_path': 'installer.exe', 18:32:50 INFO - 'log_level': 'info', 18:32:50 INFO - 'log_name': 'talos', 18:32:50 INFO - 'log_to_console': True, 18:32:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:32:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:32:50 INFO - 'opt_config_files': (), 18:32:50 INFO - 'pip_index': False, 18:32:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:32:50 INFO - 'cmd': ('bash', 18:32:50 INFO - '-c', 18:32:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:32:50 INFO - 'enabled': True, 18:32:50 INFO - 'halt_on_failure': False, 18:32:50 INFO - 'name': 'check_screen_resolution'},), 18:32:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:32:50 INFO - 'cmd': ('bash', 18:32:50 INFO - '-c', 18:32:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:32:50 INFO - 'enabled': True, 18:32:50 INFO - 'halt_on_failure': False, 18:32:50 INFO - 'name': 'check_screen_resolution'},), 18:32:50 INFO - 'run_cmd_checks_enabled': True, 18:32:50 INFO - 'sps_profile': False, 18:32:50 INFO - 'sps_profile_interval': 0, 18:32:50 INFO - 'suite': 'dromaeojs-e10s', 18:32:50 INFO - 'system_bits': '32', 18:32:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:32:50 INFO - 'title': 't-yosemite-r7-0277', 18:32:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:32:50 INFO - 'use_talos_json': True, 18:32:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:32:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:32:50 INFO - 'work_dir': 'build'} 18:32:50 INFO - [mozharness: 2016-09-22 01:32:50.237222Z] Running clobber step. 18:32:50 INFO - Running pre-action listener: _resource_record_pre_action 18:32:50 INFO - Running main action method: clobber 18:32:50 INFO - rmtree: /builds/slave/test/build 18:32:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:32:52 INFO - Running post-action listener: _resource_record_post_action 18:32:52 INFO - [mozharness: 2016-09-22 01:32:52.246104Z] Finished clobber step (success) 18:32:52 INFO - [mozharness: 2016-09-22 01:32:52.246228Z] Running read-buildbot-config step. 18:32:52 INFO - Running pre-action listener: _resource_record_pre_action 18:32:52 INFO - Running main action method: read_buildbot_config 18:32:52 INFO - Using buildbot properties: 18:32:52 INFO - { 18:32:52 INFO - "project": "", 18:32:52 INFO - "product": "firefox", 18:32:52 INFO - "script_repo_revision": "production", 18:32:52 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 18:32:52 INFO - "repository": "", 18:32:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 18:32:52 INFO - "buildid": "20160921160459", 18:32:52 INFO - "pgo_build": "False", 18:32:52 INFO - "basedir": "/builds/slave/test", 18:32:52 INFO - "buildnumber": 184, 18:32:52 INFO - "slavename": "t-yosemite-r7-0277", 18:32:52 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 18:32:52 INFO - "platform": "yosemite_r7", 18:32:52 INFO - "scheduler": "tests-autoland-macosx64-talos-8-3600", 18:32:52 INFO - "branch": "autoland", 18:32:52 INFO - "repo_path": "integration/autoland", 18:32:52 INFO - "revision": "1da8daaf2082616b3c19b31603eea886555aa2a2", 18:32:52 INFO - "stage_platform": "macosx64", 18:32:52 INFO - "builduid": "c98c6180e2064d4886f343d26d5048ef", 18:32:52 INFO - "slavebuilddir": "test" 18:32:52 INFO - } 18:32:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/FGweUBgXQ7utetjdxf5ypA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 18:32:52 INFO - Running post-action listener: _resource_record_post_action 18:32:52 INFO - [mozharness: 2016-09-22 01:32:52.249472Z] Finished read-buildbot-config step (success) 18:32:52 INFO - [mozharness: 2016-09-22 01:32:52.249593Z] Running download-and-extract step. 18:32:52 INFO - Running pre-action listener: _resource_record_pre_action 18:32:52 INFO - Running main action method: download_and_extract 18:32:52 INFO - mkdir: /builds/slave/test/build/tests 18:32:52 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')]} 18:32:52 INFO - trying https://queue.taskcluster.net/v1/task/FGweUBgXQ7utetjdxf5ypA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 18:32:52 INFO - Downloading https://queue.taskcluster.net/v1/task/FGweUBgXQ7utetjdxf5ypA/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 18:32:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FGweUBgXQ7utetjdxf5ypA/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 18:32:53 INFO - Downloaded 1199 bytes. 18:32:53 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 18:32:53 INFO - Using the following test package requirements: 18:32:53 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 18:32:53 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:32:53 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 18:32:53 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:32:53 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 18:32:53 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:32:53 INFO - u'jsshell-mac.zip'], 18:32:53 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:32:53 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 18:32:53 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 18:32:53 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:32:53 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 18:32:53 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:32:53 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 18:32:53 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:32:53 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 18:32:53 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:32:53 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 18:32:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:32:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FGweUBgXQ7utetjdxf5ypA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 18:32:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FGweUBgXQ7utetjdxf5ypA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:32:53 INFO - Fetch https://queue.taskcluster.net/v1/task/FGweUBgXQ7utetjdxf5ypA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 18:32:54 INFO - Expected file size: 16434741 18:33:01 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 18:33:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FGweUBgXQ7utetjdxf5ypA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 18:33:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FGweUBgXQ7utetjdxf5ypA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:33:01 INFO - Fetch https://queue.taskcluster.net/v1/task/FGweUBgXQ7utetjdxf5ypA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 18:33:01 INFO - Expected file size: 16434741 18:33:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FGweUBgXQ7utetjdxf5ypA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 18:33:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FGweUBgXQ7utetjdxf5ypA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:33:08 INFO - Fetch https://queue.taskcluster.net/v1/task/FGweUBgXQ7utetjdxf5ypA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 18:33:08 INFO - Expected file size: 14414059 18:33:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:09 INFO - trying https://queue.taskcluster.net/v1/task/FGweUBgXQ7utetjdxf5ypA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 18:33:09 INFO - Downloading https://queue.taskcluster.net/v1/task/FGweUBgXQ7utetjdxf5ypA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 18:33:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FGweUBgXQ7utetjdxf5ypA/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 18:33:12 INFO - Downloaded 111326745 bytes. 18:33:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FGweUBgXQ7utetjdxf5ypA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 18:33:12 INFO - mkdir: /builds/slave/test/properties 18:33:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:33:12 INFO - Writing to file /builds/slave/test/properties/build_url 18:33:12 INFO - Contents: 18:33:12 INFO - build_url:https://queue.taskcluster.net/v1/task/FGweUBgXQ7utetjdxf5ypA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 18:33:13 INFO - Running post-action listener: _resource_record_post_action 18:33:13 INFO - Running post-action listener: set_extra_try_arguments 18:33:13 INFO - [mozharness: 2016-09-22 01:33:13.552807Z] Finished download-and-extract step (success) 18:33:13 INFO - [mozharness: 2016-09-22 01:33:13.552936Z] Running populate-webroot step. 18:33:13 INFO - Running pre-action listener: _resource_record_pre_action 18:33:13 INFO - Running main action method: populate_webroot 18:33:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:33:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:33:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:33:13 INFO - '--tppagecycles', 18:33:13 INFO - '7'], 18:33:13 INFO - 'tests': ['tsvgm']}}, 18:33:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:33:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:33:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:33:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:33:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:33:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:33:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:13 INFO - 'talos_options': ['--disable-e10s'], 18:33:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:33:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:33:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:13 INFO - 'talos_options': ['--disable-e10s'], 18:33:13 INFO - 'tests': ['damp', 'tps']}, 18:33:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:13 INFO - 'tests': ['damp', 'tps']}, 18:33:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:33:13 INFO - 'tests': ['dromaeo_dom']}, 18:33:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:33:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:33:13 INFO - 'tests': ['basic_compositor_video']}, 18:33:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:33:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:33:13 INFO - 'tests': ['a11yr', 18:33:13 INFO - 'ts_paint', 18:33:13 INFO - 'tpaint', 18:33:13 INFO - 'sessionrestore', 18:33:13 INFO - 'sessionrestore_no_auto_restore', 18:33:13 INFO - 'tabpaint']}, 18:33:13 INFO - 'other-e10s': {'tests': ['a11yr', 18:33:13 INFO - 'ts_paint', 18:33:13 INFO - 'tpaint', 18:33:13 INFO - 'sessionrestore', 18:33:13 INFO - 'sessionrestore_no_auto_restore', 18:33:13 INFO - 'tabpaint']}, 18:33:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:33:13 INFO - 'ts_paint', 18:33:13 INFO - 'tpaint', 18:33:13 INFO - 'sessionrestore', 18:33:13 INFO - 'sessionrestore_no_auto_restore', 18:33:13 INFO - 'tabpaint']}, 18:33:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:33:13 INFO - 'ts_paint', 18:33:13 INFO - 'tpaint', 18:33:13 INFO - 'sessionrestore', 18:33:13 INFO - 'sessionrestore_no_auto_restore', 18:33:13 INFO - 'tabpaint']}, 18:33:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:33:13 INFO - 'tests': ['a11yr', 18:33:13 INFO - 'ts_paint', 18:33:13 INFO - 'tpaint', 18:33:13 INFO - 'sessionrestore', 18:33:13 INFO - 'sessionrestore_no_auto_restore', 18:33:13 INFO - 'tabpaint']}, 18:33:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:33:13 INFO - 'tests': ['a11yr', 18:33:13 INFO - 'ts_paint', 18:33:13 INFO - 'tpaint', 18:33:13 INFO - 'sessionrestore', 18:33:13 INFO - 'sessionrestore_no_auto_restore', 18:33:13 INFO - 'tabpaint']}, 18:33:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:33:13 INFO - 'tests': ['tsvgx', 18:33:13 INFO - 'tsvgr_opacity', 18:33:13 INFO - 'tart', 18:33:13 INFO - 'tscrollx', 18:33:13 INFO - 'cart']}, 18:33:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:33:13 INFO - 'tsvgr_opacity', 18:33:13 INFO - 'tart', 18:33:13 INFO - 'tscrollx', 18:33:13 INFO - 'cart']}, 18:33:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:13 INFO - 'talos_options': ['--disable-e10s'], 18:33:13 INFO - 'tests': ['tp5o']}, 18:33:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:13 INFO - 'tests': ['tp5o']}, 18:33:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:13 INFO - 'talos_options': ['--disable-e10s', 18:33:13 INFO - '--xperf_path', 18:33:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:33:13 INFO - 'tests': ['tp5n']}, 18:33:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:13 INFO - 'talos_options': ['--xperf_path', 18:33:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:33:13 INFO - 'tests': ['tp5n']}}, 18:33:13 INFO - 'talos.zip': {'path': '', 18:33:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:33:13 INFO - Running post-action listener: _resource_record_post_action 18:33:13 INFO - [mozharness: 2016-09-22 01:33:13.572262Z] Finished populate-webroot step (success) 18:33:13 INFO - [mozharness: 2016-09-22 01:33:13.572396Z] Running create-virtualenv step. 18:33:13 INFO - Running pre-action listener: _resource_record_pre_action 18:33:13 INFO - Running main action method: create_virtualenv 18:33:13 INFO - Creating virtualenv /builds/slave/test/build/venv 18:33:13 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 18:33:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:33:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:33:13 INFO - Using real prefix '/tools/python27' 18:33:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:33:14 INFO - Installing distribute.............................................................................................................................................................................................done. 18:33:17 INFO - Installing pip.................done. 18:33:17 INFO - Return code: 0 18:33:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105723490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105699570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1e95957e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105537d30>, '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 0x10535ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10552fb20>, '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.iKX0SOlHPt/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.WstQzb8QvR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 18:33:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:33:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iKX0SOlHPt/Render', 18:33:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:17 INFO - 'HOME': '/Users/cltbld', 18:33:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:17 INFO - 'LOGNAME': 'cltbld', 18:33:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:17 INFO - 'MOZ_NO_REMOTE': '1', 18:33:17 INFO - 'NO_EM_RESTART': '1', 18:33:17 INFO - 'PAGER': '/bin/cat', 18:33:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:17 INFO - 'PWD': '/builds/slave/test', 18:33:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:17 INFO - 'SHELL': '/bin/bash', 18:33:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WstQzb8QvR/Listeners', 18:33:17 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 18:33:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:17 INFO - 'USER': 'cltbld', 18:33:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:17 INFO - 'XPC_FLAGS': '0x0', 18:33:17 INFO - 'XPC_SERVICE_NAME': '0', 18:33:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:17 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 18:33:17 INFO - Cleaning up... 18:33:17 INFO - Return code: 0 18:33:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105723490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105699570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1e95957e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105537d30>, '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 0x10535ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10552fb20>, '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.iKX0SOlHPt/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.WstQzb8QvR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 18:33:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:33:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iKX0SOlHPt/Render', 18:33:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:17 INFO - 'HOME': '/Users/cltbld', 18:33:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:17 INFO - 'LOGNAME': 'cltbld', 18:33:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:17 INFO - 'MOZ_NO_REMOTE': '1', 18:33:17 INFO - 'NO_EM_RESTART': '1', 18:33:17 INFO - 'PAGER': '/bin/cat', 18:33:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:17 INFO - 'PWD': '/builds/slave/test', 18:33:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:17 INFO - 'SHELL': '/bin/bash', 18:33:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WstQzb8QvR/Listeners', 18:33:17 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 18:33:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:17 INFO - 'USER': 'cltbld', 18:33:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:17 INFO - 'XPC_FLAGS': '0x0', 18:33:17 INFO - 'XPC_SERVICE_NAME': '0', 18:33:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:17 INFO - Downloading/unpacking psutil>=3.1.1 18:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:33:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:33:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:33:21 INFO - Installing collected packages: psutil 18:33:21 INFO - Running setup.py install for psutil 18:33:21 INFO - building 'psutil._psutil_osx' extension 18:33:21 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 18:33:21 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 18:33:21 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 18:33:21 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 18:33:21 INFO - building 'psutil._psutil_posix' extension 18:33:21 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 18:33:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:33:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:33:22 INFO - ^ 18:33:22 INFO - 1 warning generated. 18:33:22 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 18:33:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:33:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:33:22 INFO - Successfully installed psutil 18:33:22 INFO - Cleaning up... 18:33:22 INFO - Return code: 0 18:33:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105723490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105699570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1e95957e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105537d30>, '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 0x10535ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10552fb20>, '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.iKX0SOlHPt/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.WstQzb8QvR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 18:33:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:33:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iKX0SOlHPt/Render', 18:33:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:22 INFO - 'HOME': '/Users/cltbld', 18:33:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:22 INFO - 'LOGNAME': 'cltbld', 18:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:22 INFO - 'MOZ_NO_REMOTE': '1', 18:33:22 INFO - 'NO_EM_RESTART': '1', 18:33:22 INFO - 'PAGER': '/bin/cat', 18:33:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:22 INFO - 'PWD': '/builds/slave/test', 18:33:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:22 INFO - 'SHELL': '/bin/bash', 18:33:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WstQzb8QvR/Listeners', 18:33:22 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 18:33:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:22 INFO - 'USER': 'cltbld', 18:33:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:22 INFO - 'XPC_FLAGS': '0x0', 18:33:22 INFO - 'XPC_SERVICE_NAME': '0', 18:33:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:33:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:33:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:33:25 INFO - Installing collected packages: mozsystemmonitor 18:33:25 INFO - Running setup.py install for mozsystemmonitor 18:33:25 INFO - Successfully installed mozsystemmonitor 18:33:25 INFO - Cleaning up... 18:33:25 INFO - Return code: 0 18:33:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:33:25 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')]} 18:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:25 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')]} 18:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:25 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 0x105723490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105699570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1e95957e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105537d30>, '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 0x10535ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10552fb20>, '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.iKX0SOlHPt/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.WstQzb8QvR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 18:33:25 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 18:33:25 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 18:33:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iKX0SOlHPt/Render', 18:33:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:25 INFO - 'HOME': '/Users/cltbld', 18:33:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:25 INFO - 'LOGNAME': 'cltbld', 18:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:25 INFO - 'MOZ_NO_REMOTE': '1', 18:33:25 INFO - 'NO_EM_RESTART': '1', 18:33:25 INFO - 'PAGER': '/bin/cat', 18:33:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:25 INFO - 'PWD': '/builds/slave/test', 18:33:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:25 INFO - 'SHELL': '/bin/bash', 18:33:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WstQzb8QvR/Listeners', 18:33:25 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 18:33:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:25 INFO - 'USER': 'cltbld', 18:33:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:25 INFO - 'XPC_FLAGS': '0x0', 18:33:25 INFO - 'XPC_SERVICE_NAME': '0', 18:33:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:25 INFO - Downloading/unpacking jsonschema==2.5.1 18:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:33:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:28 INFO - Downloading functools32-3.2.3-2.tar.gz 18:33:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:33:28 INFO - warning: no files found matching '*.txt' 18:33:28 INFO - no previously-included directories found matching 'build' 18:33:28 INFO - no previously-included directories found matching 'dist' 18:33:28 INFO - no previously-included directories found matching '.git*' 18:33:28 INFO - Installing collected packages: jsonschema, functools32 18:33:28 INFO - Running setup.py install for functools32 18:33:28 INFO - warning: no files found matching '*.txt' 18:33:28 INFO - no previously-included directories found matching 'build' 18:33:28 INFO - no previously-included directories found matching 'dist' 18:33:28 INFO - no previously-included directories found matching '.git*' 18:33:28 INFO - Successfully installed jsonschema functools32 18:33:28 INFO - Cleaning up... 18:33:29 INFO - Return code: 0 18:33:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:33:29 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')]} 18:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:29 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')]} 18:33:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:29 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 0x105723490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105699570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1e95957e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105537d30>, '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 0x10535ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10552fb20>, '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.iKX0SOlHPt/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.WstQzb8QvR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 18:33:29 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 18:33:29 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 18:33:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iKX0SOlHPt/Render', 18:33:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:29 INFO - 'HOME': '/Users/cltbld', 18:33:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:29 INFO - 'LOGNAME': 'cltbld', 18:33:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:29 INFO - 'MOZ_NO_REMOTE': '1', 18:33:29 INFO - 'NO_EM_RESTART': '1', 18:33:29 INFO - 'PAGER': '/bin/cat', 18:33:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:29 INFO - 'PWD': '/builds/slave/test', 18:33:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:29 INFO - 'SHELL': '/bin/bash', 18:33:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WstQzb8QvR/Listeners', 18:33:29 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 18:33:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:29 INFO - 'USER': 'cltbld', 18:33:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:29 INFO - 'XPC_FLAGS': '0x0', 18:33:29 INFO - 'XPC_SERVICE_NAME': '0', 18:33:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:33:29 INFO - Cleaning up... 18:33:29 INFO - Return code: 0 18:33:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:33:29 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')]} 18:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:29 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')]} 18:33:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:29 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 0x105723490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105699570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1e95957e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105537d30>, '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 0x10535ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10552fb20>, '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.iKX0SOlHPt/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.WstQzb8QvR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 18:33:29 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 18:33:29 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 18:33:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iKX0SOlHPt/Render', 18:33:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:29 INFO - 'HOME': '/Users/cltbld', 18:33:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:29 INFO - 'LOGNAME': 'cltbld', 18:33:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:29 INFO - 'MOZ_NO_REMOTE': '1', 18:33:29 INFO - 'NO_EM_RESTART': '1', 18:33:29 INFO - 'PAGER': '/bin/cat', 18:33:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:29 INFO - 'PWD': '/builds/slave/test', 18:33:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:29 INFO - 'SHELL': '/bin/bash', 18:33:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WstQzb8QvR/Listeners', 18:33:29 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 18:33:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:29 INFO - 'USER': 'cltbld', 18:33:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:29 INFO - 'XPC_FLAGS': '0x0', 18:33:29 INFO - 'XPC_SERVICE_NAME': '0', 18:33:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:29 INFO - Downloading/unpacking blobuploader==1.2.4 18:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:32 INFO - Downloading blobuploader-1.2.4.tar.gz 18:33:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:33:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:33:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:33 INFO - Downloading docopt-0.6.1.tar.gz 18:33:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:33:33 INFO - Installing collected packages: blobuploader, requests, docopt 18:33:33 INFO - Running setup.py install for blobuploader 18:33:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:33:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:33:33 INFO - Running setup.py install for requests 18:33:34 INFO - Running setup.py install for docopt 18:33:34 INFO - Successfully installed blobuploader requests docopt 18:33:34 INFO - Cleaning up... 18:33:34 INFO - Return code: 0 18:33:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:33:34 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')]} 18:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:34 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')]} 18:33:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:34 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 0x105723490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105699570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1e95957e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105537d30>, '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 0x10535ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10552fb20>, '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.iKX0SOlHPt/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.WstQzb8QvR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 18:33:34 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 18:33:34 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 18:33:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iKX0SOlHPt/Render', 18:33:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:34 INFO - 'HOME': '/Users/cltbld', 18:33:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:34 INFO - 'LOGNAME': 'cltbld', 18:33:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:34 INFO - 'MOZ_NO_REMOTE': '1', 18:33:34 INFO - 'NO_EM_RESTART': '1', 18:33:34 INFO - 'PAGER': '/bin/cat', 18:33:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:34 INFO - 'PWD': '/builds/slave/test', 18:33:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:34 INFO - 'SHELL': '/bin/bash', 18:33:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WstQzb8QvR/Listeners', 18:33:34 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 18:33:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:34 INFO - 'USER': 'cltbld', 18:33:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:34 INFO - 'XPC_FLAGS': '0x0', 18:33:34 INFO - 'XPC_SERVICE_NAME': '0', 18:33:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:33:34 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-jYmrIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:33:34 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-m5ks_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:33:34 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-xtAMxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:33:34 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-XFuvmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:33:34 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-wOEMY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:33:35 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-gmwGW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:33:35 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-ajZmLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:33:35 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-XWXwid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:33:35 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-gbvXQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:33:35 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-39ehNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:33:35 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-lLNqAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:33:35 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-AfYFjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:33:35 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-Vvcxo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:33:35 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-05CH_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:36 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-SJVL8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:33:36 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-oO6lx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:33:36 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-nMYj8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:33:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:33:36 INFO - Running setup.py install for manifestparser 18:33:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:33:36 INFO - Running setup.py install for mozcrash 18:33:36 INFO - Running setup.py install for mozdebug 18:33:36 INFO - Running setup.py install for mozdevice 18:33:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:33:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:33:36 INFO - Running setup.py install for mozfile 18:33:37 INFO - Running setup.py install for mozhttpd 18:33:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:33:37 INFO - Running setup.py install for mozinfo 18:33:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:33:37 INFO - Running setup.py install for mozInstall 18:33:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:33:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:33:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:33:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:33:37 INFO - Running setup.py install for mozleak 18:33:37 INFO - Running setup.py install for mozlog 18:33:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:33:37 INFO - Running setup.py install for moznetwork 18:33:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:33:37 INFO - Running setup.py install for mozprocess 18:33:38 INFO - Running setup.py install for mozprofile 18:33:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:33:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:33:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:33:38 INFO - Running setup.py install for mozrunner 18:33:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:33:38 INFO - Running setup.py install for mozscreenshot 18:33:38 INFO - Running setup.py install for moztest 18:33:38 INFO - Running setup.py install for mozversion 18:33:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:33:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:33:38 INFO - Cleaning up... 18:33:38 INFO - Return code: 0 18:33:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:33: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')]} 18:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33: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')]} 18:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:38 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 0x105723490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105699570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1e95957e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105537d30>, '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 0x10535ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10552fb20>, '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.iKX0SOlHPt/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.WstQzb8QvR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 18:33:38 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 18:33:38 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 18:33:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iKX0SOlHPt/Render', 18:33:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:38 INFO - 'HOME': '/Users/cltbld', 18:33:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:38 INFO - 'LOGNAME': 'cltbld', 18:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:38 INFO - 'MOZ_NO_REMOTE': '1', 18:33:38 INFO - 'NO_EM_RESTART': '1', 18:33:38 INFO - 'PAGER': '/bin/cat', 18:33:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:38 INFO - 'PWD': '/builds/slave/test', 18:33:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:38 INFO - 'SHELL': '/bin/bash', 18:33:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WstQzb8QvR/Listeners', 18:33:38 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 18:33:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:38 INFO - 'USER': 'cltbld', 18:33:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:38 INFO - 'XPC_FLAGS': '0x0', 18:33:38 INFO - 'XPC_SERVICE_NAME': '0', 18:33:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:33:39 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-ZSpAJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:33:39 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)) 18:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:33:39 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-15FpXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:33:39 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)) 18:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:33:39 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-O2o5mY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:33:39 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)) 18:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:33:39 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-9T01Fk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:33:39 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)) 18:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:33:39 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-WTz5du-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:33:39 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)) 18:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:33:39 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-B_UHM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:33:39 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)) 18:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:33:39 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-qiNFx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:33:39 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)) 18:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:33:39 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-1eCdMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:33:40 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)) 18:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:33:40 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-0wSWjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:33:40 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)) 18:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:33:40 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-HXoVkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:33:40 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)) 18:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:33:40 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-kDPdFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:33:40 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)) 18:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:33:40 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-mAyE3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:33:40 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)) 18:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:33:40 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-pJaRMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:33:40 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)) 18:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:33:40 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-f1zOqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:33:40 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)) 18:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:40 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-5AH8p8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:40 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)) 18:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:33:40 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-7FH1gK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:33:40 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)) 18:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:33:40 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-qJta2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:33:40 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)) 18:33:40 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)) 18:33:40 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)) 18:33:40 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)) 18:33:40 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)) 18:33:40 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)) 18:33:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:43 INFO - Downloading blessings-1.6.tar.gz 18:33:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:33:43 INFO - Installing collected packages: blessings 18:33:43 INFO - Running setup.py install for blessings 18:33:43 INFO - Successfully installed blessings 18:33:43 INFO - Cleaning up... 18:33:43 INFO - Return code: 0 18:33:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:33:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:33:44 INFO - Reading from file tmpfile_stdout 18:33:44 INFO - Current package versions: 18:33:44 INFO - blessings == 1.6 18:33:44 INFO - blobuploader == 1.2.4 18:33:44 INFO - docopt == 0.6.1 18:33:44 INFO - functools32 == 3.2.3-2 18:33:44 INFO - jsonschema == 2.5.1 18:33:44 INFO - manifestparser == 1.1 18:33:44 INFO - mozInstall == 1.12 18:33:44 INFO - mozcrash == 0.17 18:33:44 INFO - mozdebug == 0.1 18:33:44 INFO - mozdevice == 0.48 18:33:44 INFO - mozfile == 1.2 18:33:44 INFO - mozhttpd == 0.7 18:33:44 INFO - mozinfo == 0.9 18:33:44 INFO - mozleak == 0.1 18:33:44 INFO - mozlog == 3.4 18:33:44 INFO - moznetwork == 0.27 18:33:44 INFO - mozprocess == 0.23 18:33:44 INFO - mozprofile == 0.28 18:33:44 INFO - mozrunner == 6.12 18:33:44 INFO - mozscreenshot == 0.1 18:33:44 INFO - mozsystemmonitor == 0.3 18:33:44 INFO - moztest == 0.7 18:33:44 INFO - mozversion == 1.4 18:33:44 INFO - psutil == 3.1.1 18:33:44 INFO - requests == 1.2.3 18:33:44 INFO - wsgiref == 0.1.2 18:33:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:33: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')]} 18:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33: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')]} 18:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:44 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 0x105723490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105699570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1e95957e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105537d30>, '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 0x10535ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10552fb20>, '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.iKX0SOlHPt/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.WstQzb8QvR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 18:33:44 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 18:33:44 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 18:33:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iKX0SOlHPt/Render', 18:33:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:44 INFO - 'HOME': '/Users/cltbld', 18:33:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:44 INFO - 'LOGNAME': 'cltbld', 18:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:44 INFO - 'MOZ_NO_REMOTE': '1', 18:33:44 INFO - 'NO_EM_RESTART': '1', 18:33:44 INFO - 'PAGER': '/bin/cat', 18:33:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:44 INFO - 'PWD': '/builds/slave/test', 18:33:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:44 INFO - 'SHELL': '/bin/bash', 18:33:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WstQzb8QvR/Listeners', 18:33:44 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 18:33:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:44 INFO - 'USER': 'cltbld', 18:33:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:44 INFO - 'XPC_FLAGS': '0x0', 18:33:44 INFO - 'XPC_SERVICE_NAME': '0', 18:33:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:44 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)) 18:33:44 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)) 18:33:44 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)) 18:33:44 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)) 18:33:44 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)) 18:33:44 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)) 18:33:44 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)) 18:33:44 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)) 18:33:44 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)) 18:33:44 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)) 18:33:44 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)) 18:33:44 INFO - Cleaning up... 18:33:44 INFO - Return code: 0 18:33:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:33: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')]} 18:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33: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')]} 18:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105723490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105699570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1e95957e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105537d30>, '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 0x10535ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10552fb20>, '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.iKX0SOlHPt/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.WstQzb8QvR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 18:33: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'] in /builds/slave/test/build 18:33: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 18:33:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iKX0SOlHPt/Render', 18:33:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:44 INFO - 'HOME': '/Users/cltbld', 18:33:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:44 INFO - 'LOGNAME': 'cltbld', 18:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:44 INFO - 'MOZ_NO_REMOTE': '1', 18:33:44 INFO - 'NO_EM_RESTART': '1', 18:33:44 INFO - 'PAGER': '/bin/cat', 18:33:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:44 INFO - 'PWD': '/builds/slave/test', 18:33:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:44 INFO - 'SHELL': '/bin/bash', 18:33:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WstQzb8QvR/Listeners', 18:33:44 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 18:33:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:44 INFO - 'USER': 'cltbld', 18:33:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:44 INFO - 'XPC_FLAGS': '0x0', 18:33:44 INFO - 'XPC_SERVICE_NAME': '0', 18:33:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:33:44 INFO - Cleaning up... 18:33:44 INFO - Return code: 0 18:33:44 INFO - Running post-action listener: _resource_record_post_action 18:33:44 INFO - Running post-action listener: _start_resource_monitoring 18:33:44 INFO - Starting resource monitoring. 18:33:44 INFO - [mozharness: 2016-09-22 01:33:44.584462Z] Finished create-virtualenv step (success) 18:33:44 INFO - [mozharness: 2016-09-22 01:33:44.585429Z] Running install step. 18:33:44 INFO - Running pre-action listener: _resource_record_pre_action 18:33:44 INFO - Running main action method: install 18:33:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:33:44 INFO - Reading from file tmpfile_stdout 18:33:44 INFO - Detecting whether we're running mozinstall >=1.0... 18:33:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:33:44 INFO - Reading from file tmpfile_stdout 18:33:44 INFO - Output received: 18:33:44 INFO - Usage: mozinstall [options] installer 18:33:44 INFO - Options: 18:33:44 INFO - -h, --help show this help message and exit 18:33:44 INFO - -d DEST, --destination=DEST 18:33:44 INFO - Directory to install application into. [default: 18:33:44 INFO - "/builds/slave/test"] 18:33:44 INFO - --app=APP Application being installed. [default: firefox] 18:33:44 INFO - mkdir: /builds/slave/test/build/application 18:33:44 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'] 18:33:44 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 18:34:19 INFO - Reading from file tmpfile_stdout 18:34:19 INFO - Output received: 18:34:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:34:19 INFO - Running post-action listener: _resource_record_post_action 18:34:19 INFO - [mozharness: 2016-09-22 01:34:19.123851Z] Finished install step (success) 18:34:19 INFO - [mozharness: 2016-09-22 01:34:19.123977Z] Running run-tests step. 18:34:19 INFO - Running pre-action listener: _resource_record_pre_action 18:34:19 INFO - Running main action method: run_tests 18:34:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:34:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:34:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:34:19 INFO - 2016-09-21 18:34:19.138 screenresolution[1636:7419] starting screenresolution argv=screenresolution get 18:34:19 INFO - 2016-09-21 18:34:19.141 screenresolution[1636:7419] Display 0: 1600x1200x32@60 18:34:19 INFO - 2016-09-21 18:34:19.147 screenresolution[1637:7421] starting screenresolution argv=screenresolution list 18:34:19 INFO - Available Modes on Display 0 18:34:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:34:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:34:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:34:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:34:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:34:19 INFO - Intel Iris: 18:34:19 INFO - Chipset Model: Intel Iris 18:34:19 INFO - Type: GPU 18:34:19 INFO - Bus: Built-In 18:34:19 INFO - VRAM (Dynamic, Max): 1536 MB 18:34:19 INFO - Vendor: Intel (0x8086) 18:34:19 INFO - Device ID: 0x0a2e 18:34:19 INFO - Revision ID: 0x0009 18:34:19 INFO - Displays: 18:34:19 INFO - Display: 18:34:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:34:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:34:19 INFO - Display Serial Number: 1600x1200 60 18:34:19 INFO - Main Display: Yes 18:34:19 INFO - Mirror: Off 18:34:19 INFO - Online: Yes 18:34:19 INFO - Rotation: Supported 18:34:19 INFO - Return code: 0 18:34:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:34:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:34:19 INFO - Python 2.7.3 18:34:19 INFO - Return code: 0 18:34:19 INFO - grabbing minidump binary from tooltool 18:34:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:34:19 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 0x105537d30>, '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 0x10535ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10552fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:34:19 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 18:34:19 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 18:34:19 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 18:34:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:34:19 INFO - Return code: 0 18:34:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:34:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:34:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:34:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:34:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:34:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FGweUBgXQ7utetjdxf5ypA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0277', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:34:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FGweUBgXQ7utetjdxf5ypA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0277 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:34:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iKX0SOlHPt/Render', 18:34:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:34:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:34:19 INFO - 'HOME': '/Users/cltbld', 18:34:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:34:19 INFO - 'LOGNAME': 'cltbld', 18:34:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:34:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:34:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:19 INFO - 'MOZ_NO_REMOTE': '1', 18:34:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:34:19 INFO - 'NO_EM_RESTART': '1', 18:34:19 INFO - 'PAGER': '/bin/cat', 18:34:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:34:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:19 INFO - 'PWD': '/builds/slave/test', 18:34:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:34:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:34:19 INFO - 'SHELL': '/bin/bash', 18:34:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WstQzb8QvR/Listeners', 18:34:19 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 18:34:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:34:19 INFO - 'USER': 'cltbld', 18:34:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:34:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:34:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:19 INFO - 'XPC_FLAGS': '0x0', 18:34:19 INFO - 'XPC_SERVICE_NAME': '0', 18:34:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:34:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FGweUBgXQ7utetjdxf5ypA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0277', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:34:19 INFO - mozversion application_buildid: 20160921160459 18:34:19 INFO - mozversion application_changeset: 1da8daaf2082616b3c19b31603eea886555aa2a2 18:34:19 INFO - mozversion application_display_name: Nightly 18:34:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:34:19 INFO - mozversion application_name: Firefox 18:34:19 INFO - mozversion application_remotingname: firefox 18:34:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 18:34:19 INFO - mozversion application_vendor: Mozilla 18:34:19 INFO - mozversion application_version: 52.0a1 18:34:19 INFO - mozversion platform_buildid: 20160921160459 18:34:19 INFO - mozversion platform_changeset: 1da8daaf2082616b3c19b31603eea886555aa2a2 18:34:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 18:34:19 INFO - mozversion platform_version: 52.0a1 18:34:19 INFO - using testdate: 1474508059 18:34:19 INFO - actual date: 1474508059 18:34:19 INFO - starting webserver on 'localhost:49267' 18:34:19 INFO - SUITE-START | Running 2 tests 18:34:19 INFO - TEST-START | dromaeo_css 18:34:19 INFO - operating with platform_type : mac_ 18:34:19 INFO - Initialising browser for dromaeo_css test... 18:34:19 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpqdg48p/profile http://localhost:49267/getInfo.html) 18:34:22 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 18:34:22 INFO - PROCESS | 1647 | colorDepth:24 18:34:22 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 18:34:22 INFO - PROCESS | 1647 | __metrics 18:34:22 ERROR - PROCESS | 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 18:34:23 INFO - TEST-INFO | 1647: exit 0 18:34:23 INFO - Browser initialized. 18:34:23 INFO - Running cycle 1/1 for dromaeo_css test... 18:34:23 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpqdg48p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:34:35 INFO - PROCESS | 1650 | RSS: Main: 239308800 18:34:35 INFO - PROCESS | 1650 | 18:35:25 INFO - PROCESS | 1650 | 1474508125099 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] 18:37:37 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 18:37:38 INFO - PROCESS | 1650 | RSS: Main: 252821504 18:37:38 INFO - PROCESS | 1650 | 18:40:40 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 18:40:41 INFO - PROCESS | 1650 | RSS: Main: 263372800 18:40:41 INFO - PROCESS | 1650 | 18:43:43 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 18:43:44 INFO - PROCESS | 1650 | RSS: Main: 269824000 18:43:44 INFO - PROCESS | 1650 | 18:46:45 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 18:46:46 INFO - PROCESS | 1650 | RSS: Main: 269598720 18:46:46 INFO - PROCESS | 1650 | 18:49:49 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 18:49:50 INFO - PROCESS | 1650 | RSS: Main: 274976768 18:49:50 INFO - PROCESS | 1650 | 18:52:52 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 18:52:52 INFO - PROCESS | 1650 | RSS: Main: 277512192 18:52:52 INFO - PROCESS | 1650 | 18:52:52 INFO - PROCESS | 1650 | __start_tp_report 18:52:52 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 18:52:52 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 18:52:52 INFO - PROCESS | 1650 | |i|pagename|runs| 18:52:52 INFO - PROCESS | 1650 | |0;dojo.html;3407.6081250656175;3415.52182694423;3454.6372630873757;3455.4471284594456;3463.982680086599;5646.802361917334;5745.511631511321;5753.913691294634;5825.679587622684;5853.853653658661;4243.596858298457;5597.964376590324;5715.742791574378;5784.855378615526;5868.970655146718;4835.395575553056;4904.509549045085;5256.9474305256845;5285.735713214343;5317.282166907476;5278.287431196797;5367.597430192732;5380.865478363033;5396.83809485716;5414;5183.352080989876;5190.11767999441;5270.9736451317885;5297.8940421191555;5351.83152011178;5240.213967904845;5322.121849894763;5330.973345133289;5346.866328341784;5382.8923421531745;5240.371155461369;5259.500347466985;5261.579073674096;5281.973590132025;5282.260483532308;5406.243125962329;5673.546116310727;5705.800296989585;5737.340205876294;5845.152452894349;5844.766209351664;6149.108379285023;6174.382561743834;6337.461315788118;6342.080398342215;6263.906041409383;6290;6312.116303717483;6313.810585682437;6334.588251763621;5735.741891614887;5863.061910094364;5867.735951882176;5870.823875283749;5872.324682661506;6169.167162433104;6214.37856214384;6236.844078898064;6263.3736626337;6331.588446750947;6170.136180934673;6219.40915613016;6240.500759939194;6247.968760156261;6249.281332646713;6220.533459990519;6311.084892690626;6320.4311611955145;6325.873482530324;6344.841378965562;6102.004547214544;6193.504519638508;6218.968905155445;6226.937730622636;6258.186435763321;6231.470325022424;6287.842803929939;6318.462930650854;6328.272248691367;6328.873422531616;4990.451050384455;5006.824761133343;5008.173651347487;5008.273800299009;5015.27278544609;4341.261985462479;4376.474823021258;4383.101464199832;4469.687121901436;4504.909901801946;5849.356570777211;5877.9118313225335;5935.258092738408;5971.253593300838;6013.977623803964;6272.341404152498;6278;6315.55791094619;6322.083297921868;6328.240611126695;5757.280339957505;5820.272465941757;5859.121131830259;5947.970260148758;5977.402259773988;5444.373897001817;5474.945250547444;5490.588205884575;5529.944700553024;5536.944630553723;6361.77733779334;6399.296077431386;6415.807525774234;6429.196350456193;6437.420632143129;6210.968945155426;6284.088807123033;6315.210598675166;6321.49428045746;6322.589031712924;6264;6296.307406185408;6356;6421.133147025092;6423.100765892872;6273.278572964167;6289.905651415141;6291;6309.432151106423;6321.747130114744;6075.726592303446;6169.1054797053275;6314.684265786784;6315.873682526416;6316.431521163117;4844.394450693663;5960.731767070405;6105.702364395134;6132.448079672851;6132.99804414626;6167.784127555514;6192.256929168529;6221.906671399842;6224.906626400698;6234.407731265523;4753.595944344631;5417.404085550507;5589.916151257816;6107.9921812900375;6133.969330153321;5091.92362114576;6177.722002509988;6228.283747369111;6239.126522286792;6266.091416744455;6052.455279024909;6081.361457047124;6084.209052823105;6091.269047714302;6115.541334399849 18:52:52 INFO - PROCESS | 1650 | |1;ext.html;473.4011475483514;481.3213369149499;482.9830955916544;518.8547206782102;533.4612041837744;29739.405211895777;37222.88331350057;40289.79855100724;40392.394114088274;40425.797871010676;39383.409248861215;40694.38958415626;41701.37447938283;41723.165536689245;41862.58137418625;9653.662121825737;9867.802643947116;9871.802563948753;9872.506374681274;9892.455914924676;9684.080012398847;9780.657676981307;9817.312788104835;9817.705468835946;9827;9744.512774361288;9755.219582433423;9794.069563391502;9800.31397802154;9802.754931126708;9588.376755510904;9646.228301735879;9680.90319096807;9712.320137590372;9742.853857192076;9718.271129665303;9734.269929755297;9806.117449429586;9819.06718861707;9825.754356141153;39648.80175599132;39846.20307593861;39890.80054599708;40007.19985600301;40145.19709605791;3254.2272322752797;3373.9156521086925;3531.4526248431534;3814.3324918139215;3895;29539.70460295391;29629.259268518243;29726.554101688493;30755.84622076875;32131.875384361436;3090.443720130376;3090.6909309069138;3104.8292343921075;3166.208447888028;3209.133533945845;280705.5964720184;313915;347570;352933;353140;32725.83637081847;57813.710931445916;58092.70953645205;58142.54643633858;58147.41852581505;31430;33706.98879033633;34573;34871.30257394838;34881.30237395238;12024.939875300568;14603.488877889224;14651.853481465048;14838.258087095603;14853.9602227843;12443.075877168858;12604.243745375306;12655.303958282382;12676.04929630263;12699.809502857464;7428.665710042953;7607.125180604191;7644.617769111522;7662.8084297893;7681.846363072707;2748.6564179477564;3166.509191075387;3207.935841283208;3218.5172224166563;3237.8866739664;958.4297343080856;977.2572844638127;1025.4001409175567;1054.536004158168;1077.4074259157433;28611.28471788222;29717.405651886842;29820.105396837695;30230.941917032796;30377.24056898595;971.3928794503436;1004.9849252261222;1026.461107918334;1120.6918097523082;1214.313912639356;11437.71405714847;15431.845681543266;15492.457763978207;15749.763753543706;15793.97339172973;675523;681277;682450;682872;683532;53082.46917530853;53127.468725312254;53222.733886331094;53531.39405817832;53573;1324.6754545136503;1332.666833291677;1355.2613825465342;1368.8631136886231;1373.9106958047696;20875.686864697345;28708.85645571842;29082.854585726935;29220.56169157507;29441;44550;47583.76208118937;48689.5131048685;48818.0236395263;48988.510114898396;497053;498746;600470;600579;602349;25753.098641547454;25785.484290313714;25991.350216243987;26260.60609090827;26268.737312627392;45106.03142372263;45228;45978.54021459743;46227;46281.305780414;38481.615183848924;38860.6113938857;39117;39894;40541.797291013354;32034.839825800722;38216.80891595524;38477.038074048374;38966.025849353995;39587.80206098951;23953.401164971016;32891.01326960195;33973;37758.43362349512;38175.854724358316;32430.35139297248;34348.656513434544;34349;34360.14099647529;34698;20457.38627841167;22834.086636534354;24943.251702448957;25093.87453062723;25241.747582523938 18:52:52 INFO - PROCESS | 1650 | |2;jquery.html;367.3112913287587;374.28698329681947;381.20138310240037;381.26986820239244;398.1499498570551;17459.738103928452;20003.699944500826;20211.59576808463;20369.287074952397;20615.38153855387;20232.898835505803;20381.59236815263;20479.897600512013;20501.48746281344;20888.477788055305;4980.800767969277;5882.3529411764675;6067.544934129935;6106.816795496142;6124.295705993801;6034.336223015464;6060.424259695344;6104.816855494342;6106.206193194878;6160.630362178261;5746.655200687972;5830.62100963436;5994.790182343619;6061.757529698807;6062.939370606304;4687.882802929937;5526.47498487643;5748.540116790647;5940.881182376372;6003.459688628044;5151.845444636667;5204;5205.011047900886;5214.895702085937;5241.68549887008;20308.08613612391;22335.776642233533;23631;23920.40198995039;24110.758892411202;2326.8720220387872;2439.195065628356;2443.596806526921;2483.1805504183576;2484.080890070685;14590.197539135343;14985.400583976629;15210.08739475635;15383;16118.194090295437;1767.1076106566102;1811.4203454894307;1848.6949653307188;1879.718042293667;1909.255390397746;106252;113816;114642;121757.39121304425;123337.76662233353;11360.943195284137;11450.19848610606;11553.13351498641;11625.418729063513;11754.529818807323;14274.2149181796;14368.281585920662;14389.712205756035;14405.78391324131;14450.566483005527;7046.788596342118;8325.750227493185;8486.872696909551;8521.233089021895;8641.481511109354;8359.456635318686;8516.40385173032;8524.31805455562;8638.956805215934;8698.478091314415;3586.497890295361;4490.595846373842;4518.932216016762;4557.521460246693;4597.011642496813;1582.6913751818515;1907.6089401672623;1929.778075521305;1968.5767559974674;1972.5660354721938;730.9305615966475;847.5550336073611;870.9303255739526;871.4727589808075;971.8930917599058;19553.315633952745;20347.57566970298;21368.893155534122;21387.57224855494;21520.139194432362;916.6150216908915;920.7652048727532;934.7849994501166;960.8318544254728;988.4267125067587;10495.737606559896;11165.83251251232;11200.663980080612;11223.887761122447;11288.717782055513;556895;576748;589174;593383;599494;101285.4807177893;122143;123611;140278.03466185438;148811;817.8977627796526;947.668316089377;966.0773960867355;969;1025.564135242519;19529.902350488155;19833.008349582753;19951.401457956286;19989.700154497405;21032;58880.705596471744;59042.81914361603;59202.40797591969;60484.395156049635;60596.182114536634;87386.68919966332;87628;87759;88834.55582722045;89026.66460003235;8058;8066.556339401389;8172.713955011546;8300.003999520097;8367.790805229917;11945.343006134746;12779;12801.551945681857;13085.803712944504;13293.003024773374;9251.36762171198;10899.346039237671;11278.492467838803;11377.975982161644;11566.248193867372;10890.782184356427;10955.726106847393;11365.659030229106;11507.309561426342;11530.250533715282;11195.44022798873;11371.715707107389;11717.941410292893;11764.352960586908;11820.940895295813;6922.930770692228;7930.170581013542;7960.243776841191;8353.164683531599;8372.33021358302;8279.37904657141;9297.6280948764;9326.834145731784;10518.211134164816;11377.317360958037 18:52:52 INFO - PROCESS | 1650 | |3;mootools.html;1388.9305534723262;1511.0706915247124;1695.7541156532302;1804.2873065139263;1866.4027511196423;8036.638351274192;8278.793030174249;8457.53483558404;9087.273018158548;9094.86357704635;8504.19210175034;8807.95596022019;8818.294536437086;8951.418157819737;8952.641894324235;2387.069043073203;2416.359664688859;2421.32202983165;2423.1882319423016;2426.7209270933804;2379.2624286471164;2398.136670798511;2429.8177636677233;2431.513697260546;2436.3300092474624;2402.3633737059695;2402.69053365916;2415.685960825099;2424.7090349158125;2432.2703189043305;2345.7419683834764;2386.832921695482;2390.22317746733;2410.481746424527;2412.4330782266243;2371.30046636241;2373.8100951923807;2381.618940969454;2389.0443822470975;2391.270662447953;8894.510801905893;8920.464772113693;8985.505797181153;8985.640574377017;8989.685361012333;5231.659942103751;5292.550133238679;5398.541124004464;5403.729813509348;5405.567554595662;3382.357352103117;3513.5608048993877;3565.3938830398893;3570.892873213808;3583.2475180212186;936.9063093690645;1012.6000229909218;1043.3844032021068;1043.8016776812458;1076.010070734918;9475.336726429152;11770.882291177064;11808.114391420591;11835.644930652094;11969.281843089355;4196.979015104905;4513.210188217049;4659.277811939155;4869.634777391639;4878.317035615017;10005;10104.494775261355;10108.29241953071;10133;10137.087662110445;5279.841604751864;5308.734563271821;5324.7870085196155;5329.520343169133;5346.331708536433;4037.7779222143063;4409.14021765759;4555.931661025087;4762.857114286577;4890.364252647133;3402.7750009996876;3419.692227699519;3940.9802950985063;3953.7627742334976;4037.1118353962083;1302.1275745250705;1310.050213595155;1314.3625341709264;1322.2991814338416;1331.6471135149193;799.94400391972;865.476386785998;905.2938707807921;909.3816204980677;952.9047095290415;5915.733791979371;6032.763283526867;6094.695265236721;6108.602940808833;6325.209348831396;938.6526985015588;944.7307517357658;965.8358079126565;977.8142152990908;981.3081777346953;3868;3976.8608098716404;4075;4111.424400583921;4147.6474499667265;10632.627858024933;10899.692036955616;10980.450977451095;11011.28426652265;11040.392778397105;10861.402622855661;10915.072218861327;10929.234953553334;10929.726756831144;10936;7805.843883122306;8192.877106843283;8308.584570771438;8437.620307086196;8471.152884711479;5905.257948904998;5984.790532331347;6023.789167379121;6113.908291375722;6225;9975.351602145838;10124.493775311057;10248.795024099625;10257.384556926609;10263.948680256552;9961.750956225862;10192.439415832201;10212.183025357805;10299.12457441096;10316.43259620698;6478.935210647834;7606.505577137468;7869.252421019994;8237.711680091168;8353.83292334162;8366;8398.958005209935;8438.282745966417;8484.19400156984;8624.223819856243;6352.396522330371;7224.674889629874;7510.586917719578;7514;7535.660895259836;7366.263373662591;7385.113786345458;7394.223606521237;7401.370883474965;7523.3229009389415;6859.039734437282;6945.479089068239;7017.087778588751;7033.226345101933;7048.154221493453;4989.201727723692;5040.319556859924;5047.41954675217;5057.241413787961;5103.87240318995;4417.668674849335;4928.96491736725;4939.382577177853;4996.7001979881325;5195.428502864757 18:52:52 INFO - PROCESS | 1650 | |4;prototype.html;268.3626387330091;302.6942787784337;309.4028524946852;310.02960732906007;315.5125331363044;4635.420572428447;4968.602511799057;5254.57963362931;5601.495865372116;5656.688882111493;4355.825766969318;5563.777448902039;5568.303962004749;5571.192177134313;5583.520367102721;3158.242021914747;3856.768593884376;3934.3705007198855;4075.9388609170887;4120.196561670476;4064.979675101635;4209.557996410379;4241.300185469394;4244.236037513247;4258;3674.6325367463173;3805.8772662064757;4199.5511548515715;4201.579842015804;4217.650351887397;3905.5899130591165;4173.061061261223;4177.597881218312;4234.74591524508;4240.872773816775;3059.3728285701377;3121.81269123851;3281.343731253735;3290.7860989035635;3580.2968758587363;4026.154507553388;4182.247195504808;4522.756242033434;5324.429293358468;5401.459854014606;4043.858464953742;4582.564656357641;4690.50749671283;4758.571728544413;4779.856604301876;4269.893252668677;4531.025829446652;5176.818811341585;5416.241726158341;5600.723576707631;3261.2988207535254;3869.9806500967316;3923.0780766519847;3931.941020884689;3970.114195757021;5368.973155134238;6177;6230.345813689588;6245.7501699931945;6249.375062493714;3415.3852306585054;3545.7340699447645;3965.2466031453932;3991.92016159681;3992.6007399260425;4019.8342480680276;4055.7769322687536;4077.878583389532;4080.7755573443746;4097.815598298083;3838.5777564467885;4486.955130448654;4774.737389443544;4788.808447662124;4803.495632958489;4767.308740232646;5199.922001169985;5801.73732244425;5982.042873140276;6019.839584218321;1370.5888233529902;1385.2242744063358;1392.554382597559;1393.2754967417088;1393.6097892590092;711.5766119159092;779.3492433817826;830.7175560309523;846.8144597563461;846.9667006252362;5189.299444575009;5398.24424580559;5595.832125036255;5607.495325420732;5624.29696287964;5246.658967167122;5663.745131469093;5819.243498345188;5870.823875283749;6060.818175454743;4781.545753153445;5215.58275337972;5454.3454785426;5501.587380946445;5564.499195072382;3110.2379916920045;3168.30297334586;3187.10760986924;3192.7286180674437;3193.6526652910093;5380.381256155592;5835.737391817378;6046.516278697693;6300.180976473121;6334.5249106317215;5316.468353164652;5671.2060311556415;6181.381861813783;6215.316315205324;6326.715297811517;5278.785879247795;5566.888662226733;5713.685747283939;6311.116443697886;6363.840903977252;5214.843554693365;6032.638041717511;6053.606515576474;6077.696115194134;6088.5737998341465;5354;5801.897639448492;5811.651300921958;5976.820695379146;5991.7902873399225;5791.362950075404;5929.762809487745;6318.62088274705;6358.904616430665;6365.267994180728;3913.158670885773;3923.4114882767813;3931.5478719947573;3935.783531905658;3947.6644485219076;6029.547783916136;6047.123167140828;6050.878982420239;6066.817995460143;6089.330173680803;5265.341832270966;5540.75066622011;5838.591298609056;5915.881682366243;5924.911126333194;5395.298611180521;5837.6281573829265;5855.443732845373;5876.676782776988;5944.73248703818;4594.747288899142;5729.759977616451;5768.942310577008;5771.278590176228;5806.622569532967;5002.149634562206;5258.763355649082;5557.583181261502;5773.191753154478;5806.390329015392;5762.855928601818;5778.855528611818;5801.622894511843;5813.970930145322;5895.557833162616 18:52:52 INFO - PROCESS | 1650 | |5;yui.html;570.5435651478817;624.1542709628454;714.6176795414455;716.1978583985937;726.0633782420678;14986.550403487885;15807.683846323067;15843.84156158438;15878.60303492412;15899.761503577442;11772.823407648892;12041.939790301058;14289.499867504639;14483.493077742281;14483.78274325886;662.9801105966828;689.5380095336137;825.0923983618032;833.2792134803396;849.1975083546051;791.6556298010383;843.7173546861809;865.277493293101;865.7402779166256;869.4783130121939;904.7195369435497;928.3269629518612;929.061647735785;934.5700977550301;936.6019441737268;917.6100157433098;919.7792529792869;920.7375897869075;921.3642586615248;921.4931787516906;673.5756473421762;680.5406350713249;681.0397339750976;686.1594546680327;687.9886566746924;15014.024088434326;15169.393224271016;15252.694946101126;15307.698845598026;15310.387584496606;11776.528938842435;14266.785998210034;14520.273986300643;14692.485762998243;14838.851611483855;11703.180777345504;11726.003289720298;11777.411129443493;11787.646370608896;11801.88198118025;3273.2635157089703;3767.9058023549355;3816.866409675648;3835.194609132058;3970.801459927021;104044;104499.43250851243;108402;108416.91583084226;110374;10818.188635852342;10823.188260880466;10934.45327733626;10941.179411544166;10972.610786431798;18636.72044919327;20871.58256834855;21367.03848326829;21924.903754812196;22033.118675253132;7895.684172633145;8075.313598344206;8087.272145506932;8098.959505202436;8405.915940840514;4444.533324000998;4468.3074123510905;4494.056248187917;4513.616342610915;4526.207913615104;3467.4798780183173;3587.2287458196615;3587.3542762303036;3600.207954250061;3612.8012959287494;620.2928661326092;620.9006558950637;628.5066223014911;643.7811144210991;648.2318452633644;584.5031723035471;587.7296443635976;593.5311104227612;632.0298342044939;638.1353266324064;8364.539950302791;8484.575771211415;9376.906230937604;9553.61785528585;9568;568.7582777319706;586.1237450012259;595.8093410108723;647.5758378262245;649.8375406148463;3910.980445097813;4361.327308557415;4475.619572336323;4669.859904202879;4836.782344794493;89743;141227.88158177637;147285;155431.2228438873;172234.13882930754;140486.2975685115;143488.1721290157;146797.3300667492;148383;154512;108317.458412709;116154.86915915804;125932;127996.44007119806;129529;7773.3004029637605;7889.526628402315;8367.66529338844;8370.665173392996;8383.28742056932;65518.34481655122;66047;67013.66493167503;68755.65622171857;68895.31104688889;59097.70451147717;70401;71509.99566164865;84879.5756021216;99142;12558.372081396077;12846.100772945803;13310.866891330963;13311.857266757526;13822.37799299014;14822.703545928805;14879.330430130454;14904.701905962036;14920.253987300808;15227.162506062274;14005.859941400455;14040.438382464587;14301.785473218119;14329.426822927384;14507.709845803236;12024.677285498763;13292.20246785196;13337.733245335234;13596.796048059485;13711.451541938211;13284.601461956157;13437.260950647807;13482.595522134352;13798.517051903134;14074.859251407355;10919.508622112184;11043.558257669603;11147.721306967067;11153.378955945509;11454.739978602514;10790.73023174427;11315.038221750914;11436.313821170756;11437.656870293904;11510.48202830858 18:52:52 INFO - PROCESS | 1650 | __end_tp_report 18:52:52 INFO - PROCESS | 1650 | __start_cc_report 18:52:52 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,371 18:52:52 INFO - PROCESS | 1650 | __end_cc_report 18:52:52 INFO - PROCESS | 1650 | __startTimestamp1474509172958__endTimestamp 18:52:52 INFO - PROCESS | 1650 | 18:52:52 INFO - PROCESS | 1650 | ------- Summary: start ------- 18:52:52 INFO - PROCESS | 1650 | Number of tests: 6 18:52:52 INFO - PROCESS | 1650 | 18:52:52 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5775.19 Median:6052.46 stddev:663.17 (11.0%) stddev-sans-first:638.67 18:52:52 INFO - PROCESS | 1650 | Values: 3407.6 3415.5 3454.6 3455.4 3464.0 5646.8 5745.5 5753.9 5825.7 5853.9 4243.6 5598.0 5715.7 5784.9 5869.0 4835.4 4904.5 5256.9 5285.7 5317.3 5278.3 5367.6 5380.9 5396.8 5414.0 5183.4 5190.1 5271.0 5297.9 5351.8 5240.2 5322.1 5331.0 5346.9 5382.9 5240.4 5259.5 5261.6 5282.0 5282.3 5406.2 5673.5 5705.8 5737.3 5845.2 5844.8 6149.1 6174.4 6337.5 6342.1 6263.9 6290.0 6312.1 6313.8 6334.6 5735.7 5863.1 5867.7 5870.8 5872.3 6169.2 6214.4 6236.8 6263.4 6331.6 6170.1 6219.4 6240.5 6248.0 6249.3 6220.5 6311.1 6320.4 6325.9 6344.8 6102.0 6193.5 6219.0 6226.9 6258.2 6231.5 6287.8 6318.5 6328.3 6328.9 4990.5 5006.8 5008.2 5008.3 5015.3 4341.3 4376.5 4383.1 4469.7 4504.9 5849.4 5877.9 5935.3 5971.3 6014.0 6272.3 6278.0 6315.6 6322.1 6328.2 5757.3 5820.3 5859.1 5948.0 5977.4 5444.4 5474.9 5490.6 5529.9 5536.9 6361.8 6399.3 6415.8 6429.2 6437.4 6211.0 6284.1 6315.2 6321.5 6322.6 6264.0 6296.3 6356.0 6421.1 6423.1 6273.3 6289.9 6291.0 6309.4 6321.7 6075.7 6169.1 6314.7 6315.9 6316.4 4844.4 5960.7 6105.7 6132.4 6133.0 6167.8 6192.3 6221.9 6224.9 6234.4 4753.6 5417.4 5589.9 6108.0 6134.0 5091.9 6177.7 6228.3 6239.1 6266.1 6052.5 6081.4 6084.2 6091.3 6115.5 18:52:52 INFO - PROCESS | 1650 | 18:52:52 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:64339.44 Median:38346.92 stddev:146333.62 (381.6%) stddev-sans-first:146665.56 18:52:52 INFO - PROCESS | 1650 | Values: 473.4 481.3 483.0 518.9 533.5 29739.4 37222.9 40289.8 40392.4 40425.8 39383.4 40694.4 41701.4 41723.2 41862.6 9653.7 9867.8 9871.8 9872.5 9892.5 9684.1 9780.7 9817.3 9817.7 9827.0 9744.5 9755.2 9794.1 9800.3 9802.8 9588.4 9646.2 9680.9 9712.3 9742.9 9718.3 9734.3 9806.1 9819.1 9825.8 39648.8 39846.2 39890.8 40007.2 40145.2 3254.2 3373.9 3531.5 3814.3 3895.0 29539.7 29629.3 29726.6 30755.8 32131.9 3090.4 3090.7 3104.8 3166.2 3209.1 280705.6 313915.0 347570.0 352933.0 353140.0 32725.8 57813.7 58092.7 58142.5 58147.4 31430.0 33707.0 34573.0 34871.3 34881.3 12024.9 14603.5 14651.9 14838.3 14854.0 12443.1 12604.2 12655.3 12676.0 12699.8 7428.7 7607.1 7644.6 7662.8 7681.8 2748.7 3166.5 3207.9 3218.5 3237.9 958.4 977.3 1025.4 1054.5 1077.4 28611.3 29717.4 29820.1 30230.9 30377.2 971.4 1005.0 1026.5 1120.7 1214.3 11437.7 15431.8 15492.5 15749.8 15794.0 675523.0 681277.0 682450.0 682872.0 683532.0 53082.5 53127.5 53222.7 53531.4 53573.0 1324.7 1332.7 1355.3 1368.9 1373.9 20875.7 28708.9 29082.9 29220.6 29441.0 44550.0 47583.8 48689.5 48818.0 48988.5 497053.0 498746.0 600470.0 600579.0 602349.0 25753.1 25785.5 25991.4 26260.6 26268.7 45106.0 45228.0 45978.5 46227.0 46281.3 38481.6 38860.6 39117.0 39894.0 40541.8 32034.8 38216.8 38477.0 38966.0 39587.8 23953.4 32891.0 33973.0 37758.4 38175.9 32430.4 34348.7 34349.0 34360.1 34698.0 20457.4 22834.1 24943.3 25093.9 25241.7 18:52:52 INFO - PROCESS | 1650 | 18:52:52 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:35047.70 Median:2483.63 stddev:97640.09 (3931.3%) stddev-sans-first:97879.27 18:52:52 INFO - PROCESS | 1650 | Values: 367.3 374.3 381.2 381.3 398.1 17459.7 20003.7 20211.6 20369.3 20615.4 20232.9 20381.6 20479.9 20501.5 20888.5 4980.8 5882.4 6067.5 6106.8 6124.3 6034.3 6060.4 6104.8 6106.2 6160.6 5746.7 5830.6 5994.8 6061.8 6062.9 4687.9 5526.5 5748.5 5940.9 6003.5 5151.8 5204.0 5205.0 5214.9 5241.7 20308.1 22335.8 23631.0 23920.4 24110.8 2326.9 2439.2 2443.6 2483.2 2484.1 14590.2 14985.4 15210.1 15383.0 16118.2 1767.1 1811.4 1848.7 1879.7 1909.3 106252.0 113816.0 114642.0 121757.4 123337.8 11360.9 11450.2 11553.1 11625.4 11754.5 14274.2 14368.3 14389.7 14405.8 14450.6 7046.8 8325.8 8486.9 8521.2 8641.5 8359.5 8516.4 8524.3 8639.0 8698.5 3586.5 4490.6 4518.9 4557.5 4597.0 1582.7 1907.6 1929.8 1968.6 1972.6 730.9 847.6 870.9 871.5 971.9 19553.3 20347.6 21368.9 21387.6 21520.1 916.6 920.8 934.8 960.8 988.4 10495.7 11165.8 11200.7 11223.9 11288.7 556895.0 576748.0 589174.0 593383.0 599494.0 101285.5 122143.0 123611.0 140278.0 148811.0 817.9 947.7 966.1 969.0 1025.6 19529.9 19833.0 19951.4 19989.7 21032.0 58880.7 59042.8 59202.4 60484.4 60596.2 87386.7 87628.0 87759.0 88834.6 89026.7 8058.0 8066.6 8172.7 8300.0 8367.8 11945.3 12779.0 12801.6 13085.8 13293.0 9251.4 10899.3 11278.5 11378.0 11566.2 10890.8 10955.7 11365.7 11507.3 11530.3 11195.4 11371.7 11717.9 11764.4 11820.9 6922.9 7930.2 7960.2 8353.2 8372.3 8279.4 9297.6 9326.8 10518.2 11377.3 18:52:52 INFO - PROCESS | 1650 | 18:52:52 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5753.64 Median:4884.34 stddev:3235.78 (66.2%) stddev-sans-first:3228.23 18:52:52 INFO - PROCESS | 1650 | Values: 1388.9 1511.1 1695.8 1804.3 1866.4 8036.6 8278.8 8457.5 9087.3 9094.9 8504.2 8808.0 8818.3 8951.4 8952.6 2387.1 2416.4 2421.3 2423.2 2426.7 2379.3 2398.1 2429.8 2431.5 2436.3 2402.4 2402.7 2415.7 2424.7 2432.3 2345.7 2386.8 2390.2 2410.5 2412.4 2371.3 2373.8 2381.6 2389.0 2391.3 8894.5 8920.5 8985.5 8985.6 8989.7 5231.7 5292.6 5398.5 5403.7 5405.6 3382.4 3513.6 3565.4 3570.9 3583.2 936.9 1012.6 1043.4 1043.8 1076.0 9475.3 11770.9 11808.1 11835.6 11969.3 4197.0 4513.2 4659.3 4869.6 4878.3 10005.0 10104.5 10108.3 10133.0 10137.1 5279.8 5308.7 5324.8 5329.5 5346.3 4037.8 4409.1 4555.9 4762.9 4890.4 3402.8 3419.7 3941.0 3953.8 4037.1 1302.1 1310.1 1314.4 1322.3 1331.6 799.9 865.5 905.3 909.4 952.9 5915.7 6032.8 6094.7 6108.6 6325.2 938.7 944.7 965.8 977.8 981.3 3868.0 3976.9 4075.0 4111.4 4147.6 10632.6 10899.7 10980.5 11011.3 11040.4 10861.4 10915.1 10929.2 10929.7 10936.0 7805.8 8192.9 8308.6 8437.6 8471.2 5905.3 5984.8 6023.8 6113.9 6225.0 9975.4 10124.5 10248.8 10257.4 10263.9 9961.8 10192.4 10212.2 10299.1 10316.4 6478.9 7606.5 7869.3 8237.7 8353.8 8366.0 8399.0 8438.3 8484.2 8624.2 6352.4 7224.7 7510.6 7514.0 7535.7 7366.3 7385.1 7394.2 7401.4 7523.3 6859.0 6945.5 7017.1 7033.2 7048.2 4989.2 5040.3 5047.4 5057.2 5103.9 4417.7 4929.0 4939.4 4996.7 5195.4 18:52:52 INFO - PROCESS | 1650 | 18:52:52 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4670.53 Median:5272.06 stddev:1482.43 (28.1%) stddev-sans-first:1449.30 18:52:52 INFO - PROCESS | 1650 | Values: 268.4 302.7 309.4 310.0 315.5 4635.4 4968.6 5254.6 5601.5 5656.7 4355.8 5563.8 5568.3 5571.2 5583.5 3158.2 3856.8 3934.4 4075.9 4120.2 4065.0 4209.6 4241.3 4244.2 4258.0 3674.6 3805.9 4199.6 4201.6 4217.7 3905.6 4173.1 4177.6 4234.7 4240.9 3059.4 3121.8 3281.3 3290.8 3580.3 4026.2 4182.2 4522.8 5324.4 5401.5 4043.9 4582.6 4690.5 4758.6 4779.9 4269.9 4531.0 5176.8 5416.2 5600.7 3261.3 3870.0 3923.1 3931.9 3970.1 5369.0 6177.0 6230.3 6245.8 6249.4 3415.4 3545.7 3965.2 3991.9 3992.6 4019.8 4055.8 4077.9 4080.8 4097.8 3838.6 4487.0 4774.7 4788.8 4803.5 4767.3 5199.9 5801.7 5982.0 6019.8 1370.6 1385.2 1392.6 1393.3 1393.6 711.6 779.3 830.7 846.8 847.0 5189.3 5398.2 5595.8 5607.5 5624.3 5246.7 5663.7 5819.2 5870.8 6060.8 4781.5 5215.6 5454.3 5501.6 5564.5 3110.2 3168.3 3187.1 3192.7 3193.7 5380.4 5835.7 6046.5 6300.2 6334.5 5316.5 5671.2 6181.4 6215.3 6326.7 5278.8 5566.9 5713.7 6311.1 6363.8 5214.8 6032.6 6053.6 6077.7 6088.6 5354.0 5801.9 5811.7 5976.8 5991.8 5791.4 5929.8 6318.6 6358.9 6365.3 3913.2 3923.4 3931.5 3935.8 3947.7 6029.5 6047.1 6050.9 6066.8 6089.3 5265.3 5540.8 5838.6 5915.9 5924.9 5395.3 5837.6 5855.4 5876.7 5944.7 4594.7 5729.8 5768.9 5771.3 5806.6 5002.1 5258.8 5557.6 5773.2 5806.4 5762.9 5778.9 5801.6 5814.0 5895.6 18:52:52 INFO - PROCESS | 1650 | 18:52:52 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:25075.34 Median:3527.35 stddev:40820.04 (1157.2%) stddev-sans-first:40893.08 18:52:52 INFO - PROCESS | 1650 | Values: 570.5 624.2 714.6 716.2 726.1 14986.6 15807.7 15843.8 15878.6 15899.8 11772.8 12041.9 14289.5 14483.5 14483.8 663.0 689.5 825.1 833.3 849.2 791.7 843.7 865.3 865.7 869.5 904.7 928.3 929.1 934.6 936.6 917.6 919.8 920.7 921.4 921.5 673.6 680.5 681.0 686.2 688.0 15014.0 15169.4 15252.7 15307.7 15310.4 11776.5 14266.8 14520.3 14692.5 14838.9 11703.2 11726.0 11777.4 11787.6 11801.9 3273.3 3767.9 3816.9 3835.2 3970.8 104044.0 104499.4 108402.0 108416.9 110374.0 10818.2 10823.2 10934.5 10941.2 10972.6 18636.7 20871.6 21367.0 21924.9 22033.1 7895.7 8075.3 8087.3 8099.0 8405.9 4444.5 4468.3 4494.1 4513.6 4526.2 3467.5 3587.2 3587.4 3600.2 3612.8 620.3 620.9 628.5 643.8 648.2 584.5 587.7 593.5 632.0 638.1 8364.5 8484.6 9376.9 9553.6 9568.0 568.8 586.1 595.8 647.6 649.8 3911.0 4361.3 4475.6 4669.9 4836.8 89743.0 141227.9 147285.0 155431.2 172234.1 140486.3 143488.2 146797.3 148383.0 154512.0 108317.5 116154.9 125932.0 127996.4 129529.0 7773.3 7889.5 8367.7 8370.7 8383.3 65518.3 66047.0 67013.7 68755.7 68895.3 59097.7 70401.0 71510.0 84879.6 99142.0 12558.4 12846.1 13310.9 13311.9 13822.4 14822.7 14879.3 14904.7 14920.3 15227.2 14005.9 14040.4 14301.8 14329.4 14507.7 12024.7 13292.2 13337.7 13596.8 13711.5 13284.6 13437.3 13482.6 13798.5 14074.9 10919.5 11043.6 11147.7 11153.4 11454.7 10790.7 11315.0 11436.3 11437.7 11510.5 18:52:52 INFO - PROCESS | 1650 | -------- Summary: end -------- 18:52:52 INFO - PROCESS | 1650 | 18:52:53 INFO - TEST-INFO | 1650: exit 0 18:52:53 INFO - TEST-OK | dromaeo_css | took 1113824ms 18:52:53 INFO - TEST-START | kraken 18:52:53 INFO - operating with platform_type : mac_ 18:52:53 INFO - Initialising browser for kraken test... 18:52:53 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpVDvxHU/profile http://localhost:49267/getInfo.html) 18:52:56 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 18:52:56 INFO - PROCESS | 1661 | colorDepth:24 18:52:56 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 18:52:56 INFO - PROCESS | 1661 | __metrics 18:52:56 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 18:52:57 INFO - TEST-INFO | 1661: exit 0 18:52:57 INFO - Browser initialized. 18:52:57 INFO - Running cycle 1/1 for kraken test... 18:52:57 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpVDvxHU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:53:09 INFO - PROCESS | 1663 | RSS: Main: 239194112 18:53:09 INFO - PROCESS | 1663 | 18:53:12 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 18:53:13 INFO - PROCESS | 1663 | RSS: Main: 252891136 18:53:13 INFO - PROCESS | 1663 | 18:53:15 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 18:53:16 INFO - PROCESS | 1663 | RSS: Main: 261517312 18:53:16 INFO - PROCESS | 1663 | 18:53:19 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 18:53:20 INFO - PROCESS | 1663 | RSS: Main: 261566464 18:53:20 INFO - PROCESS | 1663 | 18:53:22 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 18:53:22 INFO - PROCESS | 1663 | RSS: Main: 263897088 18:53:22 INFO - PROCESS | 1663 | 18:53:24 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:53:25 INFO - PROCESS | 1663 | RSS: Main: 264032256 18:53:25 INFO - PROCESS | 1663 | 18:53:28 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 18:53:29 INFO - PROCESS | 1663 | RSS: Main: 264966144 18:53:29 INFO - PROCESS | 1663 | 18:53:32 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 18:53:32 INFO - PROCESS | 1663 | RSS: Main: 265080832 18:53:32 INFO - PROCESS | 1663 | 18:53:35 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 18:53:36 INFO - PROCESS | 1663 | RSS: Main: 265383936 18:53:36 INFO - PROCESS | 1663 | 18:53:38 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:53:38 INFO - PROCESS | 1663 | RSS: Main: 265109504 18:53:38 INFO - PROCESS | 1663 | 18:53:40 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:53:41 INFO - PROCESS | 1663 | RSS: Main: 265199616 18:53:41 INFO - PROCESS | 1663 | 18:53:43 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:53:44 INFO - PROCESS | 1663 | RSS: Main: 265203712 18:53:44 INFO - PROCESS | 1663 | 18:53:47 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:53:47 INFO - PROCESS | 1663 | RSS: Main: 265519104 18:53:47 INFO - PROCESS | 1663 | 18:53:50 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:53:51 INFO - PROCESS | 1663 | RSS: Main: 266055680 18:53:51 INFO - PROCESS | 1663 | 18:53:53 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 18:53:53 INFO - PROCESS | 1663 | RSS: Main: 267034624 18:53:53 INFO - PROCESS | 1663 | 18:53:53 INFO - PROCESS | 1663 | __start_tp_report 18:53:53 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 18:53:53 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 18:53:53 INFO - PROCESS | 1663 | |i|pagename|runs| 18:53:53 INFO - PROCESS | 1663 | |0;ai-astar;108;115;113;117;112;155;166;180;116;117 18:53:53 INFO - PROCESS | 1663 | |1;audio-beat-detection;167;114;110;148;109;107;111;113;138;114 18:53:53 INFO - PROCESS | 1663 | |2;audio-dft;191;195;203;266;281;231;196;201;213;198 18:53:53 INFO - PROCESS | 1663 | |3;audio-fft;81;59;60;82;65;72;83;60;80;60 18:53:53 INFO - PROCESS | 1663 | |4;audio-oscillator;87;71;86;71;69;71;87;71;70;84 18:53:53 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;88;104;120;133;124;105;93;105;123;78 18:53:53 INFO - PROCESS | 1663 | |6;imaging-darkroom;96;97;97;106;93;154;114;111;155;107 18:53:53 INFO - PROCESS | 1663 | |7;imaging-desaturate;96;90;94;128;149;91;92;91;92;105 18:53:53 INFO - PROCESS | 1663 | |8;json-parse-financial;57;58;60;59;58;61;60;59;59;58 18:53:53 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;70;72;71;75;83;76;70;71;72;72 18:53:53 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;90;109;110;111;94;90;87;90;96;88 18:53:53 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;140;139;139;138;139;139;138;140;188;157 18:53:53 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;180;176;174;174;175;174;174;176;173;172 18:53:53 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;71;68;68;71;71;71;75;69;66;68 18:53:53 INFO - PROCESS | 1663 | __end_tp_report 18:53:53 INFO - PROCESS | 1663 | __start_cc_report 18:53:53 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,914 18:53:53 INFO - PROCESS | 1663 | __end_cc_report 18:53:53 INFO - PROCESS | 1663 | __startTimestamp1474509233272__endTimestamp 18:53:53 INFO - PROCESS | 1663 | 18:53:53 INFO - PROCESS | 1663 | ------- Summary: start ------- 18:53:53 INFO - PROCESS | 1663 | Number of tests: 14 18:53:53 INFO - PROCESS | 1663 | 18:53:53 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:129.90 Median:117.00 stddev:26.41 (22.6%) stddev-sans-first:26.80 18:53:53 INFO - PROCESS | 1663 | Values: 108.0 115.0 113.0 117.0 112.0 155.0 166.0 180.0 116.0 117.0 18:53:53 INFO - PROCESS | 1663 | 18:53:53 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:123.10 Median:114.00 stddev:20.58 (18.1%) stddev-sans-first:14.45 18:53:53 INFO - PROCESS | 1663 | Values: 167.0 114.0 110.0 148.0 109.0 107.0 111.0 113.0 138.0 114.0 18:53:53 INFO - PROCESS | 1663 | 18:53:53 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:217.50 Median:208.00 stddev:31.83 (15.3%) stddev-sans-first:32.29 18:53:53 INFO - PROCESS | 1663 | Values: 191.0 195.0 203.0 266.0 281.0 231.0 196.0 201.0 213.0 198.0 18:53:53 INFO - PROCESS | 1663 | 18:53:53 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:70.20 Median:76.00 stddev:10.45 (13.8%) stddev-sans-first:10.33 18:53:53 INFO - PROCESS | 1663 | Values: 81.0 59.0 60.0 82.0 65.0 72.0 83.0 60.0 80.0 60.0 18:53:53 INFO - PROCESS | 1663 | 18:53:53 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:76.70 Median:77.50 stddev:8.07 (10.4%) stddev-sans-first:7.65 18:53:53 INFO - PROCESS | 1663 | Values: 87.0 71.0 86.0 71.0 69.0 71.0 87.0 71.0 70.0 84.0 18:53:53 INFO - PROCESS | 1663 | 18:53:53 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:107.30 Median:128.50 stddev:17.65 (13.7%) stddev-sans-first:17.29 18:53:53 INFO - PROCESS | 1663 | Values: 88.0 104.0 120.0 133.0 124.0 105.0 93.0 105.0 123.0 78.0 18:53:53 INFO - PROCESS | 1663 | 18:53:53 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:113.00 Median:124.00 stddev:22.94 (18.5%) stddev-sans-first:23.49 18:53:53 INFO - PROCESS | 1663 | Values: 96.0 97.0 97.0 106.0 93.0 154.0 114.0 111.0 155.0 107.0 18:53:53 INFO - PROCESS | 1663 | 18:53:53 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:102.80 Median:91.50 stddev:19.93 (21.8%) stddev-sans-first:20.98 18:53:53 INFO - PROCESS | 1663 | Values: 96.0 90.0 94.0 128.0 149.0 91.0 92.0 91.0 92.0 105.0 18:53:53 INFO - PROCESS | 1663 | 18:53:53 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:59.00 stddev:1.20 (2.0%) stddev-sans-first:1.05 18:53:53 INFO - PROCESS | 1663 | Values: 57.0 58.0 60.0 59.0 58.0 61.0 60.0 59.0 59.0 58.0 18:53:53 INFO - PROCESS | 1663 | 18:53:53 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:73.20 Median:72.00 stddev:3.97 (5.5%) stddev-sans-first:4.03 18:53:53 INFO - PROCESS | 1663 | Values: 70.0 72.0 71.0 75.0 83.0 76.0 70.0 71.0 72.0 72.0 18:53:53 INFO - PROCESS | 1663 | 18:53:53 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:96.50 Median:90.00 stddev:9.69 (10.8%) stddev-sans-first:9.98 18:53:53 INFO - PROCESS | 1663 | Values: 90.0 109.0 110.0 111.0 94.0 90.0 87.0 90.0 96.0 88.0 18:53:53 INFO - PROCESS | 1663 | 18:53:53 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:145.70 Median:139.50 stddev:15.92 (11.4%) stddev-sans-first:16.75 18:53:53 INFO - PROCESS | 1663 | Values: 140.0 139.0 139.0 138.0 139.0 139.0 138.0 140.0 188.0 157.0 18:53:53 INFO - PROCESS | 1663 | 18:53:53 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:174.50 stddev:2.20 (1.3%) stddev-sans-first:1.30 18:53:53 INFO - PROCESS | 1663 | Values: 180.0 176.0 174.0 174.0 175.0 174.0 174.0 176.0 173.0 172.0 18:53:53 INFO - PROCESS | 1663 | 18:53:53 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:71.00 stddev:2.53 (3.6%) stddev-sans-first:2.65 18:53:53 INFO - PROCESS | 1663 | Values: 71.0 68.0 68.0 71.0 71.0 71.0 75.0 69.0 66.0 68.0 18:53:53 INFO - PROCESS | 1663 | -------- Summary: end -------- 18:53:53 INFO - PROCESS | 1663 | 18:53:54 INFO - TEST-INFO | 1663: exit 0 18:53:54 INFO - TEST-OK | kraken | took 60567ms 18:53:54 INFO - SUITE-END | took 1174s 18:53:54 INFO - Completed test suite (00:19:34) 18:53:54 INFO - javascript benchmark 18:53:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7289.375342731694, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3407.6081250656175, 3415.52182694423, 3454.6372630873757, 3455.4471284594456, 3463.982680086599, 5646.802361917334, 5745.511631511321, 5753.913691294634, 5825.679587622684, 5853.853653658661, 4243.596858298457, 5597.964376590324, 5715.742791574378, 5784.855378615526, 5868.970655146718, 4835.395575553056, 4904.509549045085, 5256.9474305256845, 5285.735713214343, 5317.282166907476, 5278.287431196797, 5367.597430192732, 5380.865478363033, 5396.83809485716, 5414.0, 5183.352080989876, 5190.11767999441, 5270.9736451317885, 5297.8940421191555, 5351.83152011178, 5240.213967904845, 5322.121849894763, 5330.973345133289, 5346.866328341784, 5382.8923421531745, 5240.371155461369, 5259.500347466985, 5261.579073674096, 5281.973590132025, 5282.260483532308, 5406.243125962329, 5673.546116310727, 5705.800296989585, 5737.340205876294, 5845.152452894349, 5844.766209351664, 6149.108379285023, 6174.382561743834, 6337.461315788118, 6342.080398342215, 6263.906041409383, 6290.0, 6312.116303717483, 6313.810585682437, 6334.588251763621, 5735.741891614887, 5863.061910094364, 5867.735951882176, 5870.823875283749, 5872.324682661506, 6169.167162433104, 6214.37856214384, 6236.844078898064, 6263.3736626337, 6331.588446750947, 6170.136180934673, 6219.40915613016, 6240.500759939194, 6247.968760156261, 6249.281332646713, 6220.533459990519, 6311.084892690626, 6320.4311611955145, 6325.873482530324, 6344.841378965562, 6102.004547214544, 6193.504519638508, 6218.968905155445, 6226.937730622636, 6258.186435763321, 6231.470325022424, 6287.842803929939, 6318.462930650854, 6328.272248691367, 6328.873422531616, 4990.451050384455, 5006.824761133343, 5008.173651347487, 5008.273800299009, 5015.27278544609, 4341.261985462479, 4376.474823021258, 4383.101464199832, 4469.687121901436, 4504.909901801946, 5849.356570777211, 5877.9118313225335, 5935.258092738408, 5971.253593300838, 6013.977623803964, 6272.341404152498, 6278.0, 6315.55791094619, 6322.083297921868, 6328.240611126695, 5757.280339957505, 5820.272465941757, 5859.121131830259, 5947.970260148758, 5977.402259773988, 5444.373897001817, 5474.945250547444, 5490.588205884575, 5529.944700553024, 5536.944630553723, 6361.77733779334, 6399.296077431386, 6415.807525774234, 6429.196350456193, 6437.420632143129, 6210.968945155426, 6284.088807123033, 6315.210598675166, 6321.49428045746, 6322.589031712924, 6264.0, 6296.307406185408, 6356.0, 6421.133147025092, 6423.100765892872, 6273.278572964167, 6289.905651415141, 6291.0, 6309.432151106423, 6321.747130114744, 6075.726592303446, 6169.1054797053275, 6314.684265786784, 6315.873682526416, 6316.431521163117, 4844.394450693663, 5960.731767070405, 6105.702364395134, 6132.448079672851, 6132.99804414626, 6167.784127555514, 6192.256929168529, 6221.906671399842, 6224.906626400698, 6234.407731265523, 4753.595944344631, 5417.404085550507, 5589.916151257816, 6107.9921812900375, 6133.969330153321, 5091.92362114576, 6177.722002509988, 6228.283747369111, 6239.126522286792, 6266.091416744455, 6052.455279024909, 6081.361457047124, 6084.209052823105, 6091.269047714302, 6115.541334399849], "value": 5734.339395756909, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.4011475483514, 481.3213369149499, 482.9830955916544, 518.8547206782102, 533.4612041837744, 29739.405211895777, 37222.88331350057, 40289.79855100724, 40392.394114088274, 40425.797871010676, 39383.409248861215, 40694.38958415626, 41701.37447938283, 41723.165536689245, 41862.58137418625, 9653.662121825737, 9867.802643947116, 9871.802563948753, 9872.506374681274, 9892.455914924676, 9684.080012398847, 9780.657676981307, 9817.312788104835, 9817.705468835946, 9827.0, 9744.512774361288, 9755.219582433423, 9794.069563391502, 9800.31397802154, 9802.754931126708, 9588.376755510904, 9646.228301735879, 9680.90319096807, 9712.320137590372, 9742.853857192076, 9718.271129665303, 9734.269929755297, 9806.117449429586, 9819.06718861707, 9825.754356141153, 39648.80175599132, 39846.20307593861, 39890.80054599708, 40007.19985600301, 40145.19709605791, 3254.2272322752797, 3373.9156521086925, 3531.4526248431534, 3814.3324918139215, 3895.0, 29539.70460295391, 29629.259268518243, 29726.554101688493, 30755.84622076875, 32131.875384361436, 3090.443720130376, 3090.6909309069138, 3104.8292343921075, 3166.208447888028, 3209.133533945845, 280705.5964720184, 313915.0, 347570.0, 352933.0, 353140.0, 32725.83637081847, 57813.710931445916, 58092.70953645205, 58142.54643633858, 58147.41852581505, 31430.0, 33706.98879033633, 34573.0, 34871.30257394838, 34881.30237395238, 12024.939875300568, 14603.488877889224, 14651.853481465048, 14838.258087095603, 14853.9602227843, 12443.075877168858, 12604.243745375306, 12655.303958282382, 12676.04929630263, 12699.809502857464, 7428.665710042953, 7607.125180604191, 7644.617769111522, 7662.8084297893, 7681.846363072707, 2748.6564179477564, 3166.509191075387, 3207.935841283208, 3218.5172224166563, 3237.8866739664, 958.4297343080856, 977.2572844638127, 1025.4001409175567, 1054.536004158168, 1077.4074259157433, 28611.28471788222, 29717.405651886842, 29820.105396837695, 30230.941917032796, 30377.24056898595, 971.3928794503436, 1004.9849252261222, 1026.461107918334, 1120.6918097523082, 1214.313912639356, 11437.71405714847, 15431.845681543266, 15492.457763978207, 15749.763753543706, 15793.97339172973, 675523.0, 681277.0, 682450.0, 682872.0, 683532.0, 53082.46917530853, 53127.468725312254, 53222.733886331094, 53531.39405817832, 53573.0, 1324.6754545136503, 1332.666833291677, 1355.2613825465342, 1368.8631136886231, 1373.9106958047696, 20875.686864697345, 28708.85645571842, 29082.854585726935, 29220.56169157507, 29441.0, 44550.0, 47583.76208118937, 48689.5131048685, 48818.0236395263, 48988.510114898396, 497053.0, 498746.0, 600470.0, 600579.0, 602349.0, 25753.098641547454, 25785.484290313714, 25991.350216243987, 26260.60609090827, 26268.737312627392, 45106.03142372263, 45228.0, 45978.54021459743, 46227.0, 46281.305780414, 38481.615183848924, 38860.6113938857, 39117.0, 39894.0, 40541.797291013354, 32034.839825800722, 38216.80891595524, 38477.038074048374, 38966.025849353995, 39587.80206098951, 23953.401164971016, 32891.01326960195, 33973.0, 37758.43362349512, 38175.854724358316, 32430.35139297248, 34348.656513434544, 34349.0, 34360.14099647529, 34698.0, 20457.38627841167, 22834.086636534354, 24943.251702448957, 25093.87453062723, 25241.747582523938], "value": 18104.803396790692, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.3112913287587, 374.28698329681947, 381.20138310240037, 381.26986820239244, 398.1499498570551, 17459.738103928452, 20003.699944500826, 20211.59576808463, 20369.287074952397, 20615.38153855387, 20232.898835505803, 20381.59236815263, 20479.897600512013, 20501.48746281344, 20888.477788055305, 4980.800767969277, 5882.3529411764675, 6067.544934129935, 6106.816795496142, 6124.295705993801, 6034.336223015464, 6060.424259695344, 6104.816855494342, 6106.206193194878, 6160.630362178261, 5746.655200687972, 5830.62100963436, 5994.790182343619, 6061.757529698807, 6062.939370606304, 4687.882802929937, 5526.47498487643, 5748.540116790647, 5940.881182376372, 6003.459688628044, 5151.845444636667, 5204.0, 5205.011047900886, 5214.895702085937, 5241.68549887008, 20308.08613612391, 22335.776642233533, 23631.0, 23920.40198995039, 24110.758892411202, 2326.8720220387872, 2439.195065628356, 2443.596806526921, 2483.1805504183576, 2484.080890070685, 14590.197539135343, 14985.400583976629, 15210.08739475635, 15383.0, 16118.194090295437, 1767.1076106566102, 1811.4203454894307, 1848.6949653307188, 1879.718042293667, 1909.255390397746, 106252.0, 113816.0, 114642.0, 121757.39121304425, 123337.76662233353, 11360.943195284137, 11450.19848610606, 11553.13351498641, 11625.418729063513, 11754.529818807323, 14274.2149181796, 14368.281585920662, 14389.712205756035, 14405.78391324131, 14450.566483005527, 7046.788596342118, 8325.750227493185, 8486.872696909551, 8521.233089021895, 8641.481511109354, 8359.456635318686, 8516.40385173032, 8524.31805455562, 8638.956805215934, 8698.478091314415, 3586.497890295361, 4490.595846373842, 4518.932216016762, 4557.521460246693, 4597.011642496813, 1582.6913751818515, 1907.6089401672623, 1929.778075521305, 1968.5767559974674, 1972.5660354721938, 730.9305615966475, 847.5550336073611, 870.9303255739526, 871.4727589808075, 971.8930917599058, 19553.315633952745, 20347.57566970298, 21368.893155534122, 21387.57224855494, 21520.139194432362, 916.6150216908915, 920.7652048727532, 934.7849994501166, 960.8318544254728, 988.4267125067587, 10495.737606559896, 11165.83251251232, 11200.663980080612, 11223.887761122447, 11288.717782055513, 556895.0, 576748.0, 589174.0, 593383.0, 599494.0, 101285.4807177893, 122143.0, 123611.0, 140278.03466185438, 148811.0, 817.8977627796526, 947.668316089377, 966.0773960867355, 969.0, 1025.564135242519, 19529.902350488155, 19833.008349582753, 19951.401457956286, 19989.700154497405, 21032.0, 58880.705596471744, 59042.81914361603, 59202.40797591969, 60484.395156049635, 60596.182114536634, 87386.68919966332, 87628.0, 87759.0, 88834.55582722045, 89026.66460003235, 8058.0, 8066.556339401389, 8172.713955011546, 8300.003999520097, 8367.790805229917, 11945.343006134746, 12779.0, 12801.551945681857, 13085.803712944504, 13293.003024773374, 9251.36762171198, 10899.346039237671, 11278.492467838803, 11377.975982161644, 11566.248193867372, 10890.782184356427, 10955.726106847393, 11365.659030229106, 11507.309561426342, 11530.250533715282, 11195.44022798873, 11371.715707107389, 11717.941410292893, 11764.352960586908, 11820.940895295813, 6922.930770692228, 7930.170581013542, 7960.243776841191, 8353.164683531599, 8372.33021358302, 8279.37904657141, 9297.6280948764, 9326.834145731784, 10518.211134164816, 11377.317360958037], "value": 9631.503126001737, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1388.9305534723262, 1511.0706915247124, 1695.7541156532302, 1804.2873065139263, 1866.4027511196423, 8036.638351274192, 8278.793030174249, 8457.53483558404, 9087.273018158548, 9094.86357704635, 8504.19210175034, 8807.95596022019, 8818.294536437086, 8951.418157819737, 8952.641894324235, 2387.069043073203, 2416.359664688859, 2421.32202983165, 2423.1882319423016, 2426.7209270933804, 2379.2624286471164, 2398.136670798511, 2429.8177636677233, 2431.513697260546, 2436.3300092474624, 2402.3633737059695, 2402.69053365916, 2415.685960825099, 2424.7090349158125, 2432.2703189043305, 2345.7419683834764, 2386.832921695482, 2390.22317746733, 2410.481746424527, 2412.4330782266243, 2371.30046636241, 2373.8100951923807, 2381.618940969454, 2389.0443822470975, 2391.270662447953, 8894.510801905893, 8920.464772113693, 8985.505797181153, 8985.640574377017, 8989.685361012333, 5231.659942103751, 5292.550133238679, 5398.541124004464, 5403.729813509348, 5405.567554595662, 3382.357352103117, 3513.5608048993877, 3565.3938830398893, 3570.892873213808, 3583.2475180212186, 936.9063093690645, 1012.6000229909218, 1043.3844032021068, 1043.8016776812458, 1076.010070734918, 9475.336726429152, 11770.882291177064, 11808.114391420591, 11835.644930652094, 11969.281843089355, 4196.979015104905, 4513.210188217049, 4659.277811939155, 4869.634777391639, 4878.317035615017, 10005.0, 10104.494775261355, 10108.29241953071, 10133.0, 10137.087662110445, 5279.841604751864, 5308.734563271821, 5324.7870085196155, 5329.520343169133, 5346.331708536433, 4037.7779222143063, 4409.14021765759, 4555.931661025087, 4762.857114286577, 4890.364252647133, 3402.7750009996876, 3419.692227699519, 3940.9802950985063, 3953.7627742334976, 4037.1118353962083, 1302.1275745250705, 1310.050213595155, 1314.3625341709264, 1322.2991814338416, 1331.6471135149193, 799.94400391972, 865.476386785998, 905.2938707807921, 909.3816204980677, 952.9047095290415, 5915.733791979371, 6032.763283526867, 6094.695265236721, 6108.602940808833, 6325.209348831396, 938.6526985015588, 944.7307517357658, 965.8358079126565, 977.8142152990908, 981.3081777346953, 3868.0, 3976.8608098716404, 4075.0, 4111.424400583921, 4147.6474499667265, 10632.627858024933, 10899.692036955616, 10980.450977451095, 11011.28426652265, 11040.392778397105, 10861.402622855661, 10915.072218861327, 10929.234953553334, 10929.726756831144, 10936.0, 7805.843883122306, 8192.877106843283, 8308.584570771438, 8437.620307086196, 8471.152884711479, 5905.257948904998, 5984.790532331347, 6023.789167379121, 6113.908291375722, 6225.0, 9975.351602145838, 10124.493775311057, 10248.795024099625, 10257.384556926609, 10263.948680256552, 9961.750956225862, 10192.439415832201, 10212.183025357805, 10299.12457441096, 10316.43259620698, 6478.935210647834, 7606.505577137468, 7869.252421019994, 8237.711680091168, 8353.83292334162, 8366.0, 8398.958005209935, 8438.282745966417, 8484.19400156984, 8624.223819856243, 6352.396522330371, 7224.674889629874, 7510.586917719578, 7514.0, 7535.660895259836, 7366.263373662591, 7385.113786345458, 7394.223606521237, 7401.370883474965, 7523.3229009389415, 6859.039734437282, 6945.479089068239, 7017.087778588751, 7033.226345101933, 7048.154221493453, 4989.201727723692, 5040.319556859924, 5047.41954675217, 5057.241413787961, 5103.87240318995, 4417.668674849335, 4928.96491736725, 4939.382577177853, 4996.7001979881325, 5195.428502864757], "value": 4621.2287885468995, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [268.3626387330091, 302.6942787784337, 309.4028524946852, 310.02960732906007, 315.5125331363044, 4635.420572428447, 4968.602511799057, 5254.57963362931, 5601.495865372116, 5656.688882111493, 4355.825766969318, 5563.777448902039, 5568.303962004749, 5571.192177134313, 5583.520367102721, 3158.242021914747, 3856.768593884376, 3934.3705007198855, 4075.9388609170887, 4120.196561670476, 4064.979675101635, 4209.557996410379, 4241.300185469394, 4244.236037513247, 4258.0, 3674.6325367463173, 3805.8772662064757, 4199.5511548515715, 4201.579842015804, 4217.650351887397, 3905.5899130591165, 4173.061061261223, 4177.597881218312, 4234.74591524508, 4240.872773816775, 3059.3728285701377, 3121.81269123851, 3281.343731253735, 3290.7860989035635, 3580.2968758587363, 4026.154507553388, 4182.247195504808, 4522.756242033434, 5324.429293358468, 5401.459854014606, 4043.858464953742, 4582.564656357641, 4690.50749671283, 4758.571728544413, 4779.856604301876, 4269.893252668677, 4531.025829446652, 5176.818811341585, 5416.241726158341, 5600.723576707631, 3261.2988207535254, 3869.9806500967316, 3923.0780766519847, 3931.941020884689, 3970.114195757021, 5368.973155134238, 6177.0, 6230.345813689588, 6245.7501699931945, 6249.375062493714, 3415.3852306585054, 3545.7340699447645, 3965.2466031453932, 3991.92016159681, 3992.6007399260425, 4019.8342480680276, 4055.7769322687536, 4077.878583389532, 4080.7755573443746, 4097.815598298083, 3838.5777564467885, 4486.955130448654, 4774.737389443544, 4788.808447662124, 4803.495632958489, 4767.308740232646, 5199.922001169985, 5801.73732244425, 5982.042873140276, 6019.839584218321, 1370.5888233529902, 1385.2242744063358, 1392.554382597559, 1393.2754967417088, 1393.6097892590092, 711.5766119159092, 779.3492433817826, 830.7175560309523, 846.8144597563461, 846.9667006252362, 5189.299444575009, 5398.24424580559, 5595.832125036255, 5607.495325420732, 5624.29696287964, 5246.658967167122, 5663.745131469093, 5819.243498345188, 5870.823875283749, 6060.818175454743, 4781.545753153445, 5215.58275337972, 5454.3454785426, 5501.587380946445, 5564.499195072382, 3110.2379916920045, 3168.30297334586, 3187.10760986924, 3192.7286180674437, 3193.6526652910093, 5380.381256155592, 5835.737391817378, 6046.516278697693, 6300.180976473121, 6334.5249106317215, 5316.468353164652, 5671.2060311556415, 6181.381861813783, 6215.316315205324, 6326.715297811517, 5278.785879247795, 5566.888662226733, 5713.685747283939, 6311.116443697886, 6363.840903977252, 5214.843554693365, 6032.638041717511, 6053.606515576474, 6077.696115194134, 6088.5737998341465, 5354.0, 5801.897639448492, 5811.651300921958, 5976.820695379146, 5991.7902873399225, 5791.362950075404, 5929.762809487745, 6318.62088274705, 6358.904616430665, 6365.267994180728, 3913.158670885773, 3923.4114882767813, 3931.5478719947573, 3935.783531905658, 3947.6644485219076, 6029.547783916136, 6047.123167140828, 6050.878982420239, 6066.817995460143, 6089.330173680803, 5265.341832270966, 5540.75066622011, 5838.591298609056, 5915.881682366243, 5924.911126333194, 5395.298611180521, 5837.6281573829265, 5855.443732845373, 5876.676782776988, 5944.73248703818, 4594.747288899142, 5729.759977616451, 5768.942310577008, 5771.278590176228, 5806.622569532967, 5002.149634562206, 5258.763355649082, 5557.583181261502, 5773.191753154478, 5806.390329015392, 5762.855928601818, 5778.855528611818, 5801.622894511843, 5813.970930145322, 5895.557833162616], "value": 4189.257164443109, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.5435651478817, 624.1542709628454, 714.6176795414455, 716.1978583985937, 726.0633782420678, 14986.550403487885, 15807.683846323067, 15843.84156158438, 15878.60303492412, 15899.761503577442, 11772.823407648892, 12041.939790301058, 14289.499867504639, 14483.493077742281, 14483.78274325886, 662.9801105966828, 689.5380095336137, 825.0923983618032, 833.2792134803396, 849.1975083546051, 791.6556298010383, 843.7173546861809, 865.277493293101, 865.7402779166256, 869.4783130121939, 904.7195369435497, 928.3269629518612, 929.061647735785, 934.5700977550301, 936.6019441737268, 917.6100157433098, 919.7792529792869, 920.7375897869075, 921.3642586615248, 921.4931787516906, 673.5756473421762, 680.5406350713249, 681.0397339750976, 686.1594546680327, 687.9886566746924, 15014.024088434326, 15169.393224271016, 15252.694946101126, 15307.698845598026, 15310.387584496606, 11776.528938842435, 14266.785998210034, 14520.273986300643, 14692.485762998243, 14838.851611483855, 11703.180777345504, 11726.003289720298, 11777.411129443493, 11787.646370608896, 11801.88198118025, 3273.2635157089703, 3767.9058023549355, 3816.866409675648, 3835.194609132058, 3970.801459927021, 104044.0, 104499.43250851243, 108402.0, 108416.91583084226, 110374.0, 10818.188635852342, 10823.188260880466, 10934.45327733626, 10941.179411544166, 10972.610786431798, 18636.72044919327, 20871.58256834855, 21367.03848326829, 21924.903754812196, 22033.118675253132, 7895.684172633145, 8075.313598344206, 8087.272145506932, 8098.959505202436, 8405.915940840514, 4444.533324000998, 4468.3074123510905, 4494.056248187917, 4513.616342610915, 4526.207913615104, 3467.4798780183173, 3587.2287458196615, 3587.3542762303036, 3600.207954250061, 3612.8012959287494, 620.2928661326092, 620.9006558950637, 628.5066223014911, 643.7811144210991, 648.2318452633644, 584.5031723035471, 587.7296443635976, 593.5311104227612, 632.0298342044939, 638.1353266324064, 8364.539950302791, 8484.575771211415, 9376.906230937604, 9553.61785528585, 9568.0, 568.7582777319706, 586.1237450012259, 595.8093410108723, 647.5758378262245, 649.8375406148463, 3910.980445097813, 4361.327308557415, 4475.619572336323, 4669.859904202879, 4836.782344794493, 89743.0, 141227.88158177637, 147285.0, 155431.2228438873, 172234.13882930754, 140486.2975685115, 143488.1721290157, 146797.3300667492, 148383.0, 154512.0, 108317.458412709, 116154.86915915804, 125932.0, 127996.44007119806, 129529.0, 7773.3004029637605, 7889.526628402315, 8367.66529338844, 8370.665173392996, 8383.28742056932, 65518.34481655122, 66047.0, 67013.66493167503, 68755.65622171857, 68895.31104688889, 59097.70451147717, 70401.0, 71509.99566164865, 84879.5756021216, 99142.0, 12558.372081396077, 12846.100772945803, 13310.866891330963, 13311.857266757526, 13822.37799299014, 14822.703545928805, 14879.330430130454, 14904.701905962036, 14920.253987300808, 15227.162506062274, 14005.859941400455, 14040.438382464587, 14301.785473218119, 14329.426822927384, 14507.709845803236, 12024.677285498763, 13292.20246785196, 13337.733245335234, 13596.796048059485, 13711.451541938211, 13284.601461956157, 13437.260950647807, 13482.595522134352, 13798.517051903134, 14074.859251407355, 10919.508622112184, 11043.558257669603, 11147.721306967067, 11153.378955945509, 11454.739978602514, 10790.73023174427, 11315.038221750914, 11436.313821170756, 11437.656870293904, 11510.48202830858], "value": 7748.811393481589, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1559.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 115.0, 113.0, 117.0, 112.0, 155.0, 166.0, 180.0, 116.0, 117.0], "value": 129.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 114.0, 110.0, 148.0, 109.0, 107.0, 111.0, 113.0, 138.0, 114.0], "value": 123.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 195.0, 203.0, 266.0, 281.0, 231.0, 196.0, 201.0, 213.0, 198.0], "value": 217.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 60.0, 82.0, 65.0, 72.0, 83.0, 60.0, 80.0, 60.0], "value": 70.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 86.0, 71.0, 69.0, 71.0, 87.0, 71.0, 70.0, 84.0], "value": 76.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 104.0, 120.0, 133.0, 124.0, 105.0, 93.0, 105.0, 123.0, 78.0], "value": 107.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 106.0, 93.0, 154.0, 114.0, 111.0, 155.0, 107.0], "value": 113.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 90.0, 94.0, 128.0, 149.0, 91.0, 92.0, 91.0, 92.0, 105.0], "value": 102.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 60.0, 59.0, 58.0, 61.0, 60.0, 59.0, 59.0, 58.0], "value": 58.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 71.0, 75.0, 83.0, 76.0, 70.0, 71.0, 72.0, 72.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 109.0, 110.0, 111.0, 94.0, 90.0, 87.0, 90.0, 96.0, 88.0], "value": 96.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 139.0, 139.0, 138.0, 139.0, 139.0, 138.0, 140.0, 188.0, 157.0], "value": 145.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 176.0, 174.0, 174.0, 175.0, 174.0, 174.0, 176.0, 173.0, 172.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 68.0, 71.0, 71.0, 71.0, 75.0, 69.0, 66.0, 68.0], "value": 69.8, "unit": "score"}]}]} 18:53:54 INFO - Return code: 0 18:53:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:53:54 ERROR - # TBPL SUCCESS # 18:53:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:53:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:53:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:53:54 INFO - 2016-09-21 18:53:54.594 screenresolution[1668:10392] starting screenresolution argv=screenresolution get 18:53:54 INFO - 2016-09-21 18:53:54.596 screenresolution[1668:10392] Display 0: 1600x1200x32@60 18:53:54 INFO - 2016-09-21 18:53:54.602 screenresolution[1669:10395] starting screenresolution argv=screenresolution list 18:53:54 INFO - Available Modes on Display 0 18:53:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:53:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:53:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:53:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:53:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:53:54 INFO - Intel Iris: 18:53:54 INFO - Chipset Model: Intel Iris 18:53:54 INFO - Type: GPU 18:53:54 INFO - Bus: Built-In 18:53:54 INFO - VRAM (Dynamic, Max): 1536 MB 18:53:54 INFO - Vendor: Intel (0x8086) 18:53:54 INFO - Device ID: 0x0a2e 18:53:54 INFO - Revision ID: 0x0009 18:53:54 INFO - Displays: 18:53:54 INFO - Display: 18:53:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:53:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:53:54 INFO - Display Serial Number: 1600x1200 60 18:53:54 INFO - Main Display: Yes 18:53:54 INFO - Mirror: Off 18:53:54 INFO - Online: Yes 18:53:54 INFO - Rotation: Supported 18:53:54 INFO - Return code: 0 18:53:54 INFO - Running post-action listener: _resource_record_post_action 18:53:54 INFO - [mozharness: 2016-09-22 01:53:54.847487Z] Finished run-tests step (success) 18:53:54 INFO - Running post-run listener: _resource_record_post_run 18:53:54 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 37385216; Write bytes: 706275328; Read time: 242; Write time: 1957 18:53:54 INFO - TinderboxPrint: CPU usage
54.4% 18:53:54 INFO - TinderboxPrint: I/O read bytes / time
37,385,216 / 242 18:53:54 INFO - TinderboxPrint: I/O write bytes / time
706,275,328 / 1,957 18:53:54 INFO - TinderboxPrint: CPU idle
2,205.2 (45.6%) 18:53:54 INFO - TinderboxPrint: CPU system
980.5 (20.3%) 18:53:54 INFO - TinderboxPrint: CPU user
1,652.0 (34.1%) 18:53:54 INFO - TinderboxPrint: Swap in / out
442,273,792 / 0 18:53:54 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 395774464; Write bytes: 390948864; Read time: 29732; Write time: 764 18:53:54 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 35279872; Write bytes: 296509440; Read time: 221; Write time: 1146 18:53:55 INFO - Running post-run listener: _upload_blobber_files 18:53:55 INFO - Blob upload gear active. 18:53:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:53:55 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 18:53:55 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'] 18:53:55 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 18:53:55 INFO - (blobuploader) - INFO - Open directory for files ... 18:53:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:53:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:53:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:53:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:53:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:53:56 INFO - (blobuploader) - INFO - Done attempting. 18:53:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:53:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:53:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:53:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:53:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:53:58 INFO - (blobuploader) - INFO - Done attempting. 18:53:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:53:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:53:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:54:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:54:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:54:01 INFO - (blobuploader) - INFO - Done attempting. 18:54:01 INFO - (blobuploader) - INFO - Iteration through files over. 18:54:01 INFO - Return code: 0 18:54:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:54:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:54:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5a513f3b24fffe2d74c2ca78e0f2360b7968af5c6acf1686a2a5620194e585730e98df4e2ebffdd072c93f972fd11ec762b259d4059dd1b221700f91240cf22a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5167f46e1b03c85e216f4f067a9bce297eb1db6c0928f5079b3b13e0c1ceea217312cd4a7e53c80ff4cf4c67c4215cd15cfdf55c9f7922b6ffdd97087d13f5fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b42218a865d5330d9970ac628e43add0f2199bd66998d467cc5aab6991a280682b694268b8e4d1e7f3f76679614a1eafd08729a3b295e16b7efd4413d1aa635b"} 18:54:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:54:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:54:01 INFO - Contents: 18:54:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5a513f3b24fffe2d74c2ca78e0f2360b7968af5c6acf1686a2a5620194e585730e98df4e2ebffdd072c93f972fd11ec762b259d4059dd1b221700f91240cf22a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5167f46e1b03c85e216f4f067a9bce297eb1db6c0928f5079b3b13e0c1ceea217312cd4a7e53c80ff4cf4c67c4215cd15cfdf55c9f7922b6ffdd97087d13f5fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b42218a865d5330d9970ac628e43add0f2199bd66998d467cc5aab6991a280682b694268b8e4d1e7f3f76679614a1eafd08729a3b295e16b7efd4413d1aa635b"} 18:54:01 INFO - Running post-run listener: copy_logs_to_upload_dir 18:54:01 INFO - Copying logs to upload dir... 18:54:01 INFO - mkdir: /builds/slave/test/build/upload/logs 18:54:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.057649 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-21 18:54:01.141991) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 18:54:01.150560) ========= 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.iKX0SOlHPt/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.WstQzb8QvR/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5a513f3b24fffe2d74c2ca78e0f2360b7968af5c6acf1686a2a5620194e585730e98df4e2ebffdd072c93f972fd11ec762b259d4059dd1b221700f91240cf22a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5167f46e1b03c85e216f4f067a9bce297eb1db6c0928f5079b3b13e0c1ceea217312cd4a7e53c80ff4cf4c67c4215cd15cfdf55c9f7922b6ffdd97087d13f5fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b42218a865d5330d9970ac628e43add0f2199bd66998d467cc5aab6991a280682b694268b8e4d1e7f3f76679614a1eafd08729a3b295e16b7efd4413d1aa635b"} build_url:https://queue.taskcluster.net/v1/task/FGweUBgXQ7utetjdxf5ypA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011095 build_url: 'https://queue.taskcluster.net/v1/task/FGweUBgXQ7utetjdxf5ypA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5a513f3b24fffe2d74c2ca78e0f2360b7968af5c6acf1686a2a5620194e585730e98df4e2ebffdd072c93f972fd11ec762b259d4059dd1b221700f91240cf22a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5167f46e1b03c85e216f4f067a9bce297eb1db6c0928f5079b3b13e0c1ceea217312cd4a7e53c80ff4cf4c67c4215cd15cfdf55c9f7922b6ffdd97087d13f5fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b42218a865d5330d9970ac628e43add0f2199bd66998d467cc5aab6991a280682b694268b8e4d1e7f3f76679614a1eafd08729a3b295e16b7efd4413d1aa635b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 18:54:01.193999) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 18:54:01.194736) ========= 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.iKX0SOlHPt/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.WstQzb8QvR/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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.004797 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 18:54:01.247273) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 18:54:01.247664) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 18:54:01.248055) ========= ========= Total master_lag: 0.21 =========