builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0106 starttime: 1471049614.37 results: success (0) buildid: 20160812161717 builduid: 111a11792bcf4ec6b577a8aa9bd03f56 revision: 316a84b6888a45ff70b5badf10a5899bdc09875e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 17:53:34.371215) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 17:53:34.371763) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 17:53:34.372096) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 17:53:34.401324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 17:53:34.401751) ========= 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.5XDt3AO6vk/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.jDMGWFd6Gs/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-12 17:53:34-- 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% 154M=0s 2016-08-12 17:53:34 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157063 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 17:53:34.581547) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 17:53:34.581963) ========= 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.5XDt3AO6vk/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.jDMGWFd6Gs/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.019627 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 17:53:34.630968) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-12 17:53:34.631367) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 316a84b6888a45ff70b5badf10a5899bdc09875e --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 316a84b6888a45ff70b5badf10a5899bdc09875e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5XDt3AO6vk/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.jDMGWFd6Gs/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-12 17:53:34,707 truncating revision to first 12 chars 2016-08-12 17:53:34,707 Setting DEBUG logging. 2016-08-12 17:53:34,707 attempt 1/10 2016-08-12 17:53:34,708 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/316a84b6888a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-12 17:53:35,835 unpacking tar archive at: autoland-316a84b6888a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.374496 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-12 17:53:36.121770) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 17:53:36.122164) ========= script_repo_revision: 316a84b6888a45ff70b5badf10a5899bdc09875e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 17:53:36.122657) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 17:53:36.123020) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 17:53:36.142284) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-08-12 17:53:36.142698) ========= /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.5XDt3AO6vk/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.jDMGWFd6Gs/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 17:53:36 INFO - MultiFileLogger online at 20160812 17:53:36 in /builds/slave/test 17:53:36 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 17:53:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:53:36 INFO - {'append_to_log': False, 17:53:36 INFO - 'base_work_dir': '/builds/slave/test', 17:53:36 INFO - 'blob_upload_branch': 'Autoland', 17:53:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:53:36 INFO - 'branch': 'Autoland', 17:53:36 INFO - 'buildbot_json_path': 'buildprops.json', 17:53:36 INFO - 'config_files': ('talos/mac_config.py',), 17:53:36 INFO - 'default_actions': ('clobber', 17:53:36 INFO - 'read-buildbot-config', 17:53:36 INFO - 'download-and-extract', 17:53:36 INFO - 'populate-webroot', 17:53:36 INFO - 'create-virtualenv', 17:53:36 INFO - 'install', 17:53:36 INFO - 'run-tests'), 17:53:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:53:36 INFO - 'download_minidump_stackwalk': True, 17:53:36 INFO - 'download_symbols': 'ondemand', 17:53:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:53:36 INFO - 'tooltool.py': '/tools/tooltool.py', 17:53:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:53:36 INFO - '/tools/misc-python/virtualenv.py')}, 17:53:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:53:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:53:36 INFO - 'installer_path': 'installer.exe', 17:53:36 INFO - 'log_level': 'info', 17:53:36 INFO - 'log_name': 'talos', 17:53:36 INFO - 'log_to_console': True, 17:53:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:53:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:53:36 INFO - 'opt_config_files': (), 17:53:36 INFO - 'pip_index': False, 17:53:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:53:36 INFO - 'cmd': ('bash', 17:53:36 INFO - '-c', 17:53:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:53:36 INFO - 'enabled': True, 17:53:36 INFO - 'halt_on_failure': False, 17:53:36 INFO - 'name': 'check_screen_resolution'},), 17:53:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:53:36 INFO - 'cmd': ('bash', 17:53:36 INFO - '-c', 17:53:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:53:36 INFO - 'enabled': True, 17:53:36 INFO - 'halt_on_failure': False, 17:53:36 INFO - 'name': 'check_screen_resolution'},), 17:53:36 INFO - 'run_cmd_checks_enabled': True, 17:53:36 INFO - 'sps_profile': False, 17:53:36 INFO - 'sps_profile_interval': 0, 17:53:36 INFO - 'suite': 'dromaeojs-e10s', 17:53:36 INFO - 'system_bits': '32', 17:53:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:53:36 INFO - 'title': 't-yosemite-r7-0106', 17:53:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:53:36 INFO - 'use_talos_json': True, 17:53:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:53:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:53:36 INFO - 'work_dir': 'build'} 17:53:36 INFO - [mozharness: 2016-08-13 00:53:36.338155Z] Running clobber step. 17:53:36 INFO - Running pre-action listener: _resource_record_pre_action 17:53:36 INFO - Running main action method: clobber 17:53:36 INFO - rmtree: /builds/slave/test/build 17:53:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:53:38 INFO - Running post-action listener: _resource_record_post_action 17:53:38 INFO - [mozharness: 2016-08-13 00:53:38.448198Z] Finished clobber step (success) 17:53:38 INFO - [mozharness: 2016-08-13 00:53:38.448364Z] Running read-buildbot-config step. 17:53:38 INFO - Running pre-action listener: _resource_record_pre_action 17:53:38 INFO - Running main action method: read_buildbot_config 17:53:38 INFO - Using buildbot properties: 17:53:38 INFO - { 17:53:38 INFO - "project": "", 17:53:38 INFO - "product": "firefox", 17:53:38 INFO - "script_repo_revision": "production", 17:53:38 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 17:53:38 INFO - "repository": "", 17:53:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 17:53:38 INFO - "buildid": "20160812161717", 17:53:38 INFO - "pgo_build": "False", 17:53:38 INFO - "basedir": "/builds/slave/test", 17:53:38 INFO - "buildnumber": 114, 17:53:38 INFO - "slavename": "t-yosemite-r7-0106", 17:53:38 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 17:53:38 INFO - "platform": "yosemite_r7", 17:53:38 INFO - "scheduler": "tests-autoland-macosx64-talos", 17:53:38 INFO - "branch": "autoland", 17:53:38 INFO - "repo_path": "integration/autoland", 17:53:38 INFO - "revision": "316a84b6888a45ff70b5badf10a5899bdc09875e", 17:53:38 INFO - "stage_platform": "macosx64", 17:53:38 INFO - "builduid": "111a11792bcf4ec6b577a8aa9bd03f56", 17:53:38 INFO - "slavebuilddir": "test" 17:53:38 INFO - } 17:53:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/RHDugItNSY-1K8F-qeW2YQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 17:53:38 INFO - Running post-action listener: _resource_record_post_action 17:53:38 INFO - [mozharness: 2016-08-13 00:53:38.451763Z] Finished read-buildbot-config step (success) 17:53:38 INFO - [mozharness: 2016-08-13 00:53:38.451853Z] Running download-and-extract step. 17:53:38 INFO - Running pre-action listener: _resource_record_pre_action 17:53:38 INFO - Running main action method: download_and_extract 17:53:38 INFO - mkdir: /builds/slave/test/build/tests 17:53: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')]} 17:53:38 INFO - trying https://queue.taskcluster.net/v1/task/RHDugItNSY-1K8F-qeW2YQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 17:53:38 INFO - Downloading https://queue.taskcluster.net/v1/task/RHDugItNSY-1K8F-qeW2YQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 17:53:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RHDugItNSY-1K8F-qeW2YQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 17:53:39 INFO - Downloaded 1199 bytes. 17:53:39 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 17:53:39 INFO - Using the following test package requirements: 17:53:39 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:53:39 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:53:39 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 17:53:39 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:53:39 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 17:53:39 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:53:39 INFO - u'jsshell-mac.zip'], 17:53:39 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:53:39 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 17:53:39 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:53:39 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:53:39 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 17:53:39 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:53:39 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 17:53:39 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:53:39 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 17:53:39 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:53:39 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 17:53:39 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:53:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:53:39 INFO - trying https://queue.taskcluster.net/v1/task/RHDugItNSY-1K8F-qeW2YQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:53:39 INFO - Downloading https://queue.taskcluster.net/v1/task/RHDugItNSY-1K8F-qeW2YQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:53:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RHDugItNSY-1K8F-qeW2YQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:53:40 INFO - Downloaded 16328839 bytes. 17:53:40 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 17:53:47 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:53:47 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')]} 17:53:47 INFO - trying https://queue.taskcluster.net/v1/task/RHDugItNSY-1K8F-qeW2YQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:53:47 INFO - Downloading https://queue.taskcluster.net/v1/task/RHDugItNSY-1K8F-qeW2YQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:53:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RHDugItNSY-1K8F-qeW2YQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:53:48 INFO - Downloaded 16328839 bytes. 17:53:48 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 17:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:53:55 INFO - trying https://queue.taskcluster.net/v1/task/RHDugItNSY-1K8F-qeW2YQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 17:53:55 INFO - Downloading https://queue.taskcluster.net/v1/task/RHDugItNSY-1K8F-qeW2YQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 17:53:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RHDugItNSY-1K8F-qeW2YQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:53:56 INFO - Downloaded 14413719 bytes. 17:53:56 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 17:53:56 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')]} 17:53:56 INFO - trying https://queue.taskcluster.net/v1/task/RHDugItNSY-1K8F-qeW2YQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:53:56 INFO - Downloading https://queue.taskcluster.net/v1/task/RHDugItNSY-1K8F-qeW2YQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 17:53:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RHDugItNSY-1K8F-qeW2YQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 17:53:59 INFO - Downloaded 110996791 bytes. 17:53:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RHDugItNSY-1K8F-qeW2YQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:53:59 INFO - mkdir: /builds/slave/test/properties 17:53:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:53:59 INFO - Writing to file /builds/slave/test/properties/build_url 17:53:59 INFO - Contents: 17:53:59 INFO - build_url:https://queue.taskcluster.net/v1/task/RHDugItNSY-1K8F-qeW2YQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:54:00 INFO - Running post-action listener: _resource_record_post_action 17:54:00 INFO - Running post-action listener: set_extra_try_arguments 17:54:00 INFO - [mozharness: 2016-08-13 00:54:00.228018Z] Finished download-and-extract step (success) 17:54:00 INFO - [mozharness: 2016-08-13 00:54:00.228115Z] Running populate-webroot step. 17:54:00 INFO - Running pre-action listener: _resource_record_pre_action 17:54:00 INFO - Running main action method: populate_webroot 17:54:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:54:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:54:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:54:00 INFO - '--tppagecycles', 17:54:00 INFO - '7'], 17:54:00 INFO - 'tests': ['tsvgm']}}, 17:54:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:54:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:54:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:54:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:54:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:54:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:54:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:54:00 INFO - 'talos_options': ['--disable-e10s'], 17:54:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:54:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:54:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:54:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:54:00 INFO - 'talos_options': ['--disable-e10s'], 17:54:00 INFO - 'tests': ['damp', 'tps']}, 17:54:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:54:00 INFO - 'tests': ['damp', 'tps']}, 17:54:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:54:00 INFO - 'tests': ['dromaeo_dom']}, 17:54:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:54:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:54:00 INFO - 'tests': ['basic_compositor_video']}, 17:54:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:54:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:54:00 INFO - 'tests': ['a11yr', 17:54:00 INFO - 'ts_paint', 17:54:00 INFO - 'tpaint', 17:54:00 INFO - 'sessionrestore', 17:54:00 INFO - 'sessionrestore_no_auto_restore', 17:54:00 INFO - 'tabpaint']}, 17:54:00 INFO - 'other-e10s': {'tests': ['a11yr', 17:54:00 INFO - 'ts_paint', 17:54:00 INFO - 'tpaint', 17:54:00 INFO - 'sessionrestore', 17:54:00 INFO - 'sessionrestore_no_auto_restore', 17:54:00 INFO - 'tabpaint']}, 17:54:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:54:00 INFO - 'ts_paint', 17:54:00 INFO - 'tpaint', 17:54:00 INFO - 'sessionrestore', 17:54:00 INFO - 'sessionrestore_no_auto_restore', 17:54:00 INFO - 'tabpaint']}, 17:54:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:54:00 INFO - 'ts_paint', 17:54:00 INFO - 'tpaint', 17:54:00 INFO - 'sessionrestore', 17:54:00 INFO - 'sessionrestore_no_auto_restore', 17:54:00 INFO - 'tabpaint']}, 17:54:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:54:00 INFO - 'tests': ['a11yr', 17:54:00 INFO - 'ts_paint', 17:54:00 INFO - 'tpaint', 17:54:00 INFO - 'sessionrestore', 17:54:00 INFO - 'sessionrestore_no_auto_restore', 17:54:00 INFO - 'tabpaint']}, 17:54:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:54:00 INFO - 'tests': ['a11yr', 17:54:00 INFO - 'ts_paint', 17:54:00 INFO - 'tpaint', 17:54:00 INFO - 'sessionrestore', 17:54:00 INFO - 'sessionrestore_no_auto_restore', 17:54:00 INFO - 'tabpaint']}, 17:54:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:54:00 INFO - 'tests': ['tsvgx', 17:54:00 INFO - 'tsvgr_opacity', 17:54:00 INFO - 'tart', 17:54:00 INFO - 'tscrollx', 17:54:00 INFO - 'cart']}, 17:54:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:54:00 INFO - 'tsvgr_opacity', 17:54:00 INFO - 'tart', 17:54:00 INFO - 'tscrollx', 17:54:00 INFO - 'cart']}, 17:54:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:54:00 INFO - 'talos_options': ['--disable-e10s'], 17:54:00 INFO - 'tests': ['tp5o']}, 17:54:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:54:00 INFO - 'tests': ['tp5o']}, 17:54:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:54:00 INFO - 'talos_options': ['--disable-e10s', 17:54:00 INFO - '--xperf_path', 17:54:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:54:00 INFO - 'tests': ['tp5n']}, 17:54:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:54:00 INFO - 'talos_options': ['--xperf_path', 17:54:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:54:00 INFO - 'tests': ['tp5n']}}, 17:54:00 INFO - 'talos.zip': {'path': '', 17:54:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:54:00 INFO - Running post-action listener: _resource_record_post_action 17:54:00 INFO - [mozharness: 2016-08-13 00:54:00.246335Z] Finished populate-webroot step (success) 17:54:00 INFO - [mozharness: 2016-08-13 00:54:00.246465Z] Running create-virtualenv step. 17:54:00 INFO - Running pre-action listener: _resource_record_pre_action 17:54:00 INFO - Running main action method: create_virtualenv 17:54:00 INFO - Creating virtualenv /builds/slave/test/build/venv 17:54:00 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 17:54:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:54:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:54:00 INFO - Using real prefix '/tools/python27' 17:54:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:54:01 INFO - Installing distribute.............................................................................................................................................................................................done. 17:54:03 INFO - Installing pip.................done. 17:54:03 INFO - Return code: 0 17:54:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d4dba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d570618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe7add71d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43fd30>, '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 0x10d1a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d437b20>, '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.5XDt3AO6vk/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.jDMGWFd6Gs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 17:54:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:54:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:54:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5XDt3AO6vk/Render', 17:54:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:54:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:54:03 INFO - 'HOME': '/Users/cltbld', 17:54:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:54:03 INFO - 'LOGNAME': 'cltbld', 17:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:03 INFO - 'MOZ_NO_REMOTE': '1', 17:54:03 INFO - 'NO_EM_RESTART': '1', 17:54:03 INFO - 'PAGER': '/bin/cat', 17:54:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:03 INFO - 'PWD': '/builds/slave/test', 17:54:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:54:03 INFO - 'SHELL': '/bin/bash', 17:54:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jDMGWFd6Gs/Listeners', 17:54:03 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 17:54:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:54:03 INFO - 'USER': 'cltbld', 17:54:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:54:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:03 INFO - 'XPC_FLAGS': '0x0', 17:54:03 INFO - 'XPC_SERVICE_NAME': '0', 17:54:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:04 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 17:54:04 INFO - Cleaning up... 17:54:04 INFO - Return code: 0 17:54:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:54:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:04 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 0x10d4dba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d570618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe7add71d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43fd30>, '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 0x10d1a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d437b20>, '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.5XDt3AO6vk/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.jDMGWFd6Gs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 17:54:04 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 17:54:04 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 17:54:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5XDt3AO6vk/Render', 17:54:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:54:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:54:04 INFO - 'HOME': '/Users/cltbld', 17:54:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:54:04 INFO - 'LOGNAME': 'cltbld', 17:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:04 INFO - 'MOZ_NO_REMOTE': '1', 17:54:04 INFO - 'NO_EM_RESTART': '1', 17:54:04 INFO - 'PAGER': '/bin/cat', 17:54:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:04 INFO - 'PWD': '/builds/slave/test', 17:54:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:54:04 INFO - 'SHELL': '/bin/bash', 17:54:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jDMGWFd6Gs/Listeners', 17:54:04 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 17:54:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:54:04 INFO - 'USER': 'cltbld', 17:54:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:54:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:04 INFO - 'XPC_FLAGS': '0x0', 17:54:04 INFO - 'XPC_SERVICE_NAME': '0', 17:54:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:04 INFO - Downloading/unpacking psutil>=3.1.1 17:54:04 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 17:54:04 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 17:54:04 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 17:54:04 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 17:54:04 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 17:54:04 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 17:54:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:54:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:54:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:54:07 INFO - Installing collected packages: psutil 17:54:07 INFO - Running setup.py install for psutil 17:54:07 INFO - building 'psutil._psutil_osx' extension 17:54:07 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 17:54:08 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 17:54:08 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 17:54:08 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 17:54:08 INFO - building 'psutil._psutil_posix' extension 17:54:08 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 17:54:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:54:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:54:08 INFO - ^ 17:54:08 INFO - 1 warning generated. 17:54:08 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 17:54:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:54:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:54:08 INFO - Successfully installed psutil 17:54:08 INFO - Cleaning up... 17:54:08 INFO - Return code: 0 17:54:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:54:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:08 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 0x10d4dba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d570618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe7add71d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43fd30>, '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 0x10d1a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d437b20>, '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.5XDt3AO6vk/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.jDMGWFd6Gs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 17:54:08 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 17:54:08 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 17:54:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5XDt3AO6vk/Render', 17:54:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:54:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:54:08 INFO - 'HOME': '/Users/cltbld', 17:54:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:54:08 INFO - 'LOGNAME': 'cltbld', 17:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:08 INFO - 'MOZ_NO_REMOTE': '1', 17:54:08 INFO - 'NO_EM_RESTART': '1', 17:54:08 INFO - 'PAGER': '/bin/cat', 17:54:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:08 INFO - 'PWD': '/builds/slave/test', 17:54:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:54:08 INFO - 'SHELL': '/bin/bash', 17:54:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jDMGWFd6Gs/Listeners', 17:54:08 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 17:54:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:54:08 INFO - 'USER': 'cltbld', 17:54:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:54:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:08 INFO - 'XPC_FLAGS': '0x0', 17:54:08 INFO - 'XPC_SERVICE_NAME': '0', 17:54:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:54:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:54:08 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 17:54:08 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 17:54:08 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 17:54:08 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 17:54:08 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 17:54:08 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 17:54:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:54:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:54:11 INFO - Installing collected packages: mozsystemmonitor 17:54:11 INFO - Running setup.py install for mozsystemmonitor 17:54:11 INFO - Successfully installed mozsystemmonitor 17:54:11 INFO - Cleaning up... 17:54:11 INFO - Return code: 0 17:54:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:54:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d4dba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d570618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe7add71d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43fd30>, '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 0x10d1a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d437b20>, '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.5XDt3AO6vk/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.jDMGWFd6Gs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 17:54:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:54:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:54:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5XDt3AO6vk/Render', 17:54:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:54:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:54:11 INFO - 'HOME': '/Users/cltbld', 17:54:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:54:11 INFO - 'LOGNAME': 'cltbld', 17:54:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:11 INFO - 'MOZ_NO_REMOTE': '1', 17:54:11 INFO - 'NO_EM_RESTART': '1', 17:54:11 INFO - 'PAGER': '/bin/cat', 17:54:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:54:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:11 INFO - 'PWD': '/builds/slave/test', 17:54:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:54:11 INFO - 'SHELL': '/bin/bash', 17:54:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jDMGWFd6Gs/Listeners', 17:54:11 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 17:54:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:54:11 INFO - 'USER': 'cltbld', 17:54:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:54:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:54:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:11 INFO - 'XPC_FLAGS': '0x0', 17:54:11 INFO - 'XPC_SERVICE_NAME': '0', 17:54:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:54:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:11 INFO - Downloading/unpacking jsonschema==2.5.1 17:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:54:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:54:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:54:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:14 INFO - Downloading functools32-3.2.3-2.tar.gz 17:54:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:54:14 INFO - warning: no files found matching '*.txt' 17:54:14 INFO - no previously-included directories found matching 'build' 17:54:14 INFO - no previously-included directories found matching 'dist' 17:54:14 INFO - no previously-included directories found matching '.git*' 17:54:14 INFO - Installing collected packages: jsonschema, functools32 17:54:14 INFO - Running setup.py install for functools32 17:54:15 INFO - warning: no files found matching '*.txt' 17:54:15 INFO - no previously-included directories found matching 'build' 17:54:15 INFO - no previously-included directories found matching 'dist' 17:54:15 INFO - no previously-included directories found matching '.git*' 17:54:15 INFO - Successfully installed jsonschema functools32 17:54:15 INFO - Cleaning up... 17:54:15 INFO - Return code: 0 17:54:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:54:15 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')]} 17:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:15 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')]} 17:54:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:15 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 0x10d4dba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d570618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe7add71d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43fd30>, '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 0x10d1a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d437b20>, '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.5XDt3AO6vk/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.jDMGWFd6Gs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 17:54:15 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 17:54:15 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 17:54:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5XDt3AO6vk/Render', 17:54:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:54:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:54:15 INFO - 'HOME': '/Users/cltbld', 17:54:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:54:15 INFO - 'LOGNAME': 'cltbld', 17:54:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:15 INFO - 'MOZ_NO_REMOTE': '1', 17:54:15 INFO - 'NO_EM_RESTART': '1', 17:54:15 INFO - 'PAGER': '/bin/cat', 17:54:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:54:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:15 INFO - 'PWD': '/builds/slave/test', 17:54:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:54:15 INFO - 'SHELL': '/bin/bash', 17:54:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jDMGWFd6Gs/Listeners', 17:54:15 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 17:54:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:54:15 INFO - 'USER': 'cltbld', 17:54:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:54:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:54:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:15 INFO - 'XPC_FLAGS': '0x0', 17:54:15 INFO - 'XPC_SERVICE_NAME': '0', 17:54:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:54:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:54:15 INFO - Cleaning up... 17:54:15 INFO - Return code: 0 17:54:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:54:15 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')]} 17:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:15 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')]} 17:54:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:15 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 0x10d4dba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d570618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe7add71d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43fd30>, '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 0x10d1a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d437b20>, '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.5XDt3AO6vk/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.jDMGWFd6Gs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 17:54:15 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 17:54:15 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 17:54:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5XDt3AO6vk/Render', 17:54:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:54:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:54:15 INFO - 'HOME': '/Users/cltbld', 17:54:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:54:15 INFO - 'LOGNAME': 'cltbld', 17:54:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:15 INFO - 'MOZ_NO_REMOTE': '1', 17:54:15 INFO - 'NO_EM_RESTART': '1', 17:54:15 INFO - 'PAGER': '/bin/cat', 17:54:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:54:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:15 INFO - 'PWD': '/builds/slave/test', 17:54:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:54:15 INFO - 'SHELL': '/bin/bash', 17:54:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jDMGWFd6Gs/Listeners', 17:54:15 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 17:54:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:54:15 INFO - 'USER': 'cltbld', 17:54:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:54:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:54:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:15 INFO - 'XPC_FLAGS': '0x0', 17:54:15 INFO - 'XPC_SERVICE_NAME': '0', 17:54:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:54:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:15 INFO - Downloading/unpacking blobuploader==1.2.4 17:54:15 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 17:54:15 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 17:54:15 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 17:54:15 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 17:54:15 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 17:54:15 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 17:54:18 INFO - Downloading blobuploader-1.2.4.tar.gz 17:54:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:54:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:54:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:54:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:54:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:54:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:54:19 INFO - Downloading docopt-0.6.1.tar.gz 17:54:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:54:19 INFO - Installing collected packages: blobuploader, requests, docopt 17:54:19 INFO - Running setup.py install for blobuploader 17:54:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:54:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:54:19 INFO - Running setup.py install for requests 17:54:20 INFO - Running setup.py install for docopt 17:54:20 INFO - Successfully installed blobuploader requests docopt 17:54:20 INFO - Cleaning up... 17:54:20 INFO - Return code: 0 17:54:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:54:20 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')]} 17:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:20 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')]} 17:54:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:20 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 0x10d4dba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d570618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe7add71d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43fd30>, '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 0x10d1a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d437b20>, '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.5XDt3AO6vk/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.jDMGWFd6Gs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 17:54:20 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 17:54:20 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 17:54:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5XDt3AO6vk/Render', 17:54:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:54:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:54:20 INFO - 'HOME': '/Users/cltbld', 17:54:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:54:20 INFO - 'LOGNAME': 'cltbld', 17:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:20 INFO - 'MOZ_NO_REMOTE': '1', 17:54:20 INFO - 'NO_EM_RESTART': '1', 17:54:20 INFO - 'PAGER': '/bin/cat', 17:54:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:20 INFO - 'PWD': '/builds/slave/test', 17:54:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:54:20 INFO - 'SHELL': '/bin/bash', 17:54:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jDMGWFd6Gs/Listeners', 17:54:20 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 17:54:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:54:20 INFO - 'USER': 'cltbld', 17:54:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:54:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:20 INFO - 'XPC_FLAGS': '0x0', 17:54:20 INFO - 'XPC_SERVICE_NAME': '0', 17:54:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:54:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:54:20 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-WFRT1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:54:21 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-zl1PRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:54:21 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-T9zDhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:54:21 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-WjQRBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:54:21 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-bYEBS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:54:21 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-CXUpzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:54:21 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-zehRy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:54:21 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-cyNyvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:54:21 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-SetICs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:54:21 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-eZSAzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:54:21 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-xQZN3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:54:22 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-5Ko3fp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:54:22 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-8045HV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:54:22 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-mwO8Vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:54:22 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-nlcQ2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:54:22 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-uUxLi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:54:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:54:22 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-gpayTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:54:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:54:22 INFO - Running setup.py install for manifestparser 17:54:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:54:22 INFO - Running setup.py install for mozcrash 17:54:22 INFO - Running setup.py install for mozdebug 17:54:23 INFO - Running setup.py install for mozdevice 17:54:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:54:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:54:23 INFO - Running setup.py install for mozfile 17:54:23 INFO - Running setup.py install for mozhttpd 17:54:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:54:23 INFO - Running setup.py install for mozinfo 17:54:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:54:23 INFO - Running setup.py install for mozInstall 17:54:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:54:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:54:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:54:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:54:23 INFO - Running setup.py install for mozleak 17:54:23 INFO - Running setup.py install for mozlog 17:54:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:54:24 INFO - Running setup.py install for moznetwork 17:54:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:54:24 INFO - Running setup.py install for mozprocess 17:54:24 INFO - Running setup.py install for mozprofile 17:54:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:54:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:54:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:54:24 INFO - Running setup.py install for mozrunner 17:54:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:54:24 INFO - Running setup.py install for mozscreenshot 17:54:24 INFO - Running setup.py install for moztest 17:54:25 INFO - Running setup.py install for mozversion 17:54:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:54:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:54:25 INFO - Cleaning up... 17:54:25 INFO - Return code: 0 17:54:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:54: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')]} 17:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54: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')]} 17:54:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:25 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 0x10d4dba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d570618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe7add71d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43fd30>, '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 0x10d1a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d437b20>, '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.5XDt3AO6vk/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.jDMGWFd6Gs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 17:54:25 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 17:54:25 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 17:54:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5XDt3AO6vk/Render', 17:54:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:54:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:54:25 INFO - 'HOME': '/Users/cltbld', 17:54:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:54:25 INFO - 'LOGNAME': 'cltbld', 17:54:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:25 INFO - 'MOZ_NO_REMOTE': '1', 17:54:25 INFO - 'NO_EM_RESTART': '1', 17:54:25 INFO - 'PAGER': '/bin/cat', 17:54:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:54:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:25 INFO - 'PWD': '/builds/slave/test', 17:54:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:54:25 INFO - 'SHELL': '/bin/bash', 17:54:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jDMGWFd6Gs/Listeners', 17:54:25 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 17:54:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:54:25 INFO - 'USER': 'cltbld', 17:54:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:54:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:54:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:25 INFO - 'XPC_FLAGS': '0x0', 17:54:25 INFO - 'XPC_SERVICE_NAME': '0', 17:54:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:54:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:54:25 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-rHp0Xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:54:25 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)) 17:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:54:25 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-JSHymn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:54:26 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)) 17:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:54:26 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-gLdIfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:54:26 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)) 17:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:54:26 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-UyFAJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:54:26 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)) 17:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:54:26 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-HoLUE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:54:26 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)) 17:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:54:26 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-5c4paj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:54:26 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)) 17:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:54:26 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-mH4URM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:54:26 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)) 17:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:54:26 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-i5Uyj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:54:26 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)) 17:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:54:26 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-zCP8bY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:54:26 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)) 17:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:54:26 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-MIR9at-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:54:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:54:26 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-kbIPuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:54:27 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)) 17:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:54:27 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-9TW7Rq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:54:27 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)) 17:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:54:27 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-fZAbH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:54:27 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)) 17:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:54:27 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-RzWr5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:54:27 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)) 17:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:54:27 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-zx0DzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:54:27 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)) 17:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:54:27 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-ANPlQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:54:27 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)) 17:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:54:27 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-djfzoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:54:27 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)) 17:54:27 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)) 17:54:27 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)) 17:54:27 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)) 17:54:27 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)) 17:54:27 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)) 17:54:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:54:27 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 17:54:27 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 17:54:27 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 17:54:27 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 17:54:27 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 17:54:27 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 17:54:30 INFO - Downloading blessings-1.6.tar.gz 17:54:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:54:30 INFO - Installing collected packages: blessings 17:54:30 INFO - Running setup.py install for blessings 17:54:30 INFO - Successfully installed blessings 17:54:30 INFO - Cleaning up... 17:54:30 INFO - Return code: 0 17:54:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:54:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:54:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:54:31 INFO - Reading from file tmpfile_stdout 17:54:31 INFO - Current package versions: 17:54:31 INFO - blessings == 1.6 17:54:31 INFO - blobuploader == 1.2.4 17:54:31 INFO - docopt == 0.6.1 17:54:31 INFO - functools32 == 3.2.3-2 17:54:31 INFO - jsonschema == 2.5.1 17:54:31 INFO - manifestparser == 1.1 17:54:31 INFO - mozInstall == 1.12 17:54:31 INFO - mozcrash == 0.17 17:54:31 INFO - mozdebug == 0.1 17:54:31 INFO - mozdevice == 0.48 17:54:31 INFO - mozfile == 1.2 17:54:31 INFO - mozhttpd == 0.7 17:54:31 INFO - mozinfo == 0.9 17:54:31 INFO - mozleak == 0.1 17:54:31 INFO - mozlog == 3.3 17:54:31 INFO - moznetwork == 0.27 17:54:31 INFO - mozprocess == 0.23 17:54:31 INFO - mozprofile == 0.28 17:54:31 INFO - mozrunner == 6.12 17:54:31 INFO - mozscreenshot == 0.1 17:54:31 INFO - mozsystemmonitor == 0.3 17:54:31 INFO - moztest == 0.7 17:54:31 INFO - mozversion == 1.4 17:54:31 INFO - psutil == 3.1.1 17:54:31 INFO - requests == 1.2.3 17:54:31 INFO - wsgiref == 0.1.2 17:54:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:54:31 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')]} 17:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:31 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')]} 17:54:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:31 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 0x10d4dba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d570618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe7add71d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43fd30>, '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 0x10d1a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d437b20>, '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.5XDt3AO6vk/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.jDMGWFd6Gs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 17:54:31 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 17:54:31 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 17:54:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5XDt3AO6vk/Render', 17:54:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:54:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:54:31 INFO - 'HOME': '/Users/cltbld', 17:54:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:54:31 INFO - 'LOGNAME': 'cltbld', 17:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:31 INFO - 'MOZ_NO_REMOTE': '1', 17:54:31 INFO - 'NO_EM_RESTART': '1', 17:54:31 INFO - 'PAGER': '/bin/cat', 17:54:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:31 INFO - 'PWD': '/builds/slave/test', 17:54:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:54:31 INFO - 'SHELL': '/bin/bash', 17:54:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jDMGWFd6Gs/Listeners', 17:54:31 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 17:54:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:54:31 INFO - 'USER': 'cltbld', 17:54:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:54:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:31 INFO - 'XPC_FLAGS': '0x0', 17:54:31 INFO - 'XPC_SERVICE_NAME': '0', 17:54:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:54:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:31 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)) 17:54:31 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)) 17:54:31 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)) 17:54:31 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)) 17:54:31 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)) 17:54:31 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)) 17:54:31 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)) 17:54:31 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)) 17:54:31 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)) 17:54:31 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)) 17:54:31 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)) 17:54:31 INFO - Cleaning up... 17:54:31 INFO - Return code: 0 17:54:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:54:31 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')]} 17:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:54:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:31 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')]} 17:54:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:54:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:54:31 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 0x10d4dba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d570618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe7add71d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43fd30>, '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 0x10d1a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d437b20>, '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.5XDt3AO6vk/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.jDMGWFd6Gs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 17:54:31 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 17:54:31 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 17:54:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5XDt3AO6vk/Render', 17:54:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:54:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:54:31 INFO - 'HOME': '/Users/cltbld', 17:54:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:54:31 INFO - 'LOGNAME': 'cltbld', 17:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:54:31 INFO - 'MOZ_NO_REMOTE': '1', 17:54:31 INFO - 'NO_EM_RESTART': '1', 17:54:31 INFO - 'PAGER': '/bin/cat', 17:54:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:54:31 INFO - 'PWD': '/builds/slave/test', 17:54:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:54:31 INFO - 'SHELL': '/bin/bash', 17:54:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jDMGWFd6Gs/Listeners', 17:54:31 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 17:54:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:54:31 INFO - 'USER': 'cltbld', 17:54:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:54:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:54:31 INFO - 'XPC_FLAGS': '0x0', 17:54:31 INFO - 'XPC_SERVICE_NAME': '0', 17:54:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:54:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:54:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:54:31 INFO - Cleaning up... 17:54:31 INFO - Return code: 0 17:54:31 INFO - Running post-action listener: _resource_record_post_action 17:54:31 INFO - Running post-action listener: _start_resource_monitoring 17:54:31 INFO - Starting resource monitoring. 17:54:31 INFO - [mozharness: 2016-08-13 00:54:31.787721Z] Finished create-virtualenv step (success) 17:54:31 INFO - [mozharness: 2016-08-13 00:54:31.788701Z] Running install step. 17:54:31 INFO - Running pre-action listener: _resource_record_pre_action 17:54:31 INFO - Running main action method: install 17:54:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:54:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:54:32 INFO - Reading from file tmpfile_stdout 17:54:32 INFO - Detecting whether we're running mozinstall >=1.0... 17:54:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:54:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:54:32 INFO - Reading from file tmpfile_stdout 17:54:32 INFO - Output received: 17:54:32 INFO - Usage: mozinstall [options] installer 17:54:32 INFO - Options: 17:54:32 INFO - -h, --help show this help message and exit 17:54:32 INFO - -d DEST, --destination=DEST 17:54:32 INFO - Directory to install application into. [default: 17:54:32 INFO - "/builds/slave/test"] 17:54:32 INFO - --app=APP Application being installed. [default: firefox] 17:54:32 INFO - mkdir: /builds/slave/test/build/application 17:54:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:54:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:55:06 INFO - Reading from file tmpfile_stdout 17:55:06 INFO - Output received: 17:55:06 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:55:06 INFO - Running post-action listener: _resource_record_post_action 17:55:06 INFO - [mozharness: 2016-08-13 00:55:06.450246Z] Finished install step (success) 17:55:06 INFO - [mozharness: 2016-08-13 00:55:06.450400Z] Running run-tests step. 17:55:06 INFO - Running pre-action listener: _resource_record_pre_action 17:55:06 INFO - Running main action method: run_tests 17:55:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:55:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:55:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:55:06 INFO - 2016-08-12 17:55:06.464 screenresolution[1928:17815] starting screenresolution argv=screenresolution get 17:55:06 INFO - 2016-08-12 17:55:06.467 screenresolution[1928:17815] Display 0: 1600x1200x32@60 17:55:06 INFO - 2016-08-12 17:55:06.472 screenresolution[1929:17817] starting screenresolution argv=screenresolution list 17:55:06 INFO - Available Modes on Display 0 17:55:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:55:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:55:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:55:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:55:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:55:06 INFO - Intel Iris: 17:55:06 INFO - Chipset Model: Intel Iris 17:55:06 INFO - Type: GPU 17:55:06 INFO - Bus: Built-In 17:55:06 INFO - VRAM (Dynamic, Max): 1536 MB 17:55:06 INFO - Vendor: Intel (0x8086) 17:55:06 INFO - Device ID: 0x0a2e 17:55:06 INFO - Revision ID: 0x0009 17:55:06 INFO - Displays: 17:55:06 INFO - Display: 17:55:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:55:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:55:06 INFO - Display Serial Number: 1600x1200 60 17:55:06 INFO - Main Display: Yes 17:55:06 INFO - Mirror: Off 17:55:06 INFO - Online: Yes 17:55:06 INFO - Rotation: Supported 17:55:06 INFO - Return code: 0 17:55:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:55:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:55:06 INFO - Python 2.7.3 17:55:06 INFO - Return code: 0 17:55:06 INFO - grabbing minidump binary from tooltool 17:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:06 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 0x10d43fd30>, '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 0x10d1a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d437b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:55:06 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 17:55:06 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 17:55:06 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 17:55:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:55:06 INFO - Return code: 0 17:55:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:55:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:55:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:55:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:55:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:55:06 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/RHDugItNSY-1K8F-qeW2YQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--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 17:55:06 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/RHDugItNSY-1K8F-qeW2YQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0106 --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 17:55:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5XDt3AO6vk/Render', 17:55:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:55:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:55:06 INFO - 'HOME': '/Users/cltbld', 17:55:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:55:06 INFO - 'LOGNAME': 'cltbld', 17:55:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:55:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:55:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:06 INFO - 'MOZ_NO_REMOTE': '1', 17:55:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:55:06 INFO - 'NO_EM_RESTART': '1', 17:55:06 INFO - 'PAGER': '/bin/cat', 17:55:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:55:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:06 INFO - 'PWD': '/builds/slave/test', 17:55:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:55:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:55:06 INFO - 'SHELL': '/bin/bash', 17:55:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jDMGWFd6Gs/Listeners', 17:55:06 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 17:55:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:55:06 INFO - 'USER': 'cltbld', 17:55:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:55:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:55:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:06 INFO - 'XPC_FLAGS': '0x0', 17:55:06 INFO - 'XPC_SERVICE_NAME': '0', 17:55:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:55:06 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/RHDugItNSY-1K8F-qeW2YQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--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 17:55:07 INFO - mozversion application_buildid: 20160812161717 17:55:07 INFO - mozversion application_changeset: 316a84b6888a45ff70b5badf10a5899bdc09875e 17:55:07 INFO - mozversion application_display_name: Nightly 17:55:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:55:07 INFO - mozversion application_name: Firefox 17:55:07 INFO - mozversion application_remotingname: firefox 17:55:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 17:55:07 INFO - mozversion application_vendor: Mozilla 17:55:07 INFO - mozversion application_version: 51.0a1 17:55:07 INFO - mozversion platform_buildid: 20160812161717 17:55:07 INFO - mozversion platform_changeset: 316a84b6888a45ff70b5badf10a5899bdc09875e 17:55:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 17:55:07 INFO - mozversion platform_version: 51.0a1 17:55:07 INFO - using testdate: 1471049707 17:55:07 INFO - actual date: 1471049707 17:55:07 INFO - starting webserver on 'localhost:56102' 17:55:07 INFO - SUITE-START | Running 2 tests 17:55:07 INFO - TEST-START | dromaeo_css 17:55:07 INFO - operating with platform_type : mac_ 17:55:07 INFO - Initialising browser for dromaeo_css test... 17:55:07 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpaFSl8i/profile http://localhost:56102/getInfo.html) 17:55:09 INFO - PROCESS | 1939 | __metrics Screen width/height:1600/1200 17:55:09 INFO - PROCESS | 1939 | colorDepth:24 17:55:09 INFO - PROCESS | 1939 | Browser inner width/height: 1024/689 17:55:09 INFO - PROCESS | 1939 | __metrics 17:55:10 ERROR - PROCESS | 1939 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 17:55:10 INFO - TEST-INFO | 1939: exit 0 17:55:10 INFO - Browser initialized. 17:55:10 INFO - Running cycle 1/1 for dromaeo_css test... 17:55:10 INFO - TEST-INFO | started process 1942 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpaFSl8i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:55:22 INFO - PROCESS | 1942 | RSS: Main: 254660608 17:55:22 INFO - PROCESS | 1942 | 17:56:12 INFO - PROCESS | 1942 | 1471049772389 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] 17:58:24 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:56102/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56102/tests/dromaeo/cssquery-ext.html) 17:58:25 INFO - PROCESS | 1942 | RSS: Main: 268943360 17:58:25 INFO - PROCESS | 1942 | 18:01:27 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:56102/tests/dromaeo/cssquery-ext.html (next: http://localhost:56102/tests/dromaeo/cssquery-jquery.html) 18:01:28 INFO - PROCESS | 1942 | RSS: Main: 277647360 18:01:28 INFO - PROCESS | 1942 | 18:04:30 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:56102/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56102/tests/dromaeo/cssquery-mootools.html) 18:04:31 INFO - PROCESS | 1942 | RSS: Main: 281976832 18:04:31 INFO - PROCESS | 1942 | 18:07:32 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:56102/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56102/tests/dromaeo/cssquery-prototype.html) 18:07:33 INFO - PROCESS | 1942 | RSS: Main: 280637440 18:07:33 INFO - PROCESS | 1942 | 18:10:36 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:56102/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56102/tests/dromaeo/cssquery-yui.html) 18:10:37 INFO - PROCESS | 1942 | RSS: Main: 284860416 18:10:37 INFO - PROCESS | 1942 | 18:13:39 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:56102/tests/dromaeo/cssquery-yui.html (next: http://localhost:56102/tests/dromaeo/cssquery-dojo.html) 18:13:40 INFO - PROCESS | 1942 | RSS: Main: 287690752 18:13:40 INFO - PROCESS | 1942 | 18:13:40 INFO - PROCESS | 1942 | __start_tp_report 18:13:40 INFO - PROCESS | 1942 | _x_x_mozilla_page_load 18:13:40 INFO - PROCESS | 1942 | _x_x_mozilla_page_load_details 18:13:40 INFO - PROCESS | 1942 | |i|pagename|runs| 18:13:40 INFO - PROCESS | 1942 | |0;dojo.html;3349.5645566076423;3353.6311005789357;3379.459286514158;3388.576427946506;3394.1853955050797;5638.40796716345;5658.632188907718;5725.9999999999945;5776.65340079595;5794.333651630064;5653.943460565393;5670;5716.657000579958;5733.655980641154;5757.510611598009;5105.897882042366;5216.843494695147;5226.503482169207;5280.551153151987;5304.098303288451;4423.491298500681;5304.575633949294;5347.171188465794;5373.140297552392;5420.756065977041;5147.305113809625;5201.505856943584;5210.713410762407;5259.815906443256;5266.973665131669;5272.604554658377;5272.762725677354;5296.682199068068;5298.735063246861;5311.787528498855;4915.410150781893;5221.6083793715625;5251.55361794248;5283.128283833163;5299.364076310829;4215.957840421618;5639.915401268984;5698.943010569883;5736.196932429463;5760.2223699800825;5705.4579814917515;6202.596831205957;6247.219097612799;6249.437550620421;6267.7179526920945;6189.089419604267;6246.500279977591;6249.125122482856;6253.906191407133;6259.467945224661;5692;5758.942410575883;5811.244538210006;5838.941610583882;5840.561957853178;6260.874782504325;6281.2462504498835;6291.245050593958;6306.590071645328;6311.779087731908;6117.449429551273;6164.6917654117115;6180.505559555225;6190.226221722285;6191.752329906843;6099.218990344071;6101.005087479836;6102.458955353584;6134.252905685651;6229.283632382243;6193.721282542297;6195.411435913581;6199.256089269226;6216.658083805434;6257;6152.3540028297275;6216.533759968021;6218.409251121137;6234;6243.375662433811;4792.161371759928;4814.229723244264;4816.614670826326;4846.006568653417;4945.381827271591;3351.9832400838327;3745.8127093645207;4150.91698166041;4283.250431174594;4375.912481750347;5589.832305030855;5599.272094627754;5602.134527176236;5628.802991895264;5673.489385955284;4872.4640289568115;6099.176611157437;6181.752729890754;6182.319944806068;6234.937650623527;5754.338251101177;5754.4533269339345;5756.366799652035;5756.7121643917635;5813.302403711582;5430.972845135749;5432.348118225838;5440.156775699773;5451.1005684062475;5451.155070964007;5207.0366982108435;6231.40801623845;6264.060390941395;6298.748050077946;6313.463355614732;6216.751329946752;6229.345918678474;6240.563160578716;6242.53181011435;6258.561900666909;6268.9969604863;6329.050642403677;6331.9050214247745;6338.778142764981;6349.460295874717;6051.3041000283765;6105.732692890381;6116.305337585956;6136.417040381157;6214.25428948529;6030.849228769316;6208.130861679459;6231.470325022243;6239.906401404073;6239.96880015597;6190.50475961913;6199.3490683477585;6212.720427580679;6253.812385628438;6263.123162757127;6050.546209034252;6105.126180223362;6121.081837724377;6148.661823599745;6189.164462797465;5760.683162426107;5996.280446346466;6027.276726792637;6041.879162416639;6045.969770151297;6163.691815409301;6165.198524191826;6197.318294987457;6200.720967556561;6203.565750397429;5917.260342457193;5964.612300200473;6000.8799824004145;6043.093535969464;6062.514998800174 18:13:40 INFO - PROCESS | 1942 | |1;ext.html;431.4175862585508;506.19514971195804;521.5749164430988;546.1916363781605;553.5101435229822;31431;40465.797671011605;40490.59509404909;40570.7971460143;40602.59397406025;40851.57019504318;41238.38142427859;41247;41359.379609305885;41484;9601.375910565826;9820;9825.213982881352;9831.852522212173;9842.212622990144;9638.228941684649;9761.414315141114;9775.56009979549;9778.7776527934;9809.901900981005;9794.265430092735;9801.950990245039;9828.95085524575;9848.21214302854;9854.310198286086;9778.804423911517;9779.266555008402;9797.481390384502;9801.607935682565;9850.162736167435;9684.70945871625;9768.95115524425;9771.169450596708;9779.070988256104;9794.804103917953;39250.41124383137;39571.80214098911;39615.60384396148;39695.60304396977;39787.40318895219;2581.3417578517547;3209.3741720364537;3472.1146107742616;3614.602393736713;4162.500499940026;29393.540045254624;30284.788608455634;31134.532982005287;31584.210394740086;31953.360932781216;3065.908022759321;3074.062410964655;3087.428825667236;3103.9844800776077;3216.388886111631;383541;457427;459525;460872;463461;33406.49890251648;33531.664683353345;33547.3290534188;33642.49536256958;33686;33490.83254583712;34464.138396540286;34598.654013460044;34992.82503587466;35106.82446587802;16534.83465165333;16679.833201668072;16694;16718.91640541814;16765.32938682439;12620.55828046014;12691.619251422471;12746.872531274754;12747.936260318638;12777.297248651414;19159.61680766377;19258.71111933322;19323.806761932483;19375.321863734982;19423.3201837935;7910.644021019068;8036.758897233092;8043.839123217503;8045.235702608243;8091.231333023354;858.4591707224408;937.3672770879629;969.3844408800462;1014.5941623350571;1067.5996501312009;30098.54852177219;30853.228669283;31556;31954.520682189785;31981.680183198336;951.6241084771476;1078.3907092492716;1080.475969154959;1160.5357856857324;1179.510503141204;12455.065870059781;15616.92191539035;15631.296591653403;15708.21458927072;15838.049717016786;377734;421820;464113;470535;470629;48101.03797924022;55827.441725583034;57135;58081;58136;1277.9488820447077;1280.103927250928;1346.7239215960703;1347.696768227141;1359.8436179839248;25511;25769.871150644125;26412.735872641795;29719.55420668735;30541.694583054774;51904.22143667923;52733;52787.73606131945;52790.47209528009;52792.68018299573;625021;630553.847230761;632280;634003;634111;26207.4758504825;26463.073792417945;26649.866750666122;26763;26766.598501022112;46402;47278.05443891172;48007;48338.75830620824;48452.7577362111;38059.619403805606;38265;39353.40969885397;39381.606183937794;39497.40753888751;38280.80859595684;38524;38602.80698596489;39681;40052.998675033356;38127.618723812404;38384.616153838106;39461;39585.80207098946;40927.72578193797;30921.690783091883;31212.375752485277;35450.64549354473;35533;35606.93179204628;22195.33413997583;25645.743542564334;25866.87066564655;26068.478630426907;26410.735892640827 18:13:40 INFO - PROCESS | 1942 | |2;jquery.html;347.8973702757687;359.4285086712129;373.454756056158;381.87207285559373;391.94512768212456;19730.112144953477;20026.49933751657;20723.792762072393;20920.790792092073;21061.473463163427;19584.510387240327;19832.40502784919;20620.587588248225;20651.586968260624;20890.477738056557;5337.653052551572;5357.571394288467;5794.884102317972;5925.903707814046;6214.751409943619;6831.351021652935;6886.070380498643;6895.862082758367;6907.620080895549;6910.792676219721;5812.767489300444;6713.56361836479;6753.5947843129325;6815.318468153195;6848.657567121649;6584.967075164617;6631.867362652768;6655.534112612119;6739.797806065851;6778.017187507809;5204.828913494472;5630.465105814941;5856.912146317766;5857.648541087548;5929.851753706149;26085;26584.867075664497;26623.600645990326;26647.600285995726;26656.866715666296;2231.4309850988056;2266.6826644269813;2419.0928401849305;2436.549238390903;2929.824210547374;15527.767083493756;15669.843301566953;15810.446634367858;15934.043957362595;16051.598710032225;1873.8313551780268;1904.9428517144509;1905.1902941249914;1913.808619138089;1989.6120256549978;93011.99999999932;112435;116906;116918;118131;10510.842337364946;10578.100861426865;10686.465676716132;10956.616518421817;11110.388928608843;13350;13369.598912032654;13369.598912032654;13400.195988240543;13415.463381464631;7080.964322069647;8183.386246031571;8422.6209820557;8566.014908285502;8623.568821558896;7470.962645186848;8424.53665048416;8563.486190828571;8579.957100214458;8747.868781968149;5196.856691527858;5618.52242559387;6185.762847430532;6562.934370656328;6695.397414232742;1764.3912850066706;1770.8406243438153;1848.9075546222634;1872.157529111878;1889.9716504252447;811.5009269299338;835.5321020228691;905.968291109808;941.449252187478;984.6406061787396;20829.89585052065;21156.78843211579;22341.888290558443;22366.88165591714;22412.55174896493;935.2284365398573;986.7977064701719;994.1996692662332;994.8608842875012;1037.3412882819464;11466.713332166595;11823.408829558488;11948.34284114382;11957;12241.449134788956;581263;586900;594328;607574;609984;108346.45826770816;113655;117633;123657.38171309086;125053;953.4374718915734;964.4020707161604;1001.3741411617739;1002.333448256901;1004.1514919892679;18962;19335.516612084248;19475.318363857765;19600.803991960467;19706.408807735792;54816.90366192574;55804;56207;57000.71499642475;57457;80830.59584702273;80929.59535202286;81496.77754833564;82179.5891020541;83142.75285870596;7060.823479413056;7959.363250940027;8025.23760242776;8255.050669173123;8325.458845175286;8552.786180345292;11434.37110958872;13299.933500332436;13308.534201302908;13797.24115173675;5484.945150548443;11424.885751142714;11450.885491144982;11637.76724465523;11867.821982670093;11056.447177641247;11400.600978965696;11496.080313574726;11703.307585660325;11952.880471195176;11673.416329183678;11675.649730508097;12049.75900481968;12056;12076.45655945467;8241.546714930737;8313.293370063613;8450.408471406943;8519.3184545235;8556.828863422821;8647.524386158822;11332.716682083013;11372.886271137182;11652.242604230698;11652.592159274385 18:13:40 INFO - PROCESS | 1942 | |3;mootools.html;1377.545410014695;1499.8425165357637;1593.76093585962;1694.2121913310316;1868.4581471373303;7931.405144614163;8404.789880252989;8623.568821558913;9013.72958811236;9034.232090272335;7419.258074192578;8619.094995025525;8830.86753698695;8840;8848.823023539526;2347.4718188407555;2389.4384819567476;2393.246127469841;2397.1130681647815;2407.229686500312;2352.494213744045;2369.6682464454902;2400.9159679411223;2404.675368825204;2409.518096380722;2353.4351755578623;2369.3484291819714;2387.7134743830766;2402.5074859653814;2407.1935901473025;2347.8826058696995;2361.799247063993;2371.253055287596;2371.881405929705;2381.523695260946;2349.5300939812105;2365.7870791628834;2376;2377.108584280895;2382.213869423086;8885.378023538355;8921.375503714742;8946.55267236642;8952.462852228888;8968;4711.199096153662;5224.059669259532;5402.054640437907;5402.243685883979;5411.242426060316;3522.4540196269363;3570.7143428525656;3573.714102871764;3631.9818400907825;3651.653092956165;900.4237288135598;1001.3991605036992;1474.8230212374476;1591.1487354265528;1824.8813827101328;11415.48630311638;11541.596044138414;11701.3564253966;11735;11741.295522268605;4310.073334233155;4577.5193604671695;4659.184642687516;4702.670813043054;4703.882402939886;8340.7071903855;8896.243819275434;9236.261099112055;9246.815063698688;9304.116108969638;4489.506154323022;5259.8422047338645;5271.78912843482;5278.076336641073;5283.2075188722;4026.416169655384;4422.601965823092;4860.781264843091;4882.414110306786;4927.891224474464;3758.661720445173;3814.1799513104816;3852.5184351956004;3899.3760998240714;3936.4685767421606;1160.570588882119;1175.3006960858277;1177.3877583656451;1183.946722397477;1187.554666999875;803.8954935858418;912.9497877616794;919.7792529792802;935.3452583191793;962.1542723522228;5736.6558006519745;5980.0431930890845;6011.879762404727;6158.322584515699;6206.782762603287;434.79130017591734;439.5692221622764;454.538643277074;458.0701176611484;461.1422753678156;4050.8177132029127;4059.3707975263883;4129.772862492532;4174.540800511942;4196.958030419718;8787.813645157821;10779.299345542515;10939;10944.507497162647;10946.890531094747;10093.192544596415;10358.482075896174;10877.945610271898;10900.672979810459;10907.291026083438;7629.771106866803;8348.833023339621;8389.832203355776;8401.621927013299;8411.957940210383;5238.5023422774775;5561.916571251515;5950.16697662319;5972.163897054329;6200.689965501617;9983.500824958577;10071.244656650633;10086.8486972694;10109.696709098738;10147.746306342106;9797.559109840216;10405;10415.739606509898;10455.790884182426;10465.424401657981;5829.970850145722;7037;7556.357709594746;7696.307332339892;7849.686012559434;8570.828583428172;8605.483670979762;8628.180322869317;8628.611712473079;8644.870326944974;7303.634818259172;7457.6271186441545;7676.040494938133;7694.653740581575;7812.492188007761;7409.37020353276;7455.850882982419;7460;7471.701131954661;7712.113106992768;7001.859962800817;7166.140063192451;7180.3537681608905;7199.892001619875;7206;4468.195724769443;4936.851894443173;5095.235714642833;5133.589312855037;5188.896222075462;4173.937390939199;4498.977505112453;5115.411727651368;5160.870978225425;5164.612654051037 18:13:40 INFO - PROCESS | 1942 | |4;prototype.html;253.59298326186482;303.40078345268114;308.1295340662628;316.14325178765546;319;4658.138244424784;5141.434442211354;5306.310179676637;5433.641589602599;5501.184609079004;5434.429384914586;5525.772783820381;5541.362743284523;5542.002439560877;5552.194931734896;3634;4006.1186538961456;4251.8511852085185;4252.425922500469;4259.76571288579;3410.0963244740165;3870.3807390817474;4099.44657471242;4197.244495990721;4259.914801703964;3825.368814145663;4032.2338755636333;4155.33514637658;4185.518665353477;4188.4136220929095;3689.6679298862964;4192.182524407742;4192.958070419302;4194.266003449415;4242.151569686044;3675.650813172771;3696.3346597612417;3703.9074023149637;3708.684761795251;3709.406494960793;4630.86107416778;5138.890956087734;5352.705601191933;5408.809432179974;5431.918521222185;4111.71218014739;4838.661293709407;4839.782209800567;4849.733264670442;4878.341423907763;5385.8114965976;5555.2778138841695;5818.912716309259;5837.620554663933;5904.793332233351;3542.557180352456;3983.920321593581;3998.200809635676;4042.9393559096343;4044.797760111983;5837.8691777501335;5994.040953447471;6181.2493440419485;6212.502999760053;6267.2165979252595;3657.817109144532;4100.897477563085;4105.507339119265;4106.733062350938;4115;3381.5773028371455;3849.9525916560915;3914.5106861642294;4119.670426365884;4124.6906482013965;4270.636995855387;4783.784729687172;4846.400687773026;4859.938238909535;4870.342503762017;5057.949420505822;5827.79602713903;5892.552856578864;5922.111683247461;5927.555433342516;1328.794036924259;1336.7059246965653;1397.5457976157788;1418.4680744720729;1421.1666949635062;938.3759799733101;955.4983633592419;968.7239136846106;970.5923512124924;976.2336565795816;4671.392718946515;5236.434147267812;5341.599380046512;5369.3556773187465;5388.757505912244;5102.897942041212;5222.738863056832;5727.6849773262875;5884.440978107073;5948.76921154567;4559.840405585788;5102.846914592568;5372.570194384518;5414.702191379433;5455.699936503451;2827.4203788223363;3106.2294492139263;3154.3060526684094;3178.507331363596;3204.919877003047;5051.974740126349;5819.185314055951;6287.7799277026;6312.652804095727;6318.4313411793155;5877.67752255739;5908.704564771744;6232.3144454110015;6272.435480806749;6282.465990390868;6293.96853015732;6367.426931576088;6378.553501254961;6385.872282554323;6478.890132736219;5839.240898683144;6024.668643224665;6048.939510605013;6074.362191969956;6084;5035.4712755161645;5064.974675126601;5735.799247026334;5964.7912323068485;5991.281046274475;5068.543831055223;6128.161551534611;6209.937900620936;6377.298497165215;6381.245157581702;3440.9311813763084;3907.648311651965;3931.960680393274;3973.774686175751;3989.341758609913;5222.537689446809;6099.664518451527;6100.23747031621;6107.4197951194565;6168.717574497465;5104.030234255628;5864.765409383747;5873.295204575478;5890.734916928663;5892.440218179266;5255.868603284948;5268.6575372600655;5881.617694849821;5882.911756323573;5940.702964851654;5237.397699264633;5301.575873929999;5623.8594035149445;5701.287339082614;5789.421057894346;4867.050925069578;5535.335759708861;5864.296284445723;5885.411458854081;5890.175375447355;5495.340559132929;5719.626355062769;5772.913406298993;5794.652320860761;5798.971005144947 18:13:40 INFO - PROCESS | 1942 | |5;yui.html;680.5270337115707;701.4844089594151;712.4941291682904;755.9697612095513;849.7238397520804;15082.62293442663;15502.5349239523;15831.05013699176;15856.28646710898;15867.444639437623;14361.35373908174;14451.277436128177;14556.199409032526;14589.124652520855;14591.124532528029;694.7880896326618;847.9533625650587;873.4017198219209;874.3267683883406;875.0461996423896;834.0741776627938;858.1332853817657;870.8519551676198;871.4466313890694;872.6640243506232;870.9940019277744;885.8759773631697;897.9102089791002;919.9264058875308;923.0354279777648;868.1708967935638;909.3498148823556;914.8993610702818;915.446155076176;918.8943271523793;672.5863593889771;673.9090222819955;680.5678394219657;683.255251775567;684.8972654101875;15001.624959376102;15024.17367044812;15040;15043.774343384857;15069.623259418493;14477;14670.046446980912;14698;14794.260286985607;15084.019538729948;11930.821037684442;12234.938825305906;12456.81314780279;12475.438605262785;12489.642710964263;3853.3064048471265;3854.7494412863075;4050.736702114353;4084.2852500812237;4092.242935057024;119278.80721192763;119509.40245298806;119695;123054;125385.11922321173;11227.887721122685;11259.493322800494;11350.375729334966;11412.42937853104;11763;20212.19151233934;21863.344099677037;23003.53992920132;23050.884745576164;23197.42006449852;8185.140560241208;8218.794530136794;8260.958695206486;8268.214519620626;8302.086770455246;3860.8455661773214;4515.774211289422;4568.17772800899;4728.243481043017;4788.970371370103;3572.91067723309;3676.889693309205;3694.891532540281;3695.7412981091065;3695.8706445274825;643.9452646525098;652.3118110393485;664.7473959895209;664.7772996046282;672.226939020121;491.96327205369795;546.2652732075352;630.1933525087895;632.7310892870512;654.6726636681659;7213.711451541984;9520.714378568655;9551.188149007274;9601.183899368492;9667.951660241795;567.619694804482;575.3211210771331;609.6981993913041;617.4686776793487;666.7899611622323;3870.496835411435;4600.5629465200755;4723.7874295656775;4742.596879265301;4744.193487107131;121031;156614.2169289169;160112.1091777016;163467;166436;132378;133475.66524334825;134709;134867;138923.30538347445;69156;70021.64989175124;70924;82162.58918705248;115259;9747.707568772948;10004.149647280063;10162.073106583388;10181.440020798927;10301.690949271533;54497;58748;61594;62383.6880815593;63235.6838215806;77319.10830254592;89966;90013;90172.09827901637;92182;12896.29070401137;13291.734165316446;13333.133346332845;13577.253251071286;13772.31138443094;14900.403983840524;15063;15085.396584136512;15093.39626414931;15133.470328538448;13790.65523361924;13949.58151255464;13971.231582263074;13998.160110393408;14381.28093595337;14062;14071.859281407464;14086.22525761093;14483.710325793636;14500.202488863213;13269.668258293234;13433.328333583477;13447.394867230802;13466.124701894345;14241.287935603386;10757.515911783832;10819.1344692426;11091.889081109086;11279.830802538132;11406.543738250377;11329.490172942402;11373.886261137613;11583;11683.591074312359;11701.180917335705 18:13:40 INFO - PROCESS | 1942 | __end_tp_report 18:13:40 INFO - PROCESS | 1942 | __start_cc_report 18:13:40 INFO - PROCESS | 1942 | _x_x_mozilla_cycle_collect,420 18:13:40 INFO - PROCESS | 1942 | __end_cc_report 18:13:40 INFO - PROCESS | 1942 | __startTimestamp1471050820208__endTimestamp 18:13:40 INFO - PROCESS | 1942 | 18:13:40 INFO - PROCESS | 1942 | ------- Summary: start ------- 18:13:40 INFO - PROCESS | 1942 | Number of tests: 6 18:13:40 INFO - PROCESS | 1942 | 18:13:40 INFO - PROCESS | 1942 | [#0] dojo.html Cycles:165 Average:5712.15 Median:6000.88 stddev:688.31 (11.5%) stddev-sans-first:665.00 18:13:40 INFO - PROCESS | 1942 | Values: 3349.6 3353.6 3379.5 3388.6 3394.2 5638.4 5658.6 5726.0 5776.7 5794.3 5653.9 5670.0 5716.7 5733.7 5757.5 5105.9 5216.8 5226.5 5280.6 5304.1 4423.5 5304.6 5347.2 5373.1 5420.8 5147.3 5201.5 5210.7 5259.8 5267.0 5272.6 5272.8 5296.7 5298.7 5311.8 4915.4 5221.6 5251.6 5283.1 5299.4 4216.0 5639.9 5698.9 5736.2 5760.2 5705.5 6202.6 6247.2 6249.4 6267.7 6189.1 6246.5 6249.1 6253.9 6259.5 5692.0 5758.9 5811.2 5838.9 5840.6 6260.9 6281.2 6291.2 6306.6 6311.8 6117.4 6164.7 6180.5 6190.2 6191.8 6099.2 6101.0 6102.5 6134.3 6229.3 6193.7 6195.4 6199.3 6216.7 6257.0 6152.4 6216.5 6218.4 6234.0 6243.4 4792.2 4814.2 4816.6 4846.0 4945.4 3352.0 3745.8 4150.9 4283.3 4375.9 5589.8 5599.3 5602.1 5628.8 5673.5 4872.5 6099.2 6181.8 6182.3 6234.9 5754.3 5754.5 5756.4 5756.7 5813.3 5431.0 5432.3 5440.2 5451.1 5451.2 5207.0 6231.4 6264.1 6298.7 6313.5 6216.8 6229.3 6240.6 6242.5 6258.6 6269.0 6329.1 6331.9 6338.8 6349.5 6051.3 6105.7 6116.3 6136.4 6214.3 6030.8 6208.1 6231.5 6239.9 6240.0 6190.5 6199.3 6212.7 6253.8 6263.1 6050.5 6105.1 6121.1 6148.7 6189.2 5760.7 5996.3 6027.3 6041.9 6046.0 6163.7 6165.2 6197.3 6200.7 6203.6 5917.3 5964.6 6000.9 6043.1 6062.5 18:13:40 INFO - PROCESS | 1942 | 18:13:40 INFO - PROCESS | 1942 | [#1] ext.html Cycles:180 Average:63448.83 Median:39301.91 stddev:137294.75 (349.3%) stddev-sans-first:137598.37 18:13:40 INFO - PROCESS | 1942 | Values: 431.4 506.2 521.6 546.2 553.5 31431.0 40465.8 40490.6 40570.8 40602.6 40851.6 41238.4 41247.0 41359.4 41484.0 9601.4 9820.0 9825.2 9831.9 9842.2 9638.2 9761.4 9775.6 9778.8 9809.9 9794.3 9802.0 9829.0 9848.2 9854.3 9778.8 9779.3 9797.5 9801.6 9850.2 9684.7 9769.0 9771.2 9779.1 9794.8 39250.4 39571.8 39615.6 39695.6 39787.4 2581.3 3209.4 3472.1 3614.6 4162.5 29393.5 30284.8 31134.5 31584.2 31953.4 3065.9 3074.1 3087.4 3104.0 3216.4 383541.0 457427.0 459525.0 460872.0 463461.0 33406.5 33531.7 33547.3 33642.5 33686.0 33490.8 34464.1 34598.7 34992.8 35106.8 16534.8 16679.8 16694.0 16718.9 16765.3 12620.6 12691.6 12746.9 12747.9 12777.3 19159.6 19258.7 19323.8 19375.3 19423.3 7910.6 8036.8 8043.8 8045.2 8091.2 858.5 937.4 969.4 1014.6 1067.6 30098.5 30853.2 31556.0 31954.5 31981.7 951.6 1078.4 1080.5 1160.5 1179.5 12455.1 15616.9 15631.3 15708.2 15838.0 377734.0 421820.0 464113.0 470535.0 470629.0 48101.0 55827.4 57135.0 58081.0 58136.0 1277.9 1280.1 1346.7 1347.7 1359.8 25511.0 25769.9 26412.7 29719.6 30541.7 51904.2 52733.0 52787.7 52790.5 52792.7 625021.0 630553.8 632280.0 634003.0 634111.0 26207.5 26463.1 26649.9 26763.0 26766.6 46402.0 47278.1 48007.0 48338.8 48452.8 38059.6 38265.0 39353.4 39381.6 39497.4 38280.8 38524.0 38602.8 39681.0 40053.0 38127.6 38384.6 39461.0 39585.8 40927.7 30921.7 31212.4 35450.6 35533.0 35606.9 22195.3 25645.7 25866.9 26068.5 26410.7 18:13:40 INFO - PROCESS | 1942 | 18:13:40 INFO - PROCESS | 1942 | [#2] jquery.html Cycles:180 Average:35008.09 Median:26604.23 stddev:99121.75 (372.6%) stddev-sans-first:99365.65 18:13:40 INFO - PROCESS | 1942 | Values: 347.9 359.4 373.5 381.9 391.9 19730.1 20026.5 20723.8 20920.8 21061.5 19584.5 19832.4 20620.6 20651.6 20890.5 5337.7 5357.6 5794.9 5925.9 6214.8 6831.4 6886.1 6895.9 6907.6 6910.8 5812.8 6713.6 6753.6 6815.3 6848.7 6585.0 6631.9 6655.5 6739.8 6778.0 5204.8 5630.5 5856.9 5857.6 5929.9 26085.0 26584.9 26623.6 26647.6 26656.9 2231.4 2266.7 2419.1 2436.5 2929.8 15527.8 15669.8 15810.4 15934.0 16051.6 1873.8 1904.9 1905.2 1913.8 1989.6 93012.0 112435.0 116906.0 116918.0 118131.0 10510.8 10578.1 10686.5 10956.6 11110.4 13350.0 13369.6 13369.6 13400.2 13415.5 7081.0 8183.4 8422.6 8566.0 8623.6 7471.0 8424.5 8563.5 8580.0 8747.9 5196.9 5618.5 6185.8 6562.9 6695.4 1764.4 1770.8 1848.9 1872.2 1890.0 811.5 835.5 906.0 941.4 984.6 20829.9 21156.8 22341.9 22366.9 22412.6 935.2 986.8 994.2 994.9 1037.3 11466.7 11823.4 11948.3 11957.0 12241.4 581263.0 586900.0 594328.0 607574.0 609984.0 108346.5 113655.0 117633.0 123657.4 125053.0 953.4 964.4 1001.4 1002.3 1004.2 18962.0 19335.5 19475.3 19600.8 19706.4 54816.9 55804.0 56207.0 57000.7 57457.0 80830.6 80929.6 81496.8 82179.6 83142.8 7060.8 7959.4 8025.2 8255.1 8325.5 8552.8 11434.4 13299.9 13308.5 13797.2 5484.9 11424.9 11450.9 11637.8 11867.8 11056.4 11400.6 11496.1 11703.3 11952.9 11673.4 11675.6 12049.8 12056.0 12076.5 8241.5 8313.3 8450.4 8519.3 8556.8 8647.5 11332.7 11372.9 11652.2 11652.6 18:13:40 INFO - PROCESS | 1942 | 18:13:40 INFO - PROCESS | 1942 | [#3] mootools.html Cycles:180 Average:5682.57 Median:4703.28 stddev:3197.38 (68.0%) stddev-sans-first:3189.98 18:13:40 INFO - PROCESS | 1942 | Values: 1377.5 1499.8 1593.8 1694.2 1868.5 7931.4 8404.8 8623.6 9013.7 9034.2 7419.3 8619.1 8830.9 8840.0 8848.8 2347.5 2389.4 2393.2 2397.1 2407.2 2352.5 2369.7 2400.9 2404.7 2409.5 2353.4 2369.3 2387.7 2402.5 2407.2 2347.9 2361.8 2371.3 2371.9 2381.5 2349.5 2365.8 2376.0 2377.1 2382.2 8885.4 8921.4 8946.6 8952.5 8968.0 4711.2 5224.1 5402.1 5402.2 5411.2 3522.5 3570.7 3573.7 3632.0 3651.7 900.4 1001.4 1474.8 1591.1 1824.9 11415.5 11541.6 11701.4 11735.0 11741.3 4310.1 4577.5 4659.2 4702.7 4703.9 8340.7 8896.2 9236.3 9246.8 9304.1 4489.5 5259.8 5271.8 5278.1 5283.2 4026.4 4422.6 4860.8 4882.4 4927.9 3758.7 3814.2 3852.5 3899.4 3936.5 1160.6 1175.3 1177.4 1183.9 1187.6 803.9 912.9 919.8 935.3 962.2 5736.7 5980.0 6011.9 6158.3 6206.8 434.8 439.6 454.5 458.1 461.1 4050.8 4059.4 4129.8 4174.5 4197.0 8787.8 10779.3 10939.0 10944.5 10946.9 10093.2 10358.5 10877.9 10900.7 10907.3 7629.8 8348.8 8389.8 8401.6 8412.0 5238.5 5561.9 5950.2 5972.2 6200.7 9983.5 10071.2 10086.8 10109.7 10147.7 9797.6 10405.0 10415.7 10455.8 10465.4 5830.0 7037.0 7556.4 7696.3 7849.7 8570.8 8605.5 8628.2 8628.6 8644.9 7303.6 7457.6 7676.0 7694.7 7812.5 7409.4 7455.9 7460.0 7471.7 7712.1 7001.9 7166.1 7180.4 7199.9 7206.0 4468.2 4936.9 5095.2 5133.6 5188.9 4173.9 4499.0 5115.4 5160.9 5164.6 18:13:40 INFO - PROCESS | 1942 | 18:13:40 INFO - PROCESS | 1942 | [#4] prototype.html Cycles:180 Average:4733.05 Median:5285.12 stddev:1472.49 (27.9%) stddev-sans-first:1437.72 18:13:40 INFO - PROCESS | 1942 | Values: 253.6 303.4 308.1 316.1 319.0 4658.1 5141.4 5306.3 5433.6 5501.2 5434.4 5525.8 5541.4 5542.0 5552.2 3634.0 4006.1 4251.9 4252.4 4259.8 3410.1 3870.4 4099.4 4197.2 4259.9 3825.4 4032.2 4155.3 4185.5 4188.4 3689.7 4192.2 4193.0 4194.3 4242.2 3675.7 3696.3 3703.9 3708.7 3709.4 4630.9 5138.9 5352.7 5408.8 5431.9 4111.7 4838.7 4839.8 4849.7 4878.3 5385.8 5555.3 5818.9 5837.6 5904.8 3542.6 3983.9 3998.2 4042.9 4044.8 5837.9 5994.0 6181.2 6212.5 6267.2 3657.8 4100.9 4105.5 4106.7 4115.0 3381.6 3850.0 3914.5 4119.7 4124.7 4270.6 4783.8 4846.4 4859.9 4870.3 5057.9 5827.8 5892.6 5922.1 5927.6 1328.8 1336.7 1397.5 1418.5 1421.2 938.4 955.5 968.7 970.6 976.2 4671.4 5236.4 5341.6 5369.4 5388.8 5102.9 5222.7 5727.7 5884.4 5948.8 4559.8 5102.8 5372.6 5414.7 5455.7 2827.4 3106.2 3154.3 3178.5 3204.9 5052.0 5819.2 6287.8 6312.7 6318.4 5877.7 5908.7 6232.3 6272.4 6282.5 6294.0 6367.4 6378.6 6385.9 6478.9 5839.2 6024.7 6048.9 6074.4 6084.0 5035.5 5065.0 5735.8 5964.8 5991.3 5068.5 6128.2 6209.9 6377.3 6381.2 3440.9 3907.6 3932.0 3973.8 3989.3 5222.5 6099.7 6100.2 6107.4 6168.7 5104.0 5864.8 5873.3 5890.7 5892.4 5255.9 5268.7 5881.6 5882.9 5940.7 5237.4 5301.6 5623.9 5701.3 5789.4 4867.1 5535.3 5864.3 5885.4 5890.2 5495.3 5719.6 5772.9 5794.7 5799.0 18:13:40 INFO - PROCESS | 1942 | 18:13:40 INFO - PROCESS | 1942 | [#5] yui.html Cycles:180 Average:24693.89 Median:3624.90 stddev:39696.13 (1095.1%) stddev-sans-first:39766.54 18:13:40 INFO - PROCESS | 1942 | Values: 680.5 701.5 712.5 756.0 849.7 15082.6 15502.5 15831.1 15856.3 15867.4 14361.4 14451.3 14556.2 14589.1 14591.1 694.8 848.0 873.4 874.3 875.0 834.1 858.1 870.9 871.4 872.7 871.0 885.9 897.9 919.9 923.0 868.2 909.3 914.9 915.4 918.9 672.6 673.9 680.6 683.3 684.9 15001.6 15024.2 15040.0 15043.8 15069.6 14477.0 14670.0 14698.0 14794.3 15084.0 11930.8 12234.9 12456.8 12475.4 12489.6 3853.3 3854.7 4050.7 4084.3 4092.2 119278.8 119509.4 119695.0 123054.0 125385.1 11227.9 11259.5 11350.4 11412.4 11763.0 20212.2 21863.3 23003.5 23050.9 23197.4 8185.1 8218.8 8261.0 8268.2 8302.1 3860.8 4515.8 4568.2 4728.2 4789.0 3572.9 3676.9 3694.9 3695.7 3695.9 643.9 652.3 664.7 664.8 672.2 492.0 546.3 630.2 632.7 654.7 7213.7 9520.7 9551.2 9601.2 9668.0 567.6 575.3 609.7 617.5 666.8 3870.5 4600.6 4723.8 4742.6 4744.2 121031.0 156614.2 160112.1 163467.0 166436.0 132378.0 133475.7 134709.0 134867.0 138923.3 69156.0 70021.6 70924.0 82162.6 115259.0 9747.7 10004.1 10162.1 10181.4 10301.7 54497.0 58748.0 61594.0 62383.7 63235.7 77319.1 89966.0 90013.0 90172.1 92182.0 12896.3 13291.7 13333.1 13577.3 13772.3 14900.4 15063.0 15085.4 15093.4 15133.5 13790.7 13949.6 13971.2 13998.2 14381.3 14062.0 14071.9 14086.2 14483.7 14500.2 13269.7 13433.3 13447.4 13466.1 14241.3 10757.5 10819.1 11091.9 11279.8 11406.5 11329.5 11373.9 11583.0 11683.6 11701.2 18:13:40 INFO - PROCESS | 1942 | -------- Summary: end -------- 18:13:40 INFO - PROCESS | 1942 | 18:13:40 INFO - TEST-INFO | 1942: exit 0 18:13:40 INFO - TEST-OK | dromaeo_css | took 1113802ms 18:13:40 INFO - TEST-START | kraken 18:13:40 INFO - operating with platform_type : mac_ 18:13:40 INFO - Initialising browser for kraken test... 18:13:40 INFO - TEST-INFO | started process 1946 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpGeXiAW/profile http://localhost:56102/getInfo.html) 18:13:43 INFO - PROCESS | 1946 | __metrics Screen width/height:1600/1200 18:13:43 INFO - PROCESS | 1946 | colorDepth:24 18:13:43 INFO - PROCESS | 1946 | Browser inner width/height: 1024/689 18:13:43 INFO - PROCESS | 1946 | __metrics 18:13:43 ERROR - PROCESS | 1946 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 18:13:44 INFO - TEST-INFO | 1946: exit 0 18:13:44 INFO - Browser initialized. 18:13:44 INFO - Running cycle 1/1 for kraken test... 18:13:44 INFO - TEST-INFO | started process 1948 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpGeXiAW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:13:56 INFO - PROCESS | 1948 | RSS: Main: 254648320 18:13:56 INFO - PROCESS | 1948 | 18:13:59 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56102/tests/kraken/driver.html?testName=audio-beat-detection) 18:14:00 INFO - PROCESS | 1948 | RSS: Main: 267436032 18:14:00 INFO - PROCESS | 1948 | 18:14:03 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56102/tests/kraken/driver.html?testName=audio-dft) 18:14:03 INFO - PROCESS | 1948 | RSS: Main: 276086784 18:14:03 INFO - PROCESS | 1948 | 18:14:07 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56102/tests/kraken/driver.html?testName=audio-fft) 18:14:08 INFO - PROCESS | 1948 | RSS: Main: 279138304 18:14:08 INFO - PROCESS | 1948 | 18:14:10 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56102/tests/kraken/driver.html?testName=audio-oscillator) 18:14:10 INFO - PROCESS | 1948 | RSS: Main: 280436736 18:14:10 INFO - PROCESS | 1948 | 18:14:12 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56102/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:14:13 INFO - PROCESS | 1948 | RSS: Main: 282066944 18:14:13 INFO - PROCESS | 1948 | 18:14:16 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56102/tests/kraken/driver.html?testName=imaging-darkroom) 18:14:17 INFO - PROCESS | 1948 | RSS: Main: 282087424 18:14:17 INFO - PROCESS | 1948 | 18:14:20 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56102/tests/kraken/driver.html?testName=imaging-desaturate) 18:14:21 INFO - PROCESS | 1948 | RSS: Main: 282382336 18:14:21 INFO - PROCESS | 1948 | 18:14:23 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56102/tests/kraken/driver.html?testName=json-parse-financial) 18:14:24 INFO - PROCESS | 1948 | RSS: Main: 282427392 18:14:24 INFO - PROCESS | 1948 | 18:14:26 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56102/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:14:26 INFO - PROCESS | 1948 | RSS: Main: 282214400 18:14:26 INFO - PROCESS | 1948 | 18:14:28 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56102/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:14:29 INFO - PROCESS | 1948 | RSS: Main: 282263552 18:14:29 INFO - PROCESS | 1948 | 18:14:31 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56102/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:14:32 INFO - PROCESS | 1948 | RSS: Main: 282697728 18:14:32 INFO - PROCESS | 1948 | 18:14:35 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56102/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:14:36 INFO - PROCESS | 1948 | RSS: Main: 282824704 18:14:36 INFO - PROCESS | 1948 | 18:14:39 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56102/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:14:39 INFO - PROCESS | 1948 | RSS: Main: 282886144 18:14:39 INFO - PROCESS | 1948 | 18:14:41 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56102/tests/kraken/driver.html?testName=ai-astar) 18:14:42 INFO - PROCESS | 1948 | RSS: Main: 285143040 18:14:42 INFO - PROCESS | 1948 | 18:14:42 INFO - PROCESS | 1948 | __start_tp_report 18:14:42 INFO - PROCESS | 1948 | _x_x_mozilla_page_load 18:14:42 INFO - PROCESS | 1948 | _x_x_mozilla_page_load_details 18:14:42 INFO - PROCESS | 1948 | |i|pagename|runs| 18:14:42 INFO - PROCESS | 1948 | |0;ai-astar;107;117;108;120;119;97;164;168;97;173 18:14:42 INFO - PROCESS | 1948 | |1;audio-beat-detection;152;105;134;159;111;134;131;110;160;111 18:14:42 INFO - PROCESS | 1948 | |2;audio-dft;205;225;208;203;200;239;284;233;191;198 18:14:42 INFO - PROCESS | 1948 | |3;audio-fft;69;81;76;147;58;72;75;89;139;61 18:14:42 INFO - PROCESS | 1948 | |4;audio-oscillator;69;73;124;74;71;92;146;102;101;119 18:14:42 INFO - PROCESS | 1948 | |5;imaging-gaussian-blur;94;118;90;98;116;88;107;84;135;131 18:14:42 INFO - PROCESS | 1948 | |6;imaging-darkroom;150;114;130;153;146;98;113;118;96;97 18:14:42 INFO - PROCESS | 1948 | |7;imaging-desaturate;92;94;98;91;95;90;93;96;92;92 18:14:42 INFO - PROCESS | 1948 | |8;json-parse-financial;57;58;57;55;57;60;55;58;57;57 18:14:42 INFO - PROCESS | 1948 | |9;json-stringify-tinderbox;71;72;69;74;117;67;102;95;110;107 18:14:42 INFO - PROCESS | 1948 | |10;stanford-crypto-aes;91;86;90;88;90;91;92;105;105;118 18:14:42 INFO - PROCESS | 1948 | |11;stanford-crypto-ccm;146;145;143;128;138;157;160;171;155;164 18:14:42 INFO - PROCESS | 1948 | |12;stanford-crypto-pbkdf2;192;190;184;184;184;181;185;211;257;205 18:14:42 INFO - PROCESS | 1948 | |13;stanford-crypto-sha256-iterative;71;70;75;86;86;86;78;71;70;70 18:14:42 INFO - PROCESS | 1948 | __end_tp_report 18:14:42 INFO - PROCESS | 1948 | __start_cc_report 18:14:42 INFO - PROCESS | 1948 | _x_x_mozilla_cycle_collect,1050 18:14:42 INFO - PROCESS | 1948 | __end_cc_report 18:14:42 INFO - PROCESS | 1948 | __startTimestamp1471050882032__endTimestamp 18:14:42 INFO - PROCESS | 1948 | 18:14:42 INFO - PROCESS | 1948 | ------- Summary: start ------- 18:14:42 INFO - PROCESS | 1948 | Number of tests: 14 18:14:42 INFO - PROCESS | 1948 | 18:14:42 INFO - PROCESS | 1948 | [#0] ai-astar Cycles:10 Average:127.00 Median:166.00 stddev:29.70 (17.9%) stddev-sans-first:30.61 18:14:42 INFO - PROCESS | 1948 | Values: 107.0 117.0 108.0 120.0 119.0 97.0 164.0 168.0 97.0 173.0 18:14:42 INFO - PROCESS | 1948 | 18:14:42 INFO - PROCESS | 1948 | [#1] audio-beat-detection Cycles:10 Average:130.70 Median:134.00 stddev:21.08 (15.7%) stddev-sans-first:20.90 18:14:42 INFO - PROCESS | 1948 | Values: 152.0 105.0 134.0 159.0 111.0 134.0 131.0 110.0 160.0 111.0 18:14:42 INFO - PROCESS | 1948 | 18:14:42 INFO - PROCESS | 1948 | [#2] audio-dft Cycles:10 Average:218.60 Median:216.50 stddev:27.92 (12.9%) stddev-sans-first:29.17 18:14:42 INFO - PROCESS | 1948 | Values: 205.0 225.0 208.0 203.0 200.0 239.0 284.0 233.0 191.0 198.0 18:14:42 INFO - PROCESS | 1948 | 18:14:42 INFO - PROCESS | 1948 | [#3] audio-fft Cycles:10 Average:86.70 Median:73.50 stddev:31.04 (42.2%) stddev-sans-first:32.26 18:14:42 INFO - PROCESS | 1948 | Values: 69.0 81.0 76.0 147.0 58.0 72.0 75.0 89.0 139.0 61.0 18:14:42 INFO - PROCESS | 1948 | 18:14:42 INFO - PROCESS | 1948 | [#4] audio-oscillator Cycles:10 Average:97.10 Median:70.00 stddev:26.34 (37.6%) stddev-sans-first:25.90 18:14:42 INFO - PROCESS | 1948 | Values: 69.0 73.0 124.0 74.0 71.0 92.0 146.0 102.0 101.0 119.0 18:14:42 INFO - PROCESS | 1948 | 18:14:42 INFO - PROCESS | 1948 | [#5] imaging-gaussian-blur Cycles:10 Average:106.10 Median:86.00 stddev:18.21 (21.2%) stddev-sans-first:18.78 18:14:42 INFO - PROCESS | 1948 | Values: 94.0 118.0 90.0 98.0 116.0 88.0 107.0 84.0 135.0 131.0 18:14:42 INFO - PROCESS | 1948 | 18:14:42 INFO - PROCESS | 1948 | [#6] imaging-darkroom Cycles:10 Average:121.50 Median:151.50 stddev:22.16 (14.6%) stddev-sans-first:20.97 18:14:42 INFO - PROCESS | 1948 | Values: 150.0 114.0 130.0 153.0 146.0 98.0 113.0 118.0 96.0 97.0 18:14:42 INFO - PROCESS | 1948 | 18:14:42 INFO - PROCESS | 1948 | [#7] imaging-desaturate Cycles:10 Average:93.30 Median:93.50 stddev:2.45 (2.6%) stddev-sans-first:2.55 18:14:42 INFO - PROCESS | 1948 | Values: 92.0 94.0 98.0 91.0 95.0 90.0 93.0 96.0 92.0 92.0 18:14:42 INFO - PROCESS | 1948 | 18:14:42 INFO - PROCESS | 1948 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.00 stddev:1.45 (2.5%) stddev-sans-first:1.54 18:14:42 INFO - PROCESS | 1948 | Values: 57.0 58.0 57.0 55.0 57.0 60.0 55.0 58.0 57.0 57.0 18:14:42 INFO - PROCESS | 1948 | 18:14:42 INFO - PROCESS | 1948 | [#9] json-stringify-tinderbox Cycles:10 Average:88.40 Median:70.00 stddev:19.64 (28.1%) stddev-sans-first:19.80 18:14:42 INFO - PROCESS | 1948 | Values: 71.0 72.0 69.0 74.0 117.0 67.0 102.0 95.0 110.0 107.0 18:14:42 INFO - PROCESS | 1948 | 18:14:42 INFO - PROCESS | 1948 | [#10] stanford-crypto-aes Cycles:10 Average:95.60 Median:90.00 stddev:10.25 (11.4%) stddev-sans-first:10.74 18:14:42 INFO - PROCESS | 1948 | Values: 91.0 86.0 90.0 88.0 90.0 91.0 92.0 105.0 105.0 118.0 18:14:42 INFO - PROCESS | 1948 | 18:14:42 INFO - PROCESS | 1948 | [#11] stanford-crypto-ccm Cycles:10 Average:150.70 Median:156.00 stddev:13.01 (8.3%) stddev-sans-first:13.69 18:14:42 INFO - PROCESS | 1948 | Values: 146.0 145.0 143.0 128.0 138.0 157.0 160.0 171.0 155.0 164.0 18:14:42 INFO - PROCESS | 1948 | 18:14:42 INFO - PROCESS | 1948 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.30 Median:191.00 stddev:23.19 (12.1%) stddev-sans-first:24.52 18:14:42 INFO - PROCESS | 1948 | Values: 192.0 190.0 184.0 184.0 184.0 181.0 185.0 211.0 257.0 205.0 18:14:42 INFO - PROCESS | 1948 | 18:14:42 INFO - PROCESS | 1948 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.30 Median:76.50 stddev:7.17 (9.4%) stddev-sans-first:7.34 18:14:42 INFO - PROCESS | 1948 | Values: 71.0 70.0 75.0 86.0 86.0 86.0 78.0 71.0 70.0 70.0 18:14:42 INFO - PROCESS | 1948 | -------- Summary: end -------- 18:14:42 INFO - PROCESS | 1948 | 18:14:42 INFO - TEST-INFO | 1948: exit 0 18:14:42 INFO - TEST-OK | kraken | took 61994ms 18:14:42 INFO - SUITE-END | took 1175s 18:14:43 INFO - Completed test suite (00:19:36) 18:14:43 INFO - javascript benchmark 18:14:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7388.9007521094145, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3349.5645566076423, 3353.6311005789357, 3379.459286514158, 3388.576427946506, 3394.1853955050797, 5638.40796716345, 5658.632188907718, 5725.9999999999945, 5776.65340079595, 5794.333651630064, 5653.943460565393, 5670.0, 5716.657000579958, 5733.655980641154, 5757.510611598009, 5105.897882042366, 5216.843494695147, 5226.503482169207, 5280.551153151987, 5304.098303288451, 4423.491298500681, 5304.575633949294, 5347.171188465794, 5373.140297552392, 5420.756065977041, 5147.305113809625, 5201.505856943584, 5210.713410762407, 5259.815906443256, 5266.973665131669, 5272.604554658377, 5272.762725677354, 5296.682199068068, 5298.735063246861, 5311.787528498855, 4915.410150781893, 5221.6083793715625, 5251.55361794248, 5283.128283833163, 5299.364076310829, 4215.957840421618, 5639.915401268984, 5698.943010569883, 5736.196932429463, 5760.2223699800825, 5705.4579814917515, 6202.596831205957, 6247.219097612799, 6249.437550620421, 6267.7179526920945, 6189.089419604267, 6246.500279977591, 6249.125122482856, 6253.906191407133, 6259.467945224661, 5692.0, 5758.942410575883, 5811.244538210006, 5838.941610583882, 5840.561957853178, 6260.874782504325, 6281.2462504498835, 6291.245050593958, 6306.590071645328, 6311.779087731908, 6117.449429551273, 6164.6917654117115, 6180.505559555225, 6190.226221722285, 6191.752329906843, 6099.218990344071, 6101.005087479836, 6102.458955353584, 6134.252905685651, 6229.283632382243, 6193.721282542297, 6195.411435913581, 6199.256089269226, 6216.658083805434, 6257.0, 6152.3540028297275, 6216.533759968021, 6218.409251121137, 6234.0, 6243.375662433811, 4792.161371759928, 4814.229723244264, 4816.614670826326, 4846.006568653417, 4945.381827271591, 3351.9832400838327, 3745.8127093645207, 4150.91698166041, 4283.250431174594, 4375.912481750347, 5589.832305030855, 5599.272094627754, 5602.134527176236, 5628.802991895264, 5673.489385955284, 4872.4640289568115, 6099.176611157437, 6181.752729890754, 6182.319944806068, 6234.937650623527, 5754.338251101177, 5754.4533269339345, 5756.366799652035, 5756.7121643917635, 5813.302403711582, 5430.972845135749, 5432.348118225838, 5440.156775699773, 5451.1005684062475, 5451.155070964007, 5207.0366982108435, 6231.40801623845, 6264.060390941395, 6298.748050077946, 6313.463355614732, 6216.751329946752, 6229.345918678474, 6240.563160578716, 6242.53181011435, 6258.561900666909, 6268.9969604863, 6329.050642403677, 6331.9050214247745, 6338.778142764981, 6349.460295874717, 6051.3041000283765, 6105.732692890381, 6116.305337585956, 6136.417040381157, 6214.25428948529, 6030.849228769316, 6208.130861679459, 6231.470325022243, 6239.906401404073, 6239.96880015597, 6190.50475961913, 6199.3490683477585, 6212.720427580679, 6253.812385628438, 6263.123162757127, 6050.546209034252, 6105.126180223362, 6121.081837724377, 6148.661823599745, 6189.164462797465, 5760.683162426107, 5996.280446346466, 6027.276726792637, 6041.879162416639, 6045.969770151297, 6163.691815409301, 6165.198524191826, 6197.318294987457, 6200.720967556561, 6203.565750397429, 5917.260342457193, 5964.612300200473, 6000.8799824004145, 6043.093535969464, 6062.514998800174], "value": 5666.56570695312, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.4175862585508, 506.19514971195804, 521.5749164430988, 546.1916363781605, 553.5101435229822, 31431.0, 40465.797671011605, 40490.59509404909, 40570.7971460143, 40602.59397406025, 40851.57019504318, 41238.38142427859, 41247.0, 41359.379609305885, 41484.0, 9601.375910565826, 9820.0, 9825.213982881352, 9831.852522212173, 9842.212622990144, 9638.228941684649, 9761.414315141114, 9775.56009979549, 9778.7776527934, 9809.901900981005, 9794.265430092735, 9801.950990245039, 9828.95085524575, 9848.21214302854, 9854.310198286086, 9778.804423911517, 9779.266555008402, 9797.481390384502, 9801.607935682565, 9850.162736167435, 9684.70945871625, 9768.95115524425, 9771.169450596708, 9779.070988256104, 9794.804103917953, 39250.41124383137, 39571.80214098911, 39615.60384396148, 39695.60304396977, 39787.40318895219, 2581.3417578517547, 3209.3741720364537, 3472.1146107742616, 3614.602393736713, 4162.500499940026, 29393.540045254624, 30284.788608455634, 31134.532982005287, 31584.210394740086, 31953.360932781216, 3065.908022759321, 3074.062410964655, 3087.428825667236, 3103.9844800776077, 3216.388886111631, 383541.0, 457427.0, 459525.0, 460872.0, 463461.0, 33406.49890251648, 33531.664683353345, 33547.3290534188, 33642.49536256958, 33686.0, 33490.83254583712, 34464.138396540286, 34598.654013460044, 34992.82503587466, 35106.82446587802, 16534.83465165333, 16679.833201668072, 16694.0, 16718.91640541814, 16765.32938682439, 12620.55828046014, 12691.619251422471, 12746.872531274754, 12747.936260318638, 12777.297248651414, 19159.61680766377, 19258.71111933322, 19323.806761932483, 19375.321863734982, 19423.3201837935, 7910.644021019068, 8036.758897233092, 8043.839123217503, 8045.235702608243, 8091.231333023354, 858.4591707224408, 937.3672770879629, 969.3844408800462, 1014.5941623350571, 1067.5996501312009, 30098.54852177219, 30853.228669283, 31556.0, 31954.520682189785, 31981.680183198336, 951.6241084771476, 1078.3907092492716, 1080.475969154959, 1160.5357856857324, 1179.510503141204, 12455.065870059781, 15616.92191539035, 15631.296591653403, 15708.21458927072, 15838.049717016786, 377734.0, 421820.0, 464113.0, 470535.0, 470629.0, 48101.03797924022, 55827.441725583034, 57135.0, 58081.0, 58136.0, 1277.9488820447077, 1280.103927250928, 1346.7239215960703, 1347.696768227141, 1359.8436179839248, 25511.0, 25769.871150644125, 26412.735872641795, 29719.55420668735, 30541.694583054774, 51904.22143667923, 52733.0, 52787.73606131945, 52790.47209528009, 52792.68018299573, 625021.0, 630553.847230761, 632280.0, 634003.0, 634111.0, 26207.4758504825, 26463.073792417945, 26649.866750666122, 26763.0, 26766.598501022112, 46402.0, 47278.05443891172, 48007.0, 48338.75830620824, 48452.7577362111, 38059.619403805606, 38265.0, 39353.40969885397, 39381.606183937794, 39497.40753888751, 38280.80859595684, 38524.0, 38602.80698596489, 39681.0, 40052.998675033356, 38127.618723812404, 38384.616153838106, 39461.0, 39585.80207098946, 40927.72578193797, 30921.690783091883, 31212.375752485277, 35450.64549354473, 35533.0, 35606.93179204628, 22195.33413997583, 25645.743542564334, 25866.87066564655, 26068.478630426907, 26410.735892640827], "value": 19184.178092598173, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.8973702757687, 359.4285086712129, 373.454756056158, 381.87207285559373, 391.94512768212456, 19730.112144953477, 20026.49933751657, 20723.792762072393, 20920.790792092073, 21061.473463163427, 19584.510387240327, 19832.40502784919, 20620.587588248225, 20651.586968260624, 20890.477738056557, 5337.653052551572, 5357.571394288467, 5794.884102317972, 5925.903707814046, 6214.751409943619, 6831.351021652935, 6886.070380498643, 6895.862082758367, 6907.620080895549, 6910.792676219721, 5812.767489300444, 6713.56361836479, 6753.5947843129325, 6815.318468153195, 6848.657567121649, 6584.967075164617, 6631.867362652768, 6655.534112612119, 6739.797806065851, 6778.017187507809, 5204.828913494472, 5630.465105814941, 5856.912146317766, 5857.648541087548, 5929.851753706149, 26085.0, 26584.867075664497, 26623.600645990326, 26647.600285995726, 26656.866715666296, 2231.4309850988056, 2266.6826644269813, 2419.0928401849305, 2436.549238390903, 2929.824210547374, 15527.767083493756, 15669.843301566953, 15810.446634367858, 15934.043957362595, 16051.598710032225, 1873.8313551780268, 1904.9428517144509, 1905.1902941249914, 1913.808619138089, 1989.6120256549978, 93011.99999999932, 112435.0, 116906.0, 116918.0, 118131.0, 10510.842337364946, 10578.100861426865, 10686.465676716132, 10956.616518421817, 11110.388928608843, 13350.0, 13369.598912032654, 13369.598912032654, 13400.195988240543, 13415.463381464631, 7080.964322069647, 8183.386246031571, 8422.6209820557, 8566.014908285502, 8623.568821558896, 7470.962645186848, 8424.53665048416, 8563.486190828571, 8579.957100214458, 8747.868781968149, 5196.856691527858, 5618.52242559387, 6185.762847430532, 6562.934370656328, 6695.397414232742, 1764.3912850066706, 1770.8406243438153, 1848.9075546222634, 1872.157529111878, 1889.9716504252447, 811.5009269299338, 835.5321020228691, 905.968291109808, 941.449252187478, 984.6406061787396, 20829.89585052065, 21156.78843211579, 22341.888290558443, 22366.88165591714, 22412.55174896493, 935.2284365398573, 986.7977064701719, 994.1996692662332, 994.8608842875012, 1037.3412882819464, 11466.713332166595, 11823.408829558488, 11948.34284114382, 11957.0, 12241.449134788956, 581263.0, 586900.0, 594328.0, 607574.0, 609984.0, 108346.45826770816, 113655.0, 117633.0, 123657.38171309086, 125053.0, 953.4374718915734, 964.4020707161604, 1001.3741411617739, 1002.333448256901, 1004.1514919892679, 18962.0, 19335.516612084248, 19475.318363857765, 19600.803991960467, 19706.408807735792, 54816.90366192574, 55804.0, 56207.0, 57000.71499642475, 57457.0, 80830.59584702273, 80929.59535202286, 81496.77754833564, 82179.5891020541, 83142.75285870596, 7060.823479413056, 7959.363250940027, 8025.23760242776, 8255.050669173123, 8325.458845175286, 8552.786180345292, 11434.37110958872, 13299.933500332436, 13308.534201302908, 13797.24115173675, 5484.945150548443, 11424.885751142714, 11450.885491144982, 11637.76724465523, 11867.821982670093, 11056.447177641247, 11400.600978965696, 11496.080313574726, 11703.307585660325, 11952.880471195176, 11673.416329183678, 11675.649730508097, 12049.75900481968, 12056.0, 12076.45655945467, 8241.546714930737, 8313.293370063613, 8450.408471406943, 8519.3184545235, 8556.828863422821, 8647.524386158822, 11332.716682083013, 11372.886271137182, 11652.242604230698, 11652.592159274385], "value": 9882.937242190032, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1377.545410014695, 1499.8425165357637, 1593.76093585962, 1694.2121913310316, 1868.4581471373303, 7931.405144614163, 8404.789880252989, 8623.568821558913, 9013.72958811236, 9034.232090272335, 7419.258074192578, 8619.094995025525, 8830.86753698695, 8840.0, 8848.823023539526, 2347.4718188407555, 2389.4384819567476, 2393.246127469841, 2397.1130681647815, 2407.229686500312, 2352.494213744045, 2369.6682464454902, 2400.9159679411223, 2404.675368825204, 2409.518096380722, 2353.4351755578623, 2369.3484291819714, 2387.7134743830766, 2402.5074859653814, 2407.1935901473025, 2347.8826058696995, 2361.799247063993, 2371.253055287596, 2371.881405929705, 2381.523695260946, 2349.5300939812105, 2365.7870791628834, 2376.0, 2377.108584280895, 2382.213869423086, 8885.378023538355, 8921.375503714742, 8946.55267236642, 8952.462852228888, 8968.0, 4711.199096153662, 5224.059669259532, 5402.054640437907, 5402.243685883979, 5411.242426060316, 3522.4540196269363, 3570.7143428525656, 3573.714102871764, 3631.9818400907825, 3651.653092956165, 900.4237288135598, 1001.3991605036992, 1474.8230212374476, 1591.1487354265528, 1824.8813827101328, 11415.48630311638, 11541.596044138414, 11701.3564253966, 11735.0, 11741.295522268605, 4310.073334233155, 4577.5193604671695, 4659.184642687516, 4702.670813043054, 4703.882402939886, 8340.7071903855, 8896.243819275434, 9236.261099112055, 9246.815063698688, 9304.116108969638, 4489.506154323022, 5259.8422047338645, 5271.78912843482, 5278.076336641073, 5283.2075188722, 4026.416169655384, 4422.601965823092, 4860.781264843091, 4882.414110306786, 4927.891224474464, 3758.661720445173, 3814.1799513104816, 3852.5184351956004, 3899.3760998240714, 3936.4685767421606, 1160.570588882119, 1175.3006960858277, 1177.3877583656451, 1183.946722397477, 1187.554666999875, 803.8954935858418, 912.9497877616794, 919.7792529792802, 935.3452583191793, 962.1542723522228, 5736.6558006519745, 5980.0431930890845, 6011.879762404727, 6158.322584515699, 6206.782762603287, 434.79130017591734, 439.5692221622764, 454.538643277074, 458.0701176611484, 461.1422753678156, 4050.8177132029127, 4059.3707975263883, 4129.772862492532, 4174.540800511942, 4196.958030419718, 8787.813645157821, 10779.299345542515, 10939.0, 10944.507497162647, 10946.890531094747, 10093.192544596415, 10358.482075896174, 10877.945610271898, 10900.672979810459, 10907.291026083438, 7629.771106866803, 8348.833023339621, 8389.832203355776, 8401.621927013299, 8411.957940210383, 5238.5023422774775, 5561.916571251515, 5950.16697662319, 5972.163897054329, 6200.689965501617, 9983.500824958577, 10071.244656650633, 10086.8486972694, 10109.696709098738, 10147.746306342106, 9797.559109840216, 10405.0, 10415.739606509898, 10455.790884182426, 10465.424401657981, 5829.970850145722, 7037.0, 7556.357709594746, 7696.307332339892, 7849.686012559434, 8570.828583428172, 8605.483670979762, 8628.180322869317, 8628.611712473079, 8644.870326944974, 7303.634818259172, 7457.6271186441545, 7676.040494938133, 7694.653740581575, 7812.492188007761, 7409.37020353276, 7455.850882982419, 7460.0, 7471.701131954661, 7712.113106992768, 7001.859962800817, 7166.140063192451, 7180.3537681608905, 7199.892001619875, 7206.0, 4468.195724769443, 4936.851894443173, 5095.235714642833, 5133.589312855037, 5188.896222075462, 4173.937390939199, 4498.977505112453, 5115.411727651368, 5160.870978225425, 5164.612654051037], "value": 4510.41361651664, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [253.59298326186482, 303.40078345268114, 308.1295340662628, 316.14325178765546, 319.0, 4658.138244424784, 5141.434442211354, 5306.310179676637, 5433.641589602599, 5501.184609079004, 5434.429384914586, 5525.772783820381, 5541.362743284523, 5542.002439560877, 5552.194931734896, 3634.0, 4006.1186538961456, 4251.8511852085185, 4252.425922500469, 4259.76571288579, 3410.0963244740165, 3870.3807390817474, 4099.44657471242, 4197.244495990721, 4259.914801703964, 3825.368814145663, 4032.2338755636333, 4155.33514637658, 4185.518665353477, 4188.4136220929095, 3689.6679298862964, 4192.182524407742, 4192.958070419302, 4194.266003449415, 4242.151569686044, 3675.650813172771, 3696.3346597612417, 3703.9074023149637, 3708.684761795251, 3709.406494960793, 4630.86107416778, 5138.890956087734, 5352.705601191933, 5408.809432179974, 5431.918521222185, 4111.71218014739, 4838.661293709407, 4839.782209800567, 4849.733264670442, 4878.341423907763, 5385.8114965976, 5555.2778138841695, 5818.912716309259, 5837.620554663933, 5904.793332233351, 3542.557180352456, 3983.920321593581, 3998.200809635676, 4042.9393559096343, 4044.797760111983, 5837.8691777501335, 5994.040953447471, 6181.2493440419485, 6212.502999760053, 6267.2165979252595, 3657.817109144532, 4100.897477563085, 4105.507339119265, 4106.733062350938, 4115.0, 3381.5773028371455, 3849.9525916560915, 3914.5106861642294, 4119.670426365884, 4124.6906482013965, 4270.636995855387, 4783.784729687172, 4846.400687773026, 4859.938238909535, 4870.342503762017, 5057.949420505822, 5827.79602713903, 5892.552856578864, 5922.111683247461, 5927.555433342516, 1328.794036924259, 1336.7059246965653, 1397.5457976157788, 1418.4680744720729, 1421.1666949635062, 938.3759799733101, 955.4983633592419, 968.7239136846106, 970.5923512124924, 976.2336565795816, 4671.392718946515, 5236.434147267812, 5341.599380046512, 5369.3556773187465, 5388.757505912244, 5102.897942041212, 5222.738863056832, 5727.6849773262875, 5884.440978107073, 5948.76921154567, 4559.840405585788, 5102.846914592568, 5372.570194384518, 5414.702191379433, 5455.699936503451, 2827.4203788223363, 3106.2294492139263, 3154.3060526684094, 3178.507331363596, 3204.919877003047, 5051.974740126349, 5819.185314055951, 6287.7799277026, 6312.652804095727, 6318.4313411793155, 5877.67752255739, 5908.704564771744, 6232.3144454110015, 6272.435480806749, 6282.465990390868, 6293.96853015732, 6367.426931576088, 6378.553501254961, 6385.872282554323, 6478.890132736219, 5839.240898683144, 6024.668643224665, 6048.939510605013, 6074.362191969956, 6084.0, 5035.4712755161645, 5064.974675126601, 5735.799247026334, 5964.7912323068485, 5991.281046274475, 5068.543831055223, 6128.161551534611, 6209.937900620936, 6377.298497165215, 6381.245157581702, 3440.9311813763084, 3907.648311651965, 3931.960680393274, 3973.774686175751, 3989.341758609913, 5222.537689446809, 6099.664518451527, 6100.23747031621, 6107.4197951194565, 6168.717574497465, 5104.030234255628, 5864.765409383747, 5873.295204575478, 5890.734916928663, 5892.440218179266, 5255.868603284948, 5268.6575372600655, 5881.617694849821, 5882.911756323573, 5940.702964851654, 5237.397699264633, 5301.575873929999, 5623.8594035149445, 5701.287339082614, 5789.421057894346, 4867.050925069578, 5535.335759708861, 5864.296284445723, 5885.411458854081, 5890.175375447355, 5495.340559132929, 5719.626355062769, 5772.913406298993, 5794.652320860761, 5798.971005144947], "value": 4261.5447290112215, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [680.5270337115707, 701.4844089594151, 712.4941291682904, 755.9697612095513, 849.7238397520804, 15082.62293442663, 15502.5349239523, 15831.05013699176, 15856.28646710898, 15867.444639437623, 14361.35373908174, 14451.277436128177, 14556.199409032526, 14589.124652520855, 14591.124532528029, 694.7880896326618, 847.9533625650587, 873.4017198219209, 874.3267683883406, 875.0461996423896, 834.0741776627938, 858.1332853817657, 870.8519551676198, 871.4466313890694, 872.6640243506232, 870.9940019277744, 885.8759773631697, 897.9102089791002, 919.9264058875308, 923.0354279777648, 868.1708967935638, 909.3498148823556, 914.8993610702818, 915.446155076176, 918.8943271523793, 672.5863593889771, 673.9090222819955, 680.5678394219657, 683.255251775567, 684.8972654101875, 15001.624959376102, 15024.17367044812, 15040.0, 15043.774343384857, 15069.623259418493, 14477.0, 14670.046446980912, 14698.0, 14794.260286985607, 15084.019538729948, 11930.821037684442, 12234.938825305906, 12456.81314780279, 12475.438605262785, 12489.642710964263, 3853.3064048471265, 3854.7494412863075, 4050.736702114353, 4084.2852500812237, 4092.242935057024, 119278.80721192763, 119509.40245298806, 119695.0, 123054.0, 125385.11922321173, 11227.887721122685, 11259.493322800494, 11350.375729334966, 11412.42937853104, 11763.0, 20212.19151233934, 21863.344099677037, 23003.53992920132, 23050.884745576164, 23197.42006449852, 8185.140560241208, 8218.794530136794, 8260.958695206486, 8268.214519620626, 8302.086770455246, 3860.8455661773214, 4515.774211289422, 4568.17772800899, 4728.243481043017, 4788.970371370103, 3572.91067723309, 3676.889693309205, 3694.891532540281, 3695.7412981091065, 3695.8706445274825, 643.9452646525098, 652.3118110393485, 664.7473959895209, 664.7772996046282, 672.226939020121, 491.96327205369795, 546.2652732075352, 630.1933525087895, 632.7310892870512, 654.6726636681659, 7213.711451541984, 9520.714378568655, 9551.188149007274, 9601.183899368492, 9667.951660241795, 567.619694804482, 575.3211210771331, 609.6981993913041, 617.4686776793487, 666.7899611622323, 3870.496835411435, 4600.5629465200755, 4723.7874295656775, 4742.596879265301, 4744.193487107131, 121031.0, 156614.2169289169, 160112.1091777016, 163467.0, 166436.0, 132378.0, 133475.66524334825, 134709.0, 134867.0, 138923.30538347445, 69156.0, 70021.64989175124, 70924.0, 82162.58918705248, 115259.0, 9747.707568772948, 10004.149647280063, 10162.073106583388, 10181.440020798927, 10301.690949271533, 54497.0, 58748.0, 61594.0, 62383.6880815593, 63235.6838215806, 77319.10830254592, 89966.0, 90013.0, 90172.09827901637, 92182.0, 12896.29070401137, 13291.734165316446, 13333.133346332845, 13577.253251071286, 13772.31138443094, 14900.403983840524, 15063.0, 15085.396584136512, 15093.39626414931, 15133.470328538448, 13790.65523361924, 13949.58151255464, 13971.231582263074, 13998.160110393408, 14381.28093595337, 14062.0, 14071.859281407464, 14086.22525761093, 14483.710325793636, 14500.202488863213, 13269.668258293234, 13433.328333583477, 13447.394867230802, 13466.124701894345, 14241.287935603386, 10757.515911783832, 10819.1344692426, 11091.889081109086, 11279.830802538132, 11406.543738250377, 11329.490172942402, 11373.886261137613, 11583.0, 11683.591074312359, 11701.180917335705], "value": 7879.570548027972, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1646.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 117.0, 108.0, 120.0, 119.0, 97.0, 164.0, 168.0, 97.0, 173.0], "value": 127.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 105.0, 134.0, 159.0, 111.0, 134.0, 131.0, 110.0, 160.0, 111.0], "value": 130.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 225.0, 208.0, 203.0, 200.0, 239.0, 284.0, 233.0, 191.0, 198.0], "value": 218.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 81.0, 76.0, 147.0, 58.0, 72.0, 75.0, 89.0, 139.0, 61.0], "value": 86.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 124.0, 74.0, 71.0, 92.0, 146.0, 102.0, 101.0, 119.0], "value": 97.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 118.0, 90.0, 98.0, 116.0, 88.0, 107.0, 84.0, 135.0, 131.0], "value": 106.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 114.0, 130.0, 153.0, 146.0, 98.0, 113.0, 118.0, 96.0, 97.0], "value": 121.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 98.0, 91.0, 95.0, 90.0, 93.0, 96.0, 92.0, 92.0], "value": 93.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 57.0, 55.0, 57.0, 60.0, 55.0, 58.0, 57.0, 57.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 69.0, 74.0, 117.0, 67.0, 102.0, 95.0, 110.0, 107.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 86.0, 90.0, 88.0, 90.0, 91.0, 92.0, 105.0, 105.0, 118.0], "value": 95.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 143.0, 128.0, 138.0, 157.0, 160.0, 171.0, 155.0, 164.0], "value": 150.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 190.0, 184.0, 184.0, 184.0, 181.0, 185.0, 211.0, 257.0, 205.0], "value": 197.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 75.0, 86.0, 86.0, 86.0, 78.0, 71.0, 70.0, 70.0], "value": 76.3, "unit": "score"}]}]} 18:14:43 INFO - Return code: 0 18:14:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:14:43 ERROR - # TBPL SUCCESS # 18:14:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:14:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:14:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:14:43 INFO - 2016-08-12 18:14:43.383 screenresolution[1953:20367] starting screenresolution argv=screenresolution get 18:14:43 INFO - 2016-08-12 18:14:43.385 screenresolution[1953:20367] Display 0: 1600x1200x32@60 18:14:43 INFO - 2016-08-12 18:14:43.391 screenresolution[1954:20370] starting screenresolution argv=screenresolution list 18:14:43 INFO - Available Modes on Display 0 18:14:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:14:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:14:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:14:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:14:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:14:43 INFO - Intel Iris: 18:14:43 INFO - Chipset Model: Intel Iris 18:14:43 INFO - Type: GPU 18:14:43 INFO - Bus: Built-In 18:14:43 INFO - VRAM (Dynamic, Max): 1536 MB 18:14:43 INFO - Vendor: Intel (0x8086) 18:14:43 INFO - Device ID: 0x0a2e 18:14:43 INFO - Revision ID: 0x0009 18:14:43 INFO - Displays: 18:14:43 INFO - Display: 18:14:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:14:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:14:43 INFO - Display Serial Number: 1600x1200 60 18:14:43 INFO - Main Display: Yes 18:14:43 INFO - Mirror: Off 18:14:43 INFO - Online: Yes 18:14:43 INFO - Rotation: Supported 18:14:43 INFO - Return code: 0 18:14:43 INFO - Running post-action listener: _resource_record_post_action 18:14:43 INFO - [mozharness: 2016-08-13 01:14:43.629156Z] Finished run-tests step (success) 18:14:43 INFO - Running post-run listener: _resource_record_post_run 18:14:43 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 98304; Write bytes: 705154560; Read time: 3; Write time: 1991 18:14:43 INFO - TinderboxPrint: CPU usage
54.5% 18:14:43 INFO - TinderboxPrint: I/O read bytes / time
98,304 / 3 18:14:43 INFO - TinderboxPrint: I/O write bytes / time
705,154,560 / 1,991 18:14:43 INFO - TinderboxPrint: CPU idle
2,207.0 (45.5%) 18:14:43 INFO - TinderboxPrint: CPU system
982.7 (20.3%) 18:14:43 INFO - TinderboxPrint: CPU user
1,655.9 (34.2%) 18:14:43 INFO - TinderboxPrint: Swap in / out
403,533,824 / 0 18:14:43 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 391041536; Write bytes: 386311680; Read time: 29163; Write time: 748 18:14:43 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 98304; Write bytes: 296765440; Read time: 3; Write time: 1193 18:14:44 INFO - Running post-run listener: _upload_blobber_files 18:14:44 INFO - Blob upload gear active. 18:14:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:14:44 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:14:44 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:14:44 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:14:45 INFO - (blobuploader) - INFO - Open directory for files ... 18:14:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:14:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:14:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:14:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:14:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:14:46 INFO - (blobuploader) - INFO - Done attempting. 18:14:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:14:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:14:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:14:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:14:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:14:47 INFO - (blobuploader) - INFO - Done attempting. 18:14:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:14:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:14:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:14:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:14:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:14:50 INFO - (blobuploader) - INFO - Done attempting. 18:14:50 INFO - (blobuploader) - INFO - Iteration through files over. 18:14:50 INFO - Return code: 0 18:14:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:14:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:14:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3f52b699aadd828431e1441f9211aa4c5282372f2135d2f8e9a0ed1ed1361e37aa86710bea30d3b34826d6034d8afdd78030c34080ca83910d475ee9cf177f98", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/eb9ce7fe93e74b987a3e531c278e19ac13568a7e6ebe9d684bd0a98daa9cab0517e48f50aee7fa76b4d4e51438818780836570f3219fb401b0d34346906f4fe1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2a3e674990b5cead03943ecaf78aefd7e8dc23c71e237826b13dee69810f9a8bc881ea439fcb73e53ea85434544893be5f7224fb65f63d572f509feed022ec04"} 18:14:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:14:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:14:50 INFO - Contents: 18:14:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3f52b699aadd828431e1441f9211aa4c5282372f2135d2f8e9a0ed1ed1361e37aa86710bea30d3b34826d6034d8afdd78030c34080ca83910d475ee9cf177f98", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/eb9ce7fe93e74b987a3e531c278e19ac13568a7e6ebe9d684bd0a98daa9cab0517e48f50aee7fa76b4d4e51438818780836570f3219fb401b0d34346906f4fe1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2a3e674990b5cead03943ecaf78aefd7e8dc23c71e237826b13dee69810f9a8bc881ea439fcb73e53ea85434544893be5f7224fb65f63d572f509feed022ec04"} 18:14:50 INFO - Running post-run listener: copy_logs_to_upload_dir 18:14:50 INFO - Copying logs to upload dir... 18:14:50 INFO - mkdir: /builds/slave/test/build/upload/logs 18:14:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.164673 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-08-12 18:14:50.351875) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 18:14:50.355076) ========= 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.5XDt3AO6vk/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.jDMGWFd6Gs/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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/3f52b699aadd828431e1441f9211aa4c5282372f2135d2f8e9a0ed1ed1361e37aa86710bea30d3b34826d6034d8afdd78030c34080ca83910d475ee9cf177f98", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/eb9ce7fe93e74b987a3e531c278e19ac13568a7e6ebe9d684bd0a98daa9cab0517e48f50aee7fa76b4d4e51438818780836570f3219fb401b0d34346906f4fe1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2a3e674990b5cead03943ecaf78aefd7e8dc23c71e237826b13dee69810f9a8bc881ea439fcb73e53ea85434544893be5f7224fb65f63d572f509feed022ec04"} build_url:https://queue.taskcluster.net/v1/task/RHDugItNSY-1K8F-qeW2YQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010887 build_url: 'https://queue.taskcluster.net/v1/task/RHDugItNSY-1K8F-qeW2YQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3f52b699aadd828431e1441f9211aa4c5282372f2135d2f8e9a0ed1ed1361e37aa86710bea30d3b34826d6034d8afdd78030c34080ca83910d475ee9cf177f98", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/eb9ce7fe93e74b987a3e531c278e19ac13568a7e6ebe9d684bd0a98daa9cab0517e48f50aee7fa76b4d4e51438818780836570f3219fb401b0d34346906f4fe1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2a3e674990b5cead03943ecaf78aefd7e8dc23c71e237826b13dee69810f9a8bc881ea439fcb73e53ea85434544893be5f7224fb65f63d572f509feed022ec04"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 18:14:50.390055) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 18:14:50.390582) ========= 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.5XDt3AO6vk/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.jDMGWFd6Gs/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.005612 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 18:14:50.439706) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 18:14:50.440034) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 18:14:50.440371) ========= ========= Total master_lag: 0.28 =========