builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0222 starttime: 1471881178.47 results: success (0) buildid: 20160822063914 builduid: ac95ec65533e440cb6a32a4a9fd69779 revision: 5f3d66a9ea5ddcf59e0b83a81579773aa7d68ae4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 08:52:58.467939) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 08:52:58.468411) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 08:52:58.468748) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 08:52:58.494632) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:52:58.495090) ========= 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.CDiwvgpsyW/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.X0OkSBJcVb/Listeners TMPDIR=/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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-22 08:52:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.7M=0.001s 2016-08-22 08:52:58 (18.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137563 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:52:58.655809) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:52:58.656214) ========= 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.CDiwvgpsyW/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.X0OkSBJcVb/Listeners TMPDIR=/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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.026055 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:52:58.704874) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 08:52:58.705249) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5f3d66a9ea5ddcf59e0b83a81579773aa7d68ae4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5f3d66a9ea5ddcf59e0b83a81579773aa7d68ae4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CDiwvgpsyW/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.X0OkSBJcVb/Listeners TMPDIR=/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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-22 08:52:58,784 truncating revision to first 12 chars 2016-08-22 08:52:58,784 Setting DEBUG logging. 2016-08-22 08:52:58,784 attempt 1/10 2016-08-22 08:52:58,785 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5f3d66a9ea5d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 08:52:59,865 unpacking tar archive at: mozilla-central-5f3d66a9ea5d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.355138 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 08:53:00.082548) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 08:53:00.082876) ========= script_repo_revision: 5f3d66a9ea5ddcf59e0b83a81579773aa7d68ae4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 08:53:00.086365) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 08:53:00.086653) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 08:53:00.105385) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-22 08:53:00.105726) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CDiwvgpsyW/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.X0OkSBJcVb/Listeners TMPDIR=/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 08:53:00 INFO - MultiFileLogger online at 20160822 08:53:00 in /builds/slave/test 08:53:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:53:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:53:00 INFO - {'append_to_log': False, 08:53:00 INFO - 'base_work_dir': '/builds/slave/test', 08:53:00 INFO - 'blob_upload_branch': 'Firefox', 08:53:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:53:00 INFO - 'branch': 'Firefox', 08:53:00 INFO - 'buildbot_json_path': 'buildprops.json', 08:53:00 INFO - 'config_files': ('talos/mac_config.py',), 08:53:00 INFO - 'default_actions': ('clobber', 08:53:00 INFO - 'read-buildbot-config', 08:53:00 INFO - 'download-and-extract', 08:53:00 INFO - 'populate-webroot', 08:53:00 INFO - 'create-virtualenv', 08:53:00 INFO - 'install', 08:53:00 INFO - 'run-tests'), 08:53:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:53:00 INFO - 'download_minidump_stackwalk': True, 08:53:00 INFO - 'download_symbols': 'ondemand', 08:53:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:53:00 INFO - 'tooltool.py': '/tools/tooltool.py', 08:53:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:53:00 INFO - '/tools/misc-python/virtualenv.py')}, 08:53:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:53:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:53:00 INFO - 'installer_path': 'installer.exe', 08:53:00 INFO - 'log_level': 'info', 08:53:00 INFO - 'log_name': 'talos', 08:53:00 INFO - 'log_to_console': True, 08:53:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:53:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:53:00 INFO - 'opt_config_files': (), 08:53:00 INFO - 'pip_index': False, 08:53:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:53:00 INFO - 'cmd': ('bash', 08:53:00 INFO - '-c', 08:53:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:53:00 INFO - 'enabled': True, 08:53:00 INFO - 'halt_on_failure': False, 08:53:00 INFO - 'name': 'check_screen_resolution'},), 08:53:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:53:00 INFO - 'cmd': ('bash', 08:53:00 INFO - '-c', 08:53:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:53:00 INFO - 'enabled': True, 08:53:00 INFO - 'halt_on_failure': False, 08:53:00 INFO - 'name': 'check_screen_resolution'},), 08:53:00 INFO - 'run_cmd_checks_enabled': True, 08:53:00 INFO - 'sps_profile': False, 08:53:00 INFO - 'sps_profile_interval': 0, 08:53:00 INFO - 'suite': 'dromaeojs-e10s', 08:53:00 INFO - 'system_bits': '32', 08:53:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:53:00 INFO - 'title': 't-yosemite-r7-0222', 08:53:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:53:00 INFO - 'use_talos_json': True, 08:53:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:53:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:53:00 INFO - 'work_dir': 'build'} 08:53:00 INFO - [mozharness: 2016-08-22 15:53:00.294781Z] Running clobber step. 08:53:00 INFO - Running pre-action listener: _resource_record_pre_action 08:53:00 INFO - Running main action method: clobber 08:53:00 INFO - rmtree: /builds/slave/test/build 08:53:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:53:02 INFO - Running post-action listener: _resource_record_post_action 08:53:02 INFO - [mozharness: 2016-08-22 15:53:02.355087Z] Finished clobber step (success) 08:53:02 INFO - [mozharness: 2016-08-22 15:53:02.355234Z] Running read-buildbot-config step. 08:53:02 INFO - Running pre-action listener: _resource_record_pre_action 08:53:02 INFO - Running main action method: read_buildbot_config 08:53:02 INFO - Using buildbot properties: 08:53:02 INFO - { 08:53:02 INFO - "project": "", 08:53:02 INFO - "product": "firefox", 08:53:02 INFO - "script_repo_revision": "production", 08:53:02 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 08:53:02 INFO - "repository": "", 08:53:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 08:53:02 INFO - "buildid": "20160822063914", 08:53:02 INFO - "pgo_build": "False", 08:53:02 INFO - "basedir": "/builds/slave/test", 08:53:02 INFO - "buildnumber": 5, 08:53:02 INFO - "slavename": "t-yosemite-r7-0222", 08:53:02 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:53:02 INFO - "platform": "yosemite_r7", 08:53:02 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:53:02 INFO - "branch": "mozilla-central", 08:53:02 INFO - "repo_path": "mozilla-central", 08:53:02 INFO - "revision": "5f3d66a9ea5ddcf59e0b83a81579773aa7d68ae4", 08:53:02 INFO - "stage_platform": "macosx64", 08:53:02 INFO - "builduid": "ac95ec65533e440cb6a32a4a9fd69779", 08:53:02 INFO - "slavebuilddir": "test" 08:53:02 INFO - } 08:53:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/F86j7ptdQKKrb-Oj9HCH9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 08:53:02 INFO - Running post-action listener: _resource_record_post_action 08:53:02 INFO - [mozharness: 2016-08-22 15:53:02.358628Z] Finished read-buildbot-config step (success) 08:53:02 INFO - [mozharness: 2016-08-22 15:53:02.358773Z] Running download-and-extract step. 08:53:02 INFO - Running pre-action listener: _resource_record_pre_action 08:53:02 INFO - Running main action method: download_and_extract 08:53:02 INFO - mkdir: /builds/slave/test/build/tests 08:53:02 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')]} 08:53:02 INFO - trying https://queue.taskcluster.net/v1/task/F86j7ptdQKKrb-Oj9HCH9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 08:53:02 INFO - Downloading https://queue.taskcluster.net/v1/task/F86j7ptdQKKrb-Oj9HCH9Q/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 08:53:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F86j7ptdQKKrb-Oj9HCH9Q/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 08:53:03 INFO - Downloaded 1199 bytes. 08:53:03 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 08:53:03 INFO - Using the following test package requirements: 08:53:03 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 08:53:03 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:53:03 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 08:53:03 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:53:03 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 08:53:03 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:53:03 INFO - u'jsshell-mac.zip'], 08:53:03 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:53:03 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 08:53:03 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 08:53:03 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:53:03 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 08:53:03 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:53:03 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 08:53:03 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:53:03 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 08:53:03 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:53:03 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 08:53:03 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:53: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')]} 08:53:03 INFO - trying https://queue.taskcluster.net/v1/task/F86j7ptdQKKrb-Oj9HCH9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:53:03 INFO - Downloading https://queue.taskcluster.net/v1/task/F86j7ptdQKKrb-Oj9HCH9Q/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 08:53:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F86j7ptdQKKrb-Oj9HCH9Q/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 08:53:04 INFO - Downloaded 16351880 bytes. 08:53:04 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 08:53:11 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 08:53: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')]} 08:53:11 INFO - trying https://queue.taskcluster.net/v1/task/F86j7ptdQKKrb-Oj9HCH9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:53:11 INFO - Downloading https://queue.taskcluster.net/v1/task/F86j7ptdQKKrb-Oj9HCH9Q/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 08:53:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F86j7ptdQKKrb-Oj9HCH9Q/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 08:53:12 INFO - Downloaded 16351880 bytes. 08:53:12 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 08:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:19 INFO - trying https://queue.taskcluster.net/v1/task/F86j7ptdQKKrb-Oj9HCH9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 08:53:19 INFO - Downloading https://queue.taskcluster.net/v1/task/F86j7ptdQKKrb-Oj9HCH9Q/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 08:53:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F86j7ptdQKKrb-Oj9HCH9Q/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 08:53:20 INFO - Downloaded 14413981 bytes. 08:53:20 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 08:53: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')]} 08:53:20 INFO - trying https://queue.taskcluster.net/v1/task/F86j7ptdQKKrb-Oj9HCH9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:53:20 INFO - Downloading https://queue.taskcluster.net/v1/task/F86j7ptdQKKrb-Oj9HCH9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 08:53:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F86j7ptdQKKrb-Oj9HCH9Q/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 08:53:23 INFO - Downloaded 111515635 bytes. 08:53:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F86j7ptdQKKrb-Oj9HCH9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:53:23 INFO - mkdir: /builds/slave/test/properties 08:53:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:53:23 INFO - Writing to file /builds/slave/test/properties/build_url 08:53:23 INFO - Contents: 08:53:23 INFO - build_url:https://queue.taskcluster.net/v1/task/F86j7ptdQKKrb-Oj9HCH9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:53:24 INFO - Running post-action listener: _resource_record_post_action 08:53:24 INFO - Running post-action listener: set_extra_try_arguments 08:53:24 INFO - [mozharness: 2016-08-22 15:53:24.017259Z] Finished download-and-extract step (success) 08:53:24 INFO - [mozharness: 2016-08-22 15:53:24.017387Z] Running populate-webroot step. 08:53:24 INFO - Running pre-action listener: _resource_record_pre_action 08:53:24 INFO - Running main action method: populate_webroot 08:53:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:53:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:53:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:53:24 INFO - '--tppagecycles', 08:53:24 INFO - '7'], 08:53:24 INFO - 'tests': ['tsvgm']}}, 08:53:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:53:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:53:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:53:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:53:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:53:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:53:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:24 INFO - 'talos_options': ['--disable-e10s'], 08:53:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:24 INFO - 'talos_options': ['--disable-e10s'], 08:53:24 INFO - 'tests': ['damp', 'tps']}, 08:53:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:24 INFO - 'tests': ['damp', 'tps']}, 08:53:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:53:24 INFO - 'tests': ['dromaeo_dom']}, 08:53:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:53:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:53:24 INFO - 'tests': ['basic_compositor_video']}, 08:53:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:53:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:53:24 INFO - 'tests': ['a11yr', 08:53:24 INFO - 'ts_paint', 08:53:24 INFO - 'tpaint', 08:53:24 INFO - 'sessionrestore', 08:53:24 INFO - 'sessionrestore_no_auto_restore', 08:53:24 INFO - 'tabpaint']}, 08:53:24 INFO - 'other-e10s': {'tests': ['a11yr', 08:53:24 INFO - 'ts_paint', 08:53:24 INFO - 'tpaint', 08:53:24 INFO - 'sessionrestore', 08:53:24 INFO - 'sessionrestore_no_auto_restore', 08:53:24 INFO - 'tabpaint']}, 08:53:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:53:24 INFO - 'ts_paint', 08:53:24 INFO - 'tpaint', 08:53:24 INFO - 'sessionrestore', 08:53:24 INFO - 'sessionrestore_no_auto_restore', 08:53:24 INFO - 'tabpaint']}, 08:53:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:53:24 INFO - 'ts_paint', 08:53:24 INFO - 'tpaint', 08:53:24 INFO - 'sessionrestore', 08:53:24 INFO - 'sessionrestore_no_auto_restore', 08:53:24 INFO - 'tabpaint']}, 08:53:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:53:24 INFO - 'tests': ['a11yr', 08:53:24 INFO - 'ts_paint', 08:53:24 INFO - 'tpaint', 08:53:24 INFO - 'sessionrestore', 08:53:24 INFO - 'sessionrestore_no_auto_restore', 08:53:24 INFO - 'tabpaint']}, 08:53:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:53:24 INFO - 'tests': ['a11yr', 08:53:24 INFO - 'ts_paint', 08:53:24 INFO - 'tpaint', 08:53:24 INFO - 'sessionrestore', 08:53:24 INFO - 'sessionrestore_no_auto_restore', 08:53:24 INFO - 'tabpaint']}, 08:53:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:53:24 INFO - 'tests': ['tsvgx', 08:53:24 INFO - 'tsvgr_opacity', 08:53:24 INFO - 'tart', 08:53:24 INFO - 'tscrollx', 08:53:24 INFO - 'cart']}, 08:53:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:53:24 INFO - 'tsvgr_opacity', 08:53:24 INFO - 'tart', 08:53:24 INFO - 'tscrollx', 08:53:24 INFO - 'cart']}, 08:53:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:24 INFO - 'talos_options': ['--disable-e10s'], 08:53:24 INFO - 'tests': ['tp5o']}, 08:53:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:24 INFO - 'tests': ['tp5o']}, 08:53:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:24 INFO - 'talos_options': ['--disable-e10s', 08:53:24 INFO - '--xperf_path', 08:53:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:24 INFO - 'tests': ['tp5n']}, 08:53:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:24 INFO - 'talos_options': ['--xperf_path', 08:53:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:24 INFO - 'tests': ['tp5n']}}, 08:53:24 INFO - 'talos.zip': {'path': '', 08:53:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:53:24 INFO - Running post-action listener: _resource_record_post_action 08:53:24 INFO - [mozharness: 2016-08-22 15:53:24.036768Z] Finished populate-webroot step (success) 08:53:24 INFO - [mozharness: 2016-08-22 15:53:24.036901Z] Running create-virtualenv step. 08:53:24 INFO - Running pre-action listener: _resource_record_pre_action 08:53:24 INFO - Running main action method: create_virtualenv 08:53:24 INFO - Creating virtualenv /builds/slave/test/build/venv 08:53:24 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 08:53:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:53:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:53:24 INFO - Using real prefix '/tools/python27' 08:53:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:53:24 INFO - Installing distribute.............................................................................................................................................................................................done. 08:53:27 INFO - Installing pip.................done. 08:53:27 INFO - Return code: 0 08:53:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:27 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 0x109184a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109219618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf1aca6e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090e8d30>, '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 0x108e4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090e0b20>, '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.CDiwvgpsyW/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.X0OkSBJcVb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 08:53:27 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 08:53:27 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 08:53:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CDiwvgpsyW/Render', 08:53:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:27 INFO - 'HOME': '/Users/cltbld', 08:53:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:27 INFO - 'LOGNAME': 'cltbld', 08:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:27 INFO - 'MOZ_NO_REMOTE': '1', 08:53:27 INFO - 'NO_EM_RESTART': '1', 08:53:27 INFO - 'PAGER': '/bin/cat', 08:53:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:27 INFO - 'PWD': '/builds/slave/test', 08:53:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:27 INFO - 'SHELL': '/bin/bash', 08:53:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X0OkSBJcVb/Listeners', 08:53:27 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 08:53:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:27 INFO - 'USER': 'cltbld', 08:53:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:27 INFO - 'XPC_FLAGS': '0x0', 08:53:27 INFO - 'XPC_SERVICE_NAME': '0', 08:53:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:28 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 08:53:28 INFO - Cleaning up... 08:53:28 INFO - Return code: 0 08:53:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:28 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 0x109184a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109219618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf1aca6e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090e8d30>, '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 0x108e4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090e0b20>, '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.CDiwvgpsyW/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.X0OkSBJcVb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 08:53:28 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 08:53:28 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 08:53:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CDiwvgpsyW/Render', 08:53:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:28 INFO - 'HOME': '/Users/cltbld', 08:53:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:28 INFO - 'LOGNAME': 'cltbld', 08:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:28 INFO - 'MOZ_NO_REMOTE': '1', 08:53:28 INFO - 'NO_EM_RESTART': '1', 08:53:28 INFO - 'PAGER': '/bin/cat', 08:53:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:28 INFO - 'PWD': '/builds/slave/test', 08:53:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:28 INFO - 'SHELL': '/bin/bash', 08:53:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X0OkSBJcVb/Listeners', 08:53:28 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 08:53:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:28 INFO - 'USER': 'cltbld', 08:53:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:28 INFO - 'XPC_FLAGS': '0x0', 08:53:28 INFO - 'XPC_SERVICE_NAME': '0', 08:53:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:28 INFO - Downloading/unpacking psutil>=3.1.1 08:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:53:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:31 INFO - Installing collected packages: psutil 08:53:31 INFO - Running setup.py install for psutil 08:53:31 INFO - building 'psutil._psutil_osx' extension 08:53:31 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 08:53:31 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 08:53:31 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 08:53:31 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 08:53:31 INFO - building 'psutil._psutil_posix' extension 08:53:31 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 08:53:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:53:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:53:32 INFO - ^ 08:53:32 INFO - 1 warning generated. 08:53:32 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 08:53:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:32 INFO - Successfully installed psutil 08:53:32 INFO - Cleaning up... 08:53:32 INFO - Return code: 0 08:53:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:32 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 0x109184a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109219618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf1aca6e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090e8d30>, '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 0x108e4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090e0b20>, '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.CDiwvgpsyW/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.X0OkSBJcVb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 08:53:32 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 08:53:32 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 08:53:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CDiwvgpsyW/Render', 08:53:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:32 INFO - 'HOME': '/Users/cltbld', 08:53:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:32 INFO - 'LOGNAME': 'cltbld', 08:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:32 INFO - 'MOZ_NO_REMOTE': '1', 08:53:32 INFO - 'NO_EM_RESTART': '1', 08:53:32 INFO - 'PAGER': '/bin/cat', 08:53:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:32 INFO - 'PWD': '/builds/slave/test', 08:53:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:32 INFO - 'SHELL': '/bin/bash', 08:53:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X0OkSBJcVb/Listeners', 08:53:32 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 08:53:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:32 INFO - 'USER': 'cltbld', 08:53:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:32 INFO - 'XPC_FLAGS': '0x0', 08:53:32 INFO - 'XPC_SERVICE_NAME': '0', 08:53:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:53:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:53:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:53:35 INFO - Installing collected packages: mozsystemmonitor 08:53:35 INFO - Running setup.py install for mozsystemmonitor 08:53:35 INFO - Successfully installed mozsystemmonitor 08:53:35 INFO - Cleaning up... 08:53:35 INFO - Return code: 0 08:53:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:53:35 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')]} 08:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:35 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')]} 08:53:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:35 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 0x109184a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109219618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf1aca6e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090e8d30>, '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 0x108e4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090e0b20>, '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.CDiwvgpsyW/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.X0OkSBJcVb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 08:53:35 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 08:53:35 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 08:53:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CDiwvgpsyW/Render', 08:53:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:35 INFO - 'HOME': '/Users/cltbld', 08:53:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:35 INFO - 'LOGNAME': 'cltbld', 08:53:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:35 INFO - 'MOZ_NO_REMOTE': '1', 08:53:35 INFO - 'NO_EM_RESTART': '1', 08:53:35 INFO - 'PAGER': '/bin/cat', 08:53:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:35 INFO - 'PWD': '/builds/slave/test', 08:53:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:35 INFO - 'SHELL': '/bin/bash', 08:53:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X0OkSBJcVb/Listeners', 08:53:35 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 08:53:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:35 INFO - 'USER': 'cltbld', 08:53:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:35 INFO - 'XPC_FLAGS': '0x0', 08:53:35 INFO - 'XPC_SERVICE_NAME': '0', 08:53:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:35 INFO - Downloading/unpacking jsonschema==2.5.1 08:53:35 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 08:53:35 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 08:53:35 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 08:53:35 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 08:53:35 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 08:53:35 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 08:53:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:53:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:53:38 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 08:53:38 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 08:53:38 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 08:53:38 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 08:53:38 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 08:53:38 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 08:53:38 INFO - Downloading functools32-3.2.3-2.tar.gz 08:53:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:53:38 INFO - warning: no files found matching '*.txt' 08:53:38 INFO - no previously-included directories found matching 'build' 08:53:38 INFO - no previously-included directories found matching 'dist' 08:53:38 INFO - no previously-included directories found matching '.git*' 08:53:38 INFO - Installing collected packages: jsonschema, functools32 08:53:38 INFO - Running setup.py install for functools32 08:53:38 INFO - warning: no files found matching '*.txt' 08:53:38 INFO - no previously-included directories found matching 'build' 08:53:38 INFO - no previously-included directories found matching 'dist' 08:53:38 INFO - no previously-included directories found matching '.git*' 08:53:38 INFO - Successfully installed jsonschema functools32 08:53:38 INFO - Cleaning up... 08:53:38 INFO - Return code: 0 08:53:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08: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')]} 08:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:38 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 0x109184a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109219618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf1aca6e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090e8d30>, '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 0x108e4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090e0b20>, '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.CDiwvgpsyW/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.X0OkSBJcVb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 08:53:38 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 08:53:38 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 08:53:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CDiwvgpsyW/Render', 08:53:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:38 INFO - 'HOME': '/Users/cltbld', 08:53:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:38 INFO - 'LOGNAME': 'cltbld', 08:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:38 INFO - 'MOZ_NO_REMOTE': '1', 08:53:38 INFO - 'NO_EM_RESTART': '1', 08:53:38 INFO - 'PAGER': '/bin/cat', 08:53:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:38 INFO - 'PWD': '/builds/slave/test', 08:53:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:38 INFO - 'SHELL': '/bin/bash', 08:53:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X0OkSBJcVb/Listeners', 08:53:38 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 08:53:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:38 INFO - 'USER': 'cltbld', 08:53:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:38 INFO - 'XPC_FLAGS': '0x0', 08:53:38 INFO - 'XPC_SERVICE_NAME': '0', 08:53:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:53:39 INFO - Cleaning up... 08:53:39 INFO - Return code: 0 08:53:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08: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')]} 08:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:53:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:39 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 0x109184a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109219618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf1aca6e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090e8d30>, '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 0x108e4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090e0b20>, '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.CDiwvgpsyW/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.X0OkSBJcVb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 08:53:39 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 08:53:39 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 08:53:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CDiwvgpsyW/Render', 08:53:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:39 INFO - 'HOME': '/Users/cltbld', 08:53:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:39 INFO - 'LOGNAME': 'cltbld', 08:53:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:39 INFO - 'MOZ_NO_REMOTE': '1', 08:53:39 INFO - 'NO_EM_RESTART': '1', 08:53:39 INFO - 'PAGER': '/bin/cat', 08:53:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:39 INFO - 'PWD': '/builds/slave/test', 08:53:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:39 INFO - 'SHELL': '/bin/bash', 08:53:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X0OkSBJcVb/Listeners', 08:53:39 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 08:53:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:39 INFO - 'USER': 'cltbld', 08:53:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:39 INFO - 'XPC_FLAGS': '0x0', 08:53:39 INFO - 'XPC_SERVICE_NAME': '0', 08:53:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:39 INFO - Downloading/unpacking blobuploader==1.2.4 08:53:39 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 08:53:39 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 08:53:39 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 08:53:39 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 08:53:39 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 08:53:39 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 08:53:42 INFO - Downloading blobuploader-1.2.4.tar.gz 08:53:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:53:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:53:42 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 08:53:42 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 08:53:42 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 08:53:42 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 08:53:42 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 08:53:42 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 08:53:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:53:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:53:43 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 08:53:43 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 08:53:43 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 08:53:43 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 08:53:43 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 08:53:43 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 08:53:43 INFO - Downloading docopt-0.6.1.tar.gz 08:53:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:53:44 INFO - Installing collected packages: blobuploader, requests, docopt 08:53:44 INFO - Running setup.py install for blobuploader 08:53:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:53:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:53:44 INFO - Running setup.py install for requests 08:53:44 INFO - Running setup.py install for docopt 08:53:44 INFO - Successfully installed blobuploader requests docopt 08:53:44 INFO - Cleaning up... 08:53:44 INFO - Return code: 0 08:53:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:44 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 0x109184a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109219618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf1aca6e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090e8d30>, '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 0x108e4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090e0b20>, '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.CDiwvgpsyW/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.X0OkSBJcVb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 08:53:44 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 08:53:44 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 08:53:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CDiwvgpsyW/Render', 08:53:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:44 INFO - 'HOME': '/Users/cltbld', 08:53:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:44 INFO - 'LOGNAME': 'cltbld', 08:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:44 INFO - 'MOZ_NO_REMOTE': '1', 08:53:44 INFO - 'NO_EM_RESTART': '1', 08:53:44 INFO - 'PAGER': '/bin/cat', 08:53:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:44 INFO - 'PWD': '/builds/slave/test', 08:53:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:44 INFO - 'SHELL': '/bin/bash', 08:53:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X0OkSBJcVb/Listeners', 08:53:44 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 08:53:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:44 INFO - 'USER': 'cltbld', 08:53:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:44 INFO - 'XPC_FLAGS': '0x0', 08:53:44 INFO - 'XPC_SERVICE_NAME': '0', 08:53:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:45 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-MQsFRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:45 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-ZkI6ZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:45 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-x0YV0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:45 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-ynXxGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:45 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-xTbUvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:45 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-lbQfCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:45 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-PoAgTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:45 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-Z42tw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:46 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-LChDeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:46 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-o9OHYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:46 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-tIUIpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:46 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-1F7kLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:46 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-NRn3fY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:46 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-O5xltN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:46 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-yGXLGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:46 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-FBiT04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:46 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-OB6n27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:53:46 INFO - Running setup.py install for manifestparser 08:53:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:53:47 INFO - Running setup.py install for mozcrash 08:53:47 INFO - Running setup.py install for mozdebug 08:53:47 INFO - Running setup.py install for mozdevice 08:53:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:53:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:53:47 INFO - Running setup.py install for mozfile 08:53:47 INFO - Running setup.py install for mozhttpd 08:53:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:53:47 INFO - Running setup.py install for mozinfo 08:53:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:53:47 INFO - Running setup.py install for mozInstall 08:53:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:53:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:53:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:53:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:53:48 INFO - Running setup.py install for mozleak 08:53:48 INFO - Running setup.py install for mozlog 08:53:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:53:48 INFO - Running setup.py install for moznetwork 08:53:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:53:48 INFO - Running setup.py install for mozprocess 08:53:48 INFO - Running setup.py install for mozprofile 08:53:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:53:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:53:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:53:48 INFO - Running setup.py install for mozrunner 08:53:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:53:49 INFO - Running setup.py install for mozscreenshot 08:53:49 INFO - Running setup.py install for moztest 08:53:49 INFO - Running setup.py install for mozversion 08:53:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:53:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:53:49 INFO - Cleaning up... 08:53:49 INFO - Return code: 0 08:53:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:49 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 0x109184a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109219618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf1aca6e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090e8d30>, '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 0x108e4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090e0b20>, '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.CDiwvgpsyW/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.X0OkSBJcVb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 08:53:49 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 08:53:49 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 08:53:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CDiwvgpsyW/Render', 08:53:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:49 INFO - 'HOME': '/Users/cltbld', 08:53:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:49 INFO - 'LOGNAME': 'cltbld', 08:53:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:49 INFO - 'MOZ_NO_REMOTE': '1', 08:53:49 INFO - 'NO_EM_RESTART': '1', 08:53:49 INFO - 'PAGER': '/bin/cat', 08:53:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:49 INFO - 'PWD': '/builds/slave/test', 08:53:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:49 INFO - 'SHELL': '/bin/bash', 08:53:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X0OkSBJcVb/Listeners', 08:53:49 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 08:53:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:49 INFO - 'USER': 'cltbld', 08:53:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:49 INFO - 'XPC_FLAGS': '0x0', 08:53:49 INFO - 'XPC_SERVICE_NAME': '0', 08:53:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:49 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-GMHiOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:49 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)) 08:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:49 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-AMCVpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:50 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)) 08:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:50 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-EwjmjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:50 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)) 08:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:50 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-rbwQpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:50 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)) 08:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:50 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-1FSW_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:50 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)) 08:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:50 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-v6_ltS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:50 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)) 08:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:50 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-mqoqgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:50 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)) 08:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:50 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-zDo1QA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:50 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)) 08:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:50 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-xjKnI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:50 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)) 08:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:50 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-QZB504-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:50 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)) 08:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:50 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-hwdMg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:50 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)) 08:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:50 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-mIuVX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:51 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)) 08:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:51 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-AVYtPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:51 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)) 08:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:51 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-qZjlgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:51 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)) 08:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:51 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-ymx6dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:51 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)) 08:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:51 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-gFXhAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:51 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)) 08:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:51 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-Yo39Hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:51 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)) 08:53:51 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)) 08:53:51 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)) 08:53:51 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)) 08:53:51 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)) 08:53:51 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)) 08:53:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:54 INFO - Downloading blessings-1.6.tar.gz 08:53:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:53:54 INFO - Installing collected packages: blessings 08:53:54 INFO - Running setup.py install for blessings 08:53:54 INFO - Successfully installed blessings 08:53:54 INFO - Cleaning up... 08:53:54 INFO - Return code: 0 08:53:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:53:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:54 INFO - Reading from file tmpfile_stdout 08:53:54 INFO - Current package versions: 08:53:54 INFO - blessings == 1.6 08:53:54 INFO - blobuploader == 1.2.4 08:53:54 INFO - docopt == 0.6.1 08:53:54 INFO - functools32 == 3.2.3-2 08:53:54 INFO - jsonschema == 2.5.1 08:53:54 INFO - manifestparser == 1.1 08:53:54 INFO - mozInstall == 1.12 08:53:54 INFO - mozcrash == 0.17 08:53:54 INFO - mozdebug == 0.1 08:53:54 INFO - mozdevice == 0.48 08:53:54 INFO - mozfile == 1.2 08:53:54 INFO - mozhttpd == 0.7 08:53:54 INFO - mozinfo == 0.9 08:53:54 INFO - mozleak == 0.1 08:53:54 INFO - mozlog == 3.3 08:53:54 INFO - moznetwork == 0.27 08:53:54 INFO - mozprocess == 0.23 08:53:54 INFO - mozprofile == 0.28 08:53:54 INFO - mozrunner == 6.12 08:53:54 INFO - mozscreenshot == 0.1 08:53:54 INFO - mozsystemmonitor == 0.3 08:53:54 INFO - moztest == 0.7 08:53:54 INFO - mozversion == 1.4 08:53:54 INFO - psutil == 3.1.1 08:53:54 INFO - requests == 1.2.3 08:53:54 INFO - wsgiref == 0.1.2 08:53:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:54 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')]} 08:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:55 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 0x109184a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109219618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf1aca6e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090e8d30>, '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 0x108e4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090e0b20>, '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.CDiwvgpsyW/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.X0OkSBJcVb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 08:53:55 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 08:53:55 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 08:53:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CDiwvgpsyW/Render', 08:53:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:55 INFO - 'HOME': '/Users/cltbld', 08:53:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:55 INFO - 'LOGNAME': 'cltbld', 08:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:55 INFO - 'MOZ_NO_REMOTE': '1', 08:53:55 INFO - 'NO_EM_RESTART': '1', 08:53:55 INFO - 'PAGER': '/bin/cat', 08:53:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:55 INFO - 'PWD': '/builds/slave/test', 08:53:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:55 INFO - 'SHELL': '/bin/bash', 08:53:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X0OkSBJcVb/Listeners', 08:53:55 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 08:53:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:55 INFO - 'USER': 'cltbld', 08:53:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:55 INFO - 'XPC_FLAGS': '0x0', 08:53:55 INFO - 'XPC_SERVICE_NAME': '0', 08:53:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:55 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)) 08:53:55 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)) 08:53:55 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)) 08:53:55 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)) 08:53:55 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)) 08:53:55 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)) 08:53:55 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)) 08:53:55 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)) 08:53:55 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)) 08:53:55 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)) 08:53:55 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)) 08:53:55 INFO - Cleaning up... 08:53:55 INFO - Return code: 0 08:53:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08: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')]} 08:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:55 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 0x109184a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109219618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf1aca6e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090e8d30>, '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 0x108e4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090e0b20>, '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.CDiwvgpsyW/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.X0OkSBJcVb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 08:53:55 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 08:53:55 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 08:53:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CDiwvgpsyW/Render', 08:53:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:55 INFO - 'HOME': '/Users/cltbld', 08:53:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:55 INFO - 'LOGNAME': 'cltbld', 08:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:55 INFO - 'MOZ_NO_REMOTE': '1', 08:53:55 INFO - 'NO_EM_RESTART': '1', 08:53:55 INFO - 'PAGER': '/bin/cat', 08:53:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:55 INFO - 'PWD': '/builds/slave/test', 08:53:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:55 INFO - 'SHELL': '/bin/bash', 08:53:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X0OkSBJcVb/Listeners', 08:53:55 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 08:53:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:55 INFO - 'USER': 'cltbld', 08:53:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:55 INFO - 'XPC_FLAGS': '0x0', 08:53:55 INFO - 'XPC_SERVICE_NAME': '0', 08:53:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:53:55 INFO - Cleaning up... 08:53:55 INFO - Return code: 0 08:53:55 INFO - Running post-action listener: _resource_record_post_action 08:53:55 INFO - Running post-action listener: _start_resource_monitoring 08:53:55 INFO - Starting resource monitoring. 08:53:55 INFO - [mozharness: 2016-08-22 15:53:55.714517Z] Finished create-virtualenv step (success) 08:53:55 INFO - [mozharness: 2016-08-22 15:53:55.715326Z] Running install step. 08:53:55 INFO - Running pre-action listener: _resource_record_pre_action 08:53:55 INFO - Running main action method: install 08:53:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:55 INFO - Reading from file tmpfile_stdout 08:53:55 INFO - Detecting whether we're running mozinstall >=1.0... 08:53:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:53:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:53:56 INFO - Reading from file tmpfile_stdout 08:53:56 INFO - Output received: 08:53:56 INFO - Usage: mozinstall [options] installer 08:53:56 INFO - Options: 08:53:56 INFO - -h, --help show this help message and exit 08:53:56 INFO - -d DEST, --destination=DEST 08:53:56 INFO - Directory to install application into. [default: 08:53:56 INFO - "/builds/slave/test"] 08:53:56 INFO - --app=APP Application being installed. [default: firefox] 08:53:56 INFO - mkdir: /builds/slave/test/build/application 08:53:56 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'] 08:53:56 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 08:54:30 INFO - Reading from file tmpfile_stdout 08:54:30 INFO - Output received: 08:54:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:54:30 INFO - Running post-action listener: _resource_record_post_action 08:54:30 INFO - [mozharness: 2016-08-22 15:54:30.010606Z] Finished install step (success) 08:54:30 INFO - [mozharness: 2016-08-22 15:54:30.010745Z] Running run-tests step. 08:54:30 INFO - Running pre-action listener: _resource_record_pre_action 08:54:30 INFO - Running main action method: run_tests 08:54:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:54:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:54:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:54:30 INFO - 2016-08-22 08:54:30.025 screenresolution[1634:7494] starting screenresolution argv=screenresolution get 08:54:30 INFO - 2016-08-22 08:54:30.028 screenresolution[1634:7494] Display 0: 1600x1200x32@60 08:54:30 INFO - 2016-08-22 08:54:30.034 screenresolution[1635:7496] starting screenresolution argv=screenresolution list 08:54:30 INFO - Available Modes on Display 0 08:54:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:54:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:54:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:54:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:54:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:54:30 INFO - Intel Iris: 08:54:30 INFO - Chipset Model: Intel Iris 08:54:30 INFO - Type: GPU 08:54:30 INFO - Bus: Built-In 08:54:30 INFO - VRAM (Dynamic, Max): 1536 MB 08:54:30 INFO - Vendor: Intel (0x8086) 08:54:30 INFO - Device ID: 0x0a2e 08:54:30 INFO - Revision ID: 0x0009 08:54:30 INFO - Displays: 08:54:30 INFO - Display: 08:54:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:54:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:54:30 INFO - Display Serial Number: 1600x1200 60 08:54:30 INFO - Main Display: Yes 08:54:30 INFO - Mirror: Off 08:54:30 INFO - Online: Yes 08:54:30 INFO - Rotation: Supported 08:54:30 INFO - Return code: 0 08:54:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:54:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:54:30 INFO - Python 2.7.3 08:54:30 INFO - Return code: 0 08:54:30 INFO - grabbing minidump binary from tooltool 08:54:30 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')]} 08:54:30 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 0x1090e8d30>, '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 0x108e4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1090e0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:54:30 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 08:54:30 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 08:54:30 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 08:54:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:54:30 INFO - Return code: 0 08:54:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:54:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:54:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:54:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:54:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:54:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F86j7ptdQKKrb-Oj9HCH9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0222', '--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 08:54:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/F86j7ptdQKKrb-Oj9HCH9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0222 --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 08:54:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CDiwvgpsyW/Render', 08:54:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:30 INFO - 'HOME': '/Users/cltbld', 08:54:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:30 INFO - 'LOGNAME': 'cltbld', 08:54:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:54:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:30 INFO - 'MOZ_NO_REMOTE': '1', 08:54:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:54:30 INFO - 'NO_EM_RESTART': '1', 08:54:30 INFO - 'PAGER': '/bin/cat', 08:54:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:30 INFO - 'PWD': '/builds/slave/test', 08:54:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:54:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:30 INFO - 'SHELL': '/bin/bash', 08:54:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X0OkSBJcVb/Listeners', 08:54:30 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 08:54:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:30 INFO - 'USER': 'cltbld', 08:54:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:30 INFO - 'XPC_FLAGS': '0x0', 08:54:30 INFO - 'XPC_SERVICE_NAME': '0', 08:54:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F86j7ptdQKKrb-Oj9HCH9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0222', '--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 08:54:30 INFO - mozversion application_buildid: 20160822063914 08:54:30 INFO - mozversion application_changeset: 5f3d66a9ea5ddcf59e0b83a81579773aa7d68ae4 08:54:30 INFO - mozversion application_display_name: Nightly 08:54:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:54:30 INFO - mozversion application_name: Firefox 08:54:30 INFO - mozversion application_remotingname: firefox 08:54:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:54:30 INFO - mozversion application_vendor: Mozilla 08:54:30 INFO - mozversion application_version: 51.0a1 08:54:30 INFO - mozversion platform_buildid: 20160822063914 08:54:30 INFO - mozversion platform_changeset: 5f3d66a9ea5ddcf59e0b83a81579773aa7d68ae4 08:54:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:54:30 INFO - mozversion platform_version: 51.0a1 08:54:30 INFO - using testdate: 1471881270 08:54:30 INFO - actual date: 1471881270 08:54:30 INFO - starting webserver on 'localhost:49275' 08:54:30 INFO - SUITE-START | Running 2 tests 08:54:30 INFO - TEST-START | dromaeo_css 08:54:30 INFO - operating with platform_type : mac_ 08:54:30 INFO - Initialising browser for dromaeo_css test... 08:54:30 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/tmpjjpTj5/profile http://localhost:49275/getInfo.html) 08:54:33 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 08:54:33 INFO - PROCESS | 1645 | colorDepth:24 08:54:33 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 08:54:33 INFO - PROCESS | 1645 | __metrics 08:54:33 ERROR - PROCESS | 1645 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3061: TypeError: this.tabs is undefined 08:54:34 INFO - TEST-INFO | 1645: exit 0 08:54:34 INFO - Browser initialized. 08:54:34 INFO - Running cycle 1/1 for dromaeo_css test... 08:54:34 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/tmpjjpTj5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:54:46 INFO - PROCESS | 1648 | RSS: Main: 240160768 08:54:46 INFO - PROCESS | 1648 | 08:55:35 INFO - PROCESS | 1648 | 1471881335843 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] 08:57:47 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 08:57:49 INFO - PROCESS | 1648 | RSS: Main: 255553536 08:57:49 INFO - PROCESS | 1648 | 09:00:51 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 09:00:52 INFO - PROCESS | 1648 | RSS: Main: 265641984 09:00:52 INFO - PROCESS | 1648 | 09:03:54 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 09:03:54 INFO - PROCESS | 1648 | RSS: Main: 272097280 09:03:54 INFO - PROCESS | 1648 | 09:06:56 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 09:06:57 INFO - PROCESS | 1648 | RSS: Main: 271532032 09:06:57 INFO - PROCESS | 1648 | 09:10:00 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 09:10:00 INFO - PROCESS | 1648 | RSS: Main: 276795392 09:10:00 INFO - PROCESS | 1648 | 09:13:03 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 09:13:03 INFO - PROCESS | 1648 | RSS: Main: 279515136 09:13:03 INFO - PROCESS | 1648 | 09:13:03 INFO - PROCESS | 1648 | __start_tp_report 09:13:03 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 09:13:03 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 09:13:03 INFO - PROCESS | 1648 | |i|pagename|runs| 09:13:03 INFO - PROCESS | 1648 | |0;dojo.html;3442.965570344297;3445.672661097195;3454.4300190468575;3454.447288433851;3471.965280347196;5366.865828354288;5367.838964831057;5872.853178670535;5916.822495325147;5947.702614869261;5697.914531282024;5829.504492118164;5877.794277200299;5916.704164791765;5982.641041537511;4402.889927751799;5292.206169074631;5393.217983392406;5439.5920305977015;5465.672059676433;5339.22581225722;5467.398586155519;5500.669959802424;5504.394516603171;5509.669419834802;5235.476452354772;5387.4612538746005;5391.649542779746;5393.056215162331;5421.864453388657;5260.210968354739;5264.236685680555;5306;5333.226682131108;5336.252924590522;5260.684358938476;5288.338957630296;5302.708351040691;5395.460453954613;5401.162819762943;5882.882342353172;5920.0231961726695;5988.131720900445;6006.21919150512;6013.939860601426;6259.78090766821;6259.874802503924;6280.560360774748;6320.873582528324;6331.303556608769;6383.329750376237;6386.201724784402;6391.105245265667;6398.200224971879;6409.93590064098;5861.062230043172;5961.016432288624;6006.489448396936;6076.392360763933;6097.944866663664;6459.773907913201;6463.547551671432;6474;6482.481401487869;6486.67566621667;6280.026595877646;6285.277193122758;6285.748570057238;6329.177206963065;6333.746650134035;6168.321484636686;6234.376562343729;6281.7173227204885;6344.777932772331;6364.109024736541;6153.2000839890525;6221.9377806222265;6229.314775374705;6257.998720204836;6287.96856015717;6237.376262373817;6263.4362907337645;6289.40250676185;6290.968545157337;6292.559520833589;4984.501549845059;5115.74421278942;5131.102057139986;5137.0753264412015;5149.150390185652;4250.893727656833;4355.73865568067;4528.320751887243;4535.818567257339;4568.428946381702;5958.821235362946;6046.941785187574;6067.908981365283;6078.331383547807;6086.056661217518;6172.845678857974;6416.486681065504;6419.807405777834;6422.4862011039;6425.935740642533;5913.113033045078;5961.612495187799;5986.910196347058;6036.939630603725;6067.544934129958;5591.273134492571;5607.607467477237;5616.269884914935;5625.38120806711;5632.127020311858;6217;6538;6597.703103360456;6619.371159739817;6622.602643841385;5291.444398338119;6293.811185664437;6320.905186422299;6361.2048493938255;6380.266269379081;6479.449246813885;6521.608703477807;6531.379518945692;6532.477401807749;6553.036736569698;6191.442770150708;6319.368063193644;6328.145700330397;6332.683365831598;6338.873222535616;6255.655938923221;6262.780802671885;6312.242530896322;6352.936470635234;6355.269144048493;6211.440970312694;6252.874942501034;6258.718357674006;6267.247930248217;6295.338989406229;6090.69546522681;6238.220222472191;6307.621542707452;6312.3056463788025;6326.588771729823;4754.0016596515115;5659.830205093854;6135.53983451234;6235.376462353728;6261.279952805304;6247.843803904757;6266.811995640138;6273.811785646438;6277.529185311028;6292.52806039558;4992.425871024733;6116.235470566179;6195.752169913333;6242.438180563771;6252.218472690914 09:13:03 INFO - PROCESS | 1648 | |1;ext.html;509.44979422224003;530.9893802123958;534.4254925954599;564.0974440894569;575.3584753000406;37907.62092379079;38575.22849543011;40197.995050123725;40265;40323;41452.37821432681;41572.16855662885;42225.733228003206;42298;42413.78793106038;8386.87419688705;8662.913370866305;11747.588834390797;12018.4591693374;12077.637670869888;11792.528298868036;11859.52561897523;11916.940415297911;11917.344546049964;11923.701907452296;11913.225640333394;11956.282623042602;11972.880271197264;11974.281543107398;12007.279563226235;11832.40837958103;11883.58407455735;11893.405329733565;11917.642470725892;11944.104192185534;11913.344766037864;11923.224990375598;11939.223950443193;11992.880071199264;12015.39923003855;40158.59841401578;40508.39237411412;40615.187696246205;40640.18719625621;40692.59307406918;3033.620797400325;3585.0858031202138;3587.712982961357;3811.6188381161937;3950.2889479893606;31802.204944876332;32389.190270243198;32595.51106733401;32653.346933061443;33126.503102453484;2876.4103358811394;3163.73108285796;3227.4351988402173;3265.6081270247723;3344.782589131723;521488;527173;528370;528397;530514;58018.709906450196;58038;58190.709046454496;58215.417845821845;58478;60505;60732.392676072675;60752.69623651853;60860.478488038156;61038;14550.708985820436;15945.681086378207;16261.51215463538;16488.928219665682;16510.257038433298;11984.940075299568;12122.666506684258;12805.807912881315;13010.414531346112;13022.088453808143;13224;15320.387184512718;15340.846591534166;15352.309146088453;15475.226238688021;7161.242921475269;7246.347828695442;7255.854882902312;7310.989477893516;7352.19125896151;864.4078806017898;875.2429148786254;979.8334283171878;982.729749318943;1089.5206109311878;29323.706762932525;30257.24356891095;30282.394352112835;30301.848490757406;31340.843295783376;1050.6532844161409;1051.353417648141;1077.4128100185417;1079.266099052636;1095.381109673048;13720.8884272759;14882.627934301729;15856.603584910239;15862.682746345008;15906;667723;681090;687622;688653;691608.6258706123;45333.77333113313;58372.70813645905;58419.41580584225;58558.414415855295;58684.41315586789;1159.756451145252;1284.0882973089024;1342.7717288061053;1365.9726805463836;1377.5522955039453;29910;30157.547636785028;30160.7935682579;30437.08688739253;30605.387892242477;50242.49757502378;50606.49393506018;50650.746746266035;50686;50792.492075080256;600789.9802504972;601414;605694.9715251395;606167;607533;31967.520487193175;33489.665103348656;39721;39855.2028959425;40395.394069089576;46940;47568.762156189;47906.76046619745;48483.27275090947;48621.5137848617;38884.805575971935;39752.9405339379;39900.8004959985;41062.17875642411;41333.58666413297;39371.409428858016;39377.803110985406;39481.80259098686;40641;40975.1804963905;37564;38286;38611;38630.8410747678;38696;31101.377972439972;35609.75365862183;36003.099922502144;36805.63194368022;37020.814895925345;22717.659235111158;25463.61804572896;25899.741002590486;25949;26588 09:13:03 INFO - PROCESS | 1648 | |2;jquery.html;366.3259602331711;368.69030014787575;371.946067820166;383.2813474734872;387.1077167129768;19481.123349449274;20792.16831326747;21217.681734773993;21221.045052972615;21464.141434342608;20131.89274589897;20183.29358472454;20735.585288294264;20923.895380523078;21069.94650267488;5892.440218179277;5985.910211346812;5989.85025374367;5995.460408563228;6074.453299203071;4077.55146933837;5963.344032156459;6014.278286605591;6018.729157187915;6403.327650596691;6559;6701.698423570951;6708.865822683543;6713.160854893138;6715.529912906099;5653.4911857932775;5949.137375080589;6002.3697511761075;6028.457438830526;6704.2625311215725;5246.8688282792855;5533.612647114704;5758.7696492140685;5784.248047753807;5826.067829147316;19255.711164332406;24821;25636.743632563623;25829.74170258311;26136.477270454674;2142.207383268201;2154.149111101122;2257.6952111464907;2367.1596583213054;2585.31489155374;9876.60493580256;9988;10611.734706632396;12775.169613975062;15531.990420622624;1846.907654617277;1853.3050106210171;1853.369854249548;1871.0616089739435;1873.0821897270375;117052.41473792662;119473.20790188242;122306.77693223042;122808;124240;11135.331880087058;11270;11316.151288653384;11501.654950351503;11702.648920532398;11687.649370518899;14324.713505729827;14330.140191588538;14342.856571434151;14364.425422982964;6983.301669832976;8106.878396823934;8446.57767111642;8461.323094152453;8590.91409085901;7422.775242084996;8212.548309842896;8416.549214821893;8454.87317690235;8602.87095693565;4377.9124417511475;4467.30756732707;4478.813114524653;4566.086782643484;4572.314152877095;1325.4698120751777;1654.5036489053477;1921.5484361175113;1970.871893326958;2005.0851436877747;787.9874361445515;900.9729708108767;919.2324409118328;950.4724877692809;1004.9296549241483;16388.590285242724;17482.912585436992;20943.790562094488;21528.56942861134;21628.4592885176;929.61885626894;951.8810148731409;956.8421210500189;958.7938593202495;984.4683870709737;10740.087092597218;10904.781904362027;11281.518066025461;11430.942845285721;11486.67903191127;545110;580446;582350;589867;595533;95741.52129239448;132212.3557528844;132296;132432;135994;932.5803388475214;938.4041133880036;960.4237457525569;962.6871266838306;965.3242730088966;14349.282535872955;15458.768118478456;15716.449924252596;17585.736213956545;18989.33537326187;46294.07411851812;47124;54672.7990801383;55214.343569692974;56071.719641403164;80721;82771.29376707226;83880;85031;85426.57286713527;7271.4546409020595;7365.558066516026;7443.36731377839;7489.15412143382;7574.091109066947;9763.267754918268;10076.748081298027;10316.587336506756;11767.764644706887;12857.164284321489;8227.259546640831;9676.83895924759;10334.948325258325;10423.061924426534;10462.319949203582;11380.260283081574;11645.243059201124;11717.88282117168;11837.822432663344;11920;10966.890331096587;11510.712232194262;11863.466144023367;11908.92819646236;11973.401329933642;7598.20218877032;7706.497233039503;8216.507009579444;8216.794580135544;8643.783905402415;8347.666093356198;9092.727218183465;9207.58565864551;11134.109271258118;11300.378479183724 09:13:03 INFO - PROCESS | 1648 | |3;mootools.html;1346.616214378902;1462.4588902106218;1653.9580064559325;1813.5375479252805;1856.0905156473323;7901.644426000829;8360.623771930263;8455.112213217608;8998.595063222163;9008.234300084492;8405.117462666423;8616.267617252526;8690.261327787146;8696.1303869613;8700.695475658353;2343.695319608453;2385.0936644075227;2388.6297623868327;2394.4732158925094;2400.543896659638;2357.1749887539395;2357.976420235793;2402.4834660547976;2402.939926501843;2405.4707964247923;2204.4268490192503;2214.1254204589177;2374.715034195899;2379.0364902214633;2386.1171366594385;1899.705545640428;2243.9775602244013;2262.6492893601517;2276.0099356779856;2364.2268298775916;2357.634566642156;2364.1252736487436;2368.455255291293;2371.6916800815784;2377.191754803358;7283.162436319838;8790.912090879074;8799.736007919773;8821.647134114628;8822.250108740765;5192.688438693653;5316.415194328621;5339.145736682112;5341.973290133564;5411;3083.3370825272673;3487.9476807847905;3535.5580552430947;3675.3568125578186;3679.337719210541;1045.0803293102097;1083.1713738989679;1086.5219303506433;1091.9454027298602;1110.2339385823757;9698.854517182177;11418.771624567462;11600.535978560933;11627.476763545661;11651.708707282385;4551.112533056023;4627.722336659811;4792.880177995578;4825.710457372569;4843.709377437365;8554.272886804567;9629.651848741181;9995.950020249853;10018.699439016842;10040.347377420445;5313.309269794902;5337.973310133424;5342.706151161646;5354.303940487712;5374.3013408256675;4311.676624253194;4698.3187437821325;4830.203016502308;4862.7325497098;4877.219644856806;3357.7481688872945;3388.9152771180425;3898.2983063048355;3996.2407142643387;4063.8577649782114;1077.932846481977;1161.4192903548226;1283.6726634708277;1335.8492826549248;1339.6249050265942;845.9915400845913;883.3330835219497;904.4985324361528;907.1744712311896;912.0651332384359;5600.971995140079;5867.61860479076;5902.085176797603;5944.7324870380935;6084.269887613515;799.8200404908849;943.9008904064974;972.8783902012249;980.2696990741942;992.8709267795285;3895.8636447724193;3980.820863061111;4009.8195581198916;4026.6913253192242;4050.9392359114636;9250.306227033;9995.300328976902;10658.840117398246;10754.56981720738;10792.190585706103;10399.376037437627;10662.680119596425;10699.893001070046;10724.356538607708;10733.83899241512;7965.840683186304;8160.3471722262075;8184.836303273901;8204.753857384288;8290.08809031006;5704.914426283692;5735.54115670737;5759.56803239767;5861.1501332305725;5881;10002.599896004078;10067.798644026932;10075.395476271447;10132.392056476636;10173.389596624227;8465.746027619181;9977.800443990935;10141.239407044648;10206.642767503101;10283.794324113325;6498.74005039812;6868.828279292858;6957.965210173917;7098.29017098286;7135;8439.071702112886;8523.275521580486;8526.82946341082;8533.658653654033;8574.742757717278;6809.557378770364;7428.814279643052;7531.209223031503;7580.620968951641;7690.538567685957;7100.751473698396;7322.450816188701;7394.075740532434;7422.294881986203;7462;6979.162500499972;6992.930070699228;7071.292870712888;7077.82305442368;7091.43268538526;4619.191641462798;4895.7062576245535;4940.407151141886;4960.553550180501;5007.7245751484015;4912.066707325596;4935.210366341368;4935.309056731989;4987.950120498894;4993.325901003318 09:13:03 INFO - PROCESS | 1648 | |4;prototype.html;282.75117896251294;302.4344475830197;316.61689355879395;316.9698878606533;318.1251558214909;5371.623986320949;5522.818486697752;5587.05020146575;5661.943380566198;5748.419184724197;4847.981923796007;5214.530692237698;5639.674676451031;5654.886902261963;5681.403452637475;3734.2344819311975;4316.84891028814;4324.815967936188;4351.303791393378;4369.694121411502;3566.7681600695873;3996.240714264295;4023.7988100595;4367.323064924942;4382.020226246152;4191.727537710054;4252.489701235856;4267.658587313023;4280;4301.892452688677;3549.290141971616;4268.38108474271;4272.636825869805;4277.721948073366;4325.3728209409455;3479.2693534357563;3618.9685939507112;3641.1443310821937;3646.690031347339;3733.8133093345223;4851;5137.768800403991;5484.780608775644;5487.341519017704;5588.720563971826;4159.521655009652;4781.402324709411;4872.878178045542;4884.242942343943;4910.656254062217;4921.360223171001;5701.603107238711;5954.4938680212235;6029.8191054268445;6060.848438796658;3989.6409323160765;3998.3402738548107;4005.959940400588;4018.176273863851;4026.295398305285;5892.292924849003;5980.880382392371;6183.876322473526;6215;6313.747450101991;3839.4432807242792;4005.0588111793704;4042.0703238255364;4044.170944956336;4052.3111071117983;3449.1721986723005;3695.9260814784093;3979.880603581897;4102.487189101363;4127.463429754112;4659.487456379796;4720.33915251865;4847.684900481458;4862.95137048632;4883.267509873547;4737.881552961204;5876.030454974882;5970.432808883149;6082.171790117616;6103.603265787799;1202.991005021616;1229.569650622275;1256.1520973342956;1302.693866941268;1375.8899288056932;778.3345239819986;864.4942708515463;895.3106108296575;935.3499317974079;938.3150300280834;4914.164592019365;5461.453854614507;5514.869451762379;5519.819671229841;5554.666719996813;6062.423170329526;6086.417531441857;6086.665233412116;6093.329733729286;6108.511319094462;4877.951220487821;4901.235555200125;5456.454354564591;5473.989305881749;5494.780208791683;2126.606577783115;2374.3707917401557;2379.5003049359484;2549.171519256249;2629.541378810818;4490.820367185342;5066.923996140061;5119.87200319995;5203.947960520422;5303.36359636846;4306.80619372129;4415.933760993587;4795.832145874878;5143.485651434827;5329.26798790387;4338.945128924767;4920.926186107211;4977.352944117241;5109.926915347744;5295.828710228865;4433.911321773611;4858.319835223142;4999.950000500094;5012.598992080552;5095.974520127375;5009.323741294878;5018.874528136826;5494.725263736877;6141.293751218667;6175.660338681416;5339.97081109176;6329.7151628175925;6332.208473940757;6472;6531.216254049545;3424.880129195466;3568.553930758655;4038.6970977176243;4058.1680755445655;4067.9593204067583;5890.9116363253725;5956.940430595639;6063.756410128281;6140.815775526741;6171.259448866164;5878.647281163144;6008.429199226067;6011.699415029144;6012.458878700763;6023.397660233942;4727.976360118315;4913;5051.812823986434;5951.191237607848;6062.42406971337;4672.859814205579;4741.83403580873;5088.363954505687;5843.561732870136;5888.587798854039;5604.971975140098;5970.820875373745;5995.013316144715;6023.608465449732;6047.395260473917;5117.7717347837;5588.720563971704;5657.151427285776;5917.674527900835;5921.644701317935 09:13:03 INFO - PROCESS | 1648 | |5;yui.html;708.9361957423831;764.7858599592113;768.5465575310569;803.144650946742;850.9489430634164;12863.678408039803;15033.473828416008;15724.449644262468;16027.919860400696;16098.275577599035;14184.432622695105;14308.785368219485;14325.498607548738;14342;14375;828.9544075075869;835.6448509383488;866.8439680857443;876.2770714160811;877.3858299190592;858.6651206029653;863.2877875752498;866.8916385451819;870.6430363550945;873.2751815992742;907.686848037426;917.9127982841653;920.5121285718579;921.0467166482691;921.2491819167391;722.6495149852317;815.9673613055501;842.8862103615994;892.607252808762;896.7802888292377;592.1739173852452;663.1577896071962;669.6618207805076;672.0893189727946;677.9118714567124;15510.302036408277;15533.922330388275;15538.689226215412;15547.989380690218;15565.688686226325;13730.862691373059;13750.381232844546;14128.434862605483;14223.857761422356;14435.607632206424;10155;11664.475098620498;11740.236884602473;12068.456919438646;12336.198147120409;3791.317562838688;3870.845166193349;3948.506436695413;3983.8406463741417;3993.900152496182;119823.80176198213;124186.75813241843;124959.3752031243;125406;125595;11070.833937490945;11073;11216.55133794639;11259.662210133709;11480.253783504046;22401.66397504039;22695.319140425814;22723.88638056799;22734;22734.772652273266;5958.821235362946;6769.661516924134;6880.862382752317;7065.6113913735235;7066.293370662996;4197.9370309445385;4260.211860805761;4267.0825772459075;4295.183915056129;4353.1293741251875;3639.6178401267484;3757.981210093932;3762.097096696773;3762.247550489913;3873.69010479161;636.6530241018563;722.6459035072882;738.7635956493978;739.6708464733142;758.2493331601675;548.7996881138436;597.3339726205337;638.5211091681239;662.5329142954206;671.3823282580038;8247.835043299221;8899.421537600036;9326.440413575207;9453.52732363379;9878.851817222747;538.7360193505154;561.9381867994517;604.1481511069459;607.8419610901109;614.5698011391954;4542.1824071667415;4754.2588993224235;4883.95116048835;5015.523525265094;5349.170878513836;100407;129896;154745;156581;159504;115518.8448115525;126210.36894815651;127663;129884.3505782465;137236;103412.96587034184;110026;111326.44336778265;116046;117583;8436.578171091298;9010.819783604422;9888.357256778287;10028.29801913859;10029.548670309707;48874.511254886995;50658;64527.35472645401;64643;65631.01553476606;71454.64272678603;75250;88532;89339.55330223308;89369.55315223642;12646.367681615699;12865.742685146432;13497.785199332107;13515.797263041259;13697.657558561115;12978.935105324414;14555.68998790114;14847.554573362817;15033.473828415952;15291.033036182218;13890.097143685629;13930.993218986594;13957.860421395657;14103.929480352532;14587;13937.860621393656;14023.36894839755;14039.50861719835;14424.134551926918;14539.927300363854;13644;13896.374663140385;13942.651433714238;14032.719345613235;14374.990692987825;9185.908140918506;11405.315681059163;11418.31490110596;11579;11602.583209140586;8831.602577883883;9806.85289720669;10407.791844163226;11698.2981021139;11757 09:13:03 INFO - PROCESS | 1648 | __end_tp_report 09:13:03 INFO - PROCESS | 1648 | __start_cc_report 09:13:03 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,428 09:13:03 INFO - PROCESS | 1648 | __end_cc_report 09:13:03 INFO - PROCESS | 1648 | __startTimestamp1471882383789__endTimestamp 09:13:03 INFO - PROCESS | 1648 | 09:13:03 INFO - PROCESS | 1648 | ------- Summary: start ------- 09:13:03 INFO - PROCESS | 1648 | Number of tests: 6 09:13:03 INFO - PROCESS | 1648 | 09:13:03 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5872.35 Median:6153.20 stddev:668.71 (10.9%) stddev-sans-first:643.03 09:13:03 INFO - PROCESS | 1648 | Values: 3443.0 3445.7 3454.4 3454.4 3472.0 5366.9 5367.8 5872.9 5916.8 5947.7 5697.9 5829.5 5877.8 5916.7 5982.6 4402.9 5292.2 5393.2 5439.6 5465.7 5339.2 5467.4 5500.7 5504.4 5509.7 5235.5 5387.5 5391.6 5393.1 5421.9 5260.2 5264.2 5306.0 5333.2 5336.3 5260.7 5288.3 5302.7 5395.5 5401.2 5882.9 5920.0 5988.1 6006.2 6013.9 6259.8 6259.9 6280.6 6320.9 6331.3 6383.3 6386.2 6391.1 6398.2 6409.9 5861.1 5961.0 6006.5 6076.4 6097.9 6459.8 6463.5 6474.0 6482.5 6486.7 6280.0 6285.3 6285.7 6329.2 6333.7 6168.3 6234.4 6281.7 6344.8 6364.1 6153.2 6221.9 6229.3 6258.0 6288.0 6237.4 6263.4 6289.4 6291.0 6292.6 4984.5 5115.7 5131.1 5137.1 5149.2 4250.9 4355.7 4528.3 4535.8 4568.4 5958.8 6046.9 6067.9 6078.3 6086.1 6172.8 6416.5 6419.8 6422.5 6425.9 5913.1 5961.6 5986.9 6036.9 6067.5 5591.3 5607.6 5616.3 5625.4 5632.1 6217.0 6538.0 6597.7 6619.4 6622.6 5291.4 6293.8 6320.9 6361.2 6380.3 6479.4 6521.6 6531.4 6532.5 6553.0 6191.4 6319.4 6328.1 6332.7 6338.9 6255.7 6262.8 6312.2 6352.9 6355.3 6211.4 6252.9 6258.7 6267.2 6295.3 6090.7 6238.2 6307.6 6312.3 6326.6 4754.0 5659.8 6135.5 6235.4 6261.3 6247.8 6266.8 6273.8 6277.5 6292.5 4992.4 6116.2 6195.8 6242.4 6252.2 09:13:03 INFO - PROCESS | 1648 | 09:13:03 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:73732.62 Median:20859.62 stddev:162642.26 (779.7%) stddev-sans-first:163005.60 09:13:03 INFO - PROCESS | 1648 | Values: 509.4 531.0 534.4 564.1 575.4 37907.6 38575.2 40198.0 40265.0 40323.0 41452.4 41572.2 42225.7 42298.0 42413.8 8386.9 8662.9 11747.6 12018.5 12077.6 11792.5 11859.5 11916.9 11917.3 11923.7 11913.2 11956.3 11972.9 11974.3 12007.3 11832.4 11883.6 11893.4 11917.6 11944.1 11913.3 11923.2 11939.2 11992.9 12015.4 40158.6 40508.4 40615.2 40640.2 40692.6 3033.6 3585.1 3587.7 3811.6 3950.3 31802.2 32389.2 32595.5 32653.3 33126.5 2876.4 3163.7 3227.4 3265.6 3344.8 521488.0 527173.0 528370.0 528397.0 530514.0 58018.7 58038.0 58190.7 58215.4 58478.0 60505.0 60732.4 60752.7 60860.5 61038.0 14550.7 15945.7 16261.5 16488.9 16510.3 11984.9 12122.7 12805.8 13010.4 13022.1 13224.0 15320.4 15340.8 15352.3 15475.2 7161.2 7246.3 7255.9 7311.0 7352.2 864.4 875.2 979.8 982.7 1089.5 29323.7 30257.2 30282.4 30301.8 31340.8 1050.7 1051.4 1077.4 1079.3 1095.4 13720.9 14882.6 15856.6 15862.7 15906.0 667723.0 681090.0 687622.0 688653.0 691608.6 45333.8 58372.7 58419.4 58558.4 58684.4 1159.8 1284.1 1342.8 1366.0 1377.6 29910.0 30157.5 30160.8 30437.1 30605.4 50242.5 50606.5 50650.7 50686.0 50792.5 600790.0 601414.0 605695.0 606167.0 607533.0 31967.5 33489.7 39721.0 39855.2 40395.4 46940.0 47568.8 47906.8 48483.3 48621.5 38884.8 39752.9 39900.8 41062.2 41333.6 39371.4 39377.8 39481.8 40641.0 40975.2 37564.0 38286.0 38611.0 38630.8 38696.0 31101.4 35609.8 36003.1 36805.6 37020.8 22717.7 25463.6 25899.7 25949.0 26588.0 09:13:03 INFO - PROCESS | 1648 | 09:13:03 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:34455.60 Median:385.19 stddev:96966.86 (25173.5%) stddev-sans-first:97205.09 09:13:03 INFO - PROCESS | 1648 | Values: 366.3 368.7 371.9 383.3 387.1 19481.1 20792.2 21217.7 21221.0 21464.1 20131.9 20183.3 20735.6 20923.9 21069.9 5892.4 5985.9 5989.9 5995.5 6074.5 4077.6 5963.3 6014.3 6018.7 6403.3 6559.0 6701.7 6708.9 6713.2 6715.5 5653.5 5949.1 6002.4 6028.5 6704.3 5246.9 5533.6 5758.8 5784.2 5826.1 19255.7 24821.0 25636.7 25829.7 26136.5 2142.2 2154.1 2257.7 2367.2 2585.3 9876.6 9988.0 10611.7 12775.2 15532.0 1846.9 1853.3 1853.4 1871.1 1873.1 117052.4 119473.2 122306.8 122808.0 124240.0 11135.3 11270.0 11316.2 11501.7 11702.6 11687.6 14324.7 14330.1 14342.9 14364.4 6983.3 8106.9 8446.6 8461.3 8590.9 7422.8 8212.5 8416.5 8454.9 8602.9 4377.9 4467.3 4478.8 4566.1 4572.3 1325.5 1654.5 1921.5 1970.9 2005.1 788.0 901.0 919.2 950.5 1004.9 16388.6 17482.9 20943.8 21528.6 21628.5 929.6 951.9 956.8 958.8 984.5 10740.1 10904.8 11281.5 11430.9 11486.7 545110.0 580446.0 582350.0 589867.0 595533.0 95741.5 132212.4 132296.0 132432.0 135994.0 932.6 938.4 960.4 962.7 965.3 14349.3 15458.8 15716.4 17585.7 18989.3 46294.1 47124.0 54672.8 55214.3 56071.7 80721.0 82771.3 83880.0 85031.0 85426.6 7271.5 7365.6 7443.4 7489.2 7574.1 9763.3 10076.7 10316.6 11767.8 12857.2 8227.3 9676.8 10334.9 10423.1 10462.3 11380.3 11645.2 11717.9 11837.8 11920.0 10966.9 11510.7 11863.5 11908.9 11973.4 7598.2 7706.5 8216.5 8216.8 8643.8 8347.7 9092.7 9207.6 11134.1 11300.4 09:13:03 INFO - PROCESS | 1648 | 09:13:03 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:5639.34 Median:4935.26 stddev:3140.36 (63.6%) stddev-sans-first:3132.60 09:13:03 INFO - PROCESS | 1648 | Values: 1346.6 1462.5 1654.0 1813.5 1856.1 7901.6 8360.6 8455.1 8998.6 9008.2 8405.1 8616.3 8690.3 8696.1 8700.7 2343.7 2385.1 2388.6 2394.5 2400.5 2357.2 2358.0 2402.5 2402.9 2405.5 2204.4 2214.1 2374.7 2379.0 2386.1 1899.7 2244.0 2262.6 2276.0 2364.2 2357.6 2364.1 2368.5 2371.7 2377.2 7283.2 8790.9 8799.7 8821.6 8822.3 5192.7 5316.4 5339.1 5342.0 5411.0 3083.3 3487.9 3535.6 3675.4 3679.3 1045.1 1083.2 1086.5 1091.9 1110.2 9698.9 11418.8 11600.5 11627.5 11651.7 4551.1 4627.7 4792.9 4825.7 4843.7 8554.3 9629.7 9996.0 10018.7 10040.3 5313.3 5338.0 5342.7 5354.3 5374.3 4311.7 4698.3 4830.2 4862.7 4877.2 3357.7 3388.9 3898.3 3996.2 4063.9 1077.9 1161.4 1283.7 1335.8 1339.6 846.0 883.3 904.5 907.2 912.1 5601.0 5867.6 5902.1 5944.7 6084.3 799.8 943.9 972.9 980.3 992.9 3895.9 3980.8 4009.8 4026.7 4050.9 9250.3 9995.3 10658.8 10754.6 10792.2 10399.4 10662.7 10699.9 10724.4 10733.8 7965.8 8160.3 8184.8 8204.8 8290.1 5704.9 5735.5 5759.6 5861.2 5881.0 10002.6 10067.8 10075.4 10132.4 10173.4 8465.7 9977.8 10141.2 10206.6 10283.8 6498.7 6868.8 6958.0 7098.3 7135.0 8439.1 8523.3 8526.8 8533.7 8574.7 6809.6 7428.8 7531.2 7580.6 7690.5 7100.8 7322.5 7394.1 7422.3 7462.0 6979.2 6992.9 7071.3 7077.8 7091.4 4619.2 4895.7 4940.4 4960.6 5007.7 4912.1 4935.2 4935.3 4988.0 4993.3 09:13:03 INFO - PROCESS | 1648 | 09:13:03 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4628.63 Median:5004.64 stddev:1462.72 (29.2%) stddev-sans-first:1429.99 09:13:03 INFO - PROCESS | 1648 | Values: 282.8 302.4 316.6 317.0 318.1 5371.6 5522.8 5587.1 5661.9 5748.4 4848.0 5214.5 5639.7 5654.9 5681.4 3734.2 4316.8 4324.8 4351.3 4369.7 3566.8 3996.2 4023.8 4367.3 4382.0 4191.7 4252.5 4267.7 4280.0 4301.9 3549.3 4268.4 4272.6 4277.7 4325.4 3479.3 3619.0 3641.1 3646.7 3733.8 4851.0 5137.8 5484.8 5487.3 5588.7 4159.5 4781.4 4872.9 4884.2 4910.7 4921.4 5701.6 5954.5 6029.8 6060.8 3989.6 3998.3 4006.0 4018.2 4026.3 5892.3 5980.9 6183.9 6215.0 6313.7 3839.4 4005.1 4042.1 4044.2 4052.3 3449.2 3695.9 3979.9 4102.5 4127.5 4659.5 4720.3 4847.7 4863.0 4883.3 4737.9 5876.0 5970.4 6082.2 6103.6 1203.0 1229.6 1256.2 1302.7 1375.9 778.3 864.5 895.3 935.3 938.3 4914.2 5461.5 5514.9 5519.8 5554.7 6062.4 6086.4 6086.7 6093.3 6108.5 4878.0 4901.2 5456.5 5474.0 5494.8 2126.6 2374.4 2379.5 2549.2 2629.5 4490.8 5066.9 5119.9 5203.9 5303.4 4306.8 4415.9 4795.8 5143.5 5329.3 4338.9 4920.9 4977.4 5109.9 5295.8 4433.9 4858.3 5000.0 5012.6 5096.0 5009.3 5018.9 5494.7 6141.3 6175.7 5340.0 6329.7 6332.2 6472.0 6531.2 3424.9 3568.6 4038.7 4058.2 4068.0 5890.9 5956.9 6063.8 6140.8 6171.3 5878.6 6008.4 6011.7 6012.5 6023.4 4728.0 4913.0 5051.8 5951.2 6062.4 4672.9 4741.8 5088.4 5843.6 5888.6 5605.0 5970.8 5995.0 6023.6 6047.4 5117.8 5588.7 5657.2 5917.7 5921.6 09:13:03 INFO - PROCESS | 1648 | 09:13:03 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:24723.76 Median:3760.04 stddev:39514.42 (1050.9%) stddev-sans-first:39584.13 09:13:03 INFO - PROCESS | 1648 | Values: 708.9 764.8 768.5 803.1 850.9 12863.7 15033.5 15724.4 16027.9 16098.3 14184.4 14308.8 14325.5 14342.0 14375.0 829.0 835.6 866.8 876.3 877.4 858.7 863.3 866.9 870.6 873.3 907.7 917.9 920.5 921.0 921.2 722.6 816.0 842.9 892.6 896.8 592.2 663.2 669.7 672.1 677.9 15510.3 15533.9 15538.7 15548.0 15565.7 13730.9 13750.4 14128.4 14223.9 14435.6 10155.0 11664.5 11740.2 12068.5 12336.2 3791.3 3870.8 3948.5 3983.8 3993.9 119823.8 124186.8 124959.4 125406.0 125595.0 11070.8 11073.0 11216.6 11259.7 11480.3 22401.7 22695.3 22723.9 22734.0 22734.8 5958.8 6769.7 6880.9 7065.6 7066.3 4197.9 4260.2 4267.1 4295.2 4353.1 3639.6 3758.0 3762.1 3762.2 3873.7 636.7 722.6 738.8 739.7 758.2 548.8 597.3 638.5 662.5 671.4 8247.8 8899.4 9326.4 9453.5 9878.9 538.7 561.9 604.1 607.8 614.6 4542.2 4754.3 4884.0 5015.5 5349.2 100407.0 129896.0 154745.0 156581.0 159504.0 115518.8 126210.4 127663.0 129884.4 137236.0 103413.0 110026.0 111326.4 116046.0 117583.0 8436.6 9010.8 9888.4 10028.3 10029.5 48874.5 50658.0 64527.4 64643.0 65631.0 71454.6 75250.0 88532.0 89339.6 89369.6 12646.4 12865.7 13497.8 13515.8 13697.7 12978.9 14555.7 14847.6 15033.5 15291.0 13890.1 13931.0 13957.9 14103.9 14587.0 13937.9 14023.4 14039.5 14424.1 14539.9 13644.0 13896.4 13942.7 14032.7 14375.0 9185.9 11405.3 11418.3 11579.0 11602.6 8831.6 9806.9 10407.8 11698.3 11757.0 09:13:03 INFO - PROCESS | 1648 | -------- Summary: end -------- 09:13:03 INFO - PROCESS | 1648 | 09:13:04 INFO - TEST-INFO | 1648: exit 0 09:13:04 INFO - TEST-OK | dromaeo_css | took 1113846ms 09:13:04 INFO - TEST-START | kraken 09:13:04 INFO - operating with platform_type : mac_ 09:13:04 INFO - Initialising browser for kraken test... 09:13:04 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/tmp2r4LM6/profile http://localhost:49275/getInfo.html) 09:13:07 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 09:13:07 INFO - PROCESS | 1657 | colorDepth:24 09:13:07 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 09:13:07 INFO - PROCESS | 1657 | __metrics 09:13:07 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3061: TypeError: this.tabs is undefined 09:13:07 INFO - TEST-INFO | 1657: exit 0 09:13:07 INFO - Browser initialized. 09:13:07 INFO - Running cycle 1/1 for kraken test... 09:13:07 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/tmp2r4LM6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:13:19 INFO - PROCESS | 1659 | RSS: Main: 239751168 09:13:19 INFO - PROCESS | 1659 | 09:13:22 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 09:13:23 INFO - PROCESS | 1659 | RSS: Main: 252772352 09:13:23 INFO - PROCESS | 1659 | 09:13:26 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 09:13:26 INFO - PROCESS | 1659 | RSS: Main: 261525504 09:13:26 INFO - PROCESS | 1659 | 09:13:30 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 09:13:30 INFO - PROCESS | 1659 | RSS: Main: 264245248 09:13:30 INFO - PROCESS | 1659 | 09:13:33 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 09:13:33 INFO - PROCESS | 1659 | RSS: Main: 266616832 09:13:33 INFO - PROCESS | 1659 | 09:13:35 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:13:36 INFO - PROCESS | 1659 | RSS: Main: 267038720 09:13:36 INFO - PROCESS | 1659 | 09:13:39 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 09:13:39 INFO - PROCESS | 1659 | RSS: Main: 268083200 09:13:39 INFO - PROCESS | 1659 | 09:13:43 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 09:13:43 INFO - PROCESS | 1659 | RSS: Main: 268345344 09:13:43 INFO - PROCESS | 1659 | 09:13:46 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 09:13:47 INFO - PROCESS | 1659 | RSS: Main: 268419072 09:13:47 INFO - PROCESS | 1659 | 09:13:48 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:13:49 INFO - PROCESS | 1659 | RSS: Main: 268197888 09:13:49 INFO - PROCESS | 1659 | 09:13:51 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:13:52 INFO - PROCESS | 1659 | RSS: Main: 267726848 09:13:52 INFO - PROCESS | 1659 | 09:13:54 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:13:54 INFO - PROCESS | 1659 | RSS: Main: 268005376 09:13:54 INFO - PROCESS | 1659 | 09:13:57 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:13:58 INFO - PROCESS | 1659 | RSS: Main: 268005376 09:13:58 INFO - PROCESS | 1659 | 09:14:01 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:14:02 INFO - PROCESS | 1659 | RSS: Main: 268038144 09:14:02 INFO - PROCESS | 1659 | 09:14:03 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 09:14:03 INFO - PROCESS | 1659 | RSS: Main: 269631488 09:14:03 INFO - PROCESS | 1659 | 09:14:03 INFO - PROCESS | 1659 | __start_tp_report 09:14:03 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 09:14:03 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 09:14:03 INFO - PROCESS | 1659 | |i|pagename|runs| 09:14:03 INFO - PROCESS | 1659 | |0;ai-astar;107;116;109;117;117;117;118;117;116;117 09:14:03 INFO - PROCESS | 1659 | |1;audio-beat-detection;138;108;131;157;112;133;141;146;186;110 09:14:03 INFO - PROCESS | 1659 | |2;audio-dft;197;200;195;220;187;273;280;192;274;281 09:14:03 INFO - PROCESS | 1659 | |3;audio-fft;69;84;75;140;98;83;88;54;145;84 09:14:03 INFO - PROCESS | 1659 | |4;audio-oscillator;73;72;129;71;73;76;109;72;73;113 09:14:03 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;89;77;137;131;89;85;88;113;88;85 09:14:03 INFO - PROCESS | 1659 | |6;imaging-darkroom;138;153;97;151;124;147;152;96;98;95 09:14:03 INFO - PROCESS | 1659 | |7;imaging-desaturate;92;94;90;91;96;101;137;91;101;92 09:14:03 INFO - PROCESS | 1659 | |8;json-parse-financial;58;60;59;57;62;57;58;60;58;58 09:14:03 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;66;69;69;76;75;72;68;71;70;73 09:14:03 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;87;86;87;88;85;88;88;90;92;92 09:14:03 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;162;151;150;139;142;159;148;138;159;165 09:14:03 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;171;176;174;172;173;169;172;173;176;171 09:14:03 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;70;68;69;77;73;68;69;69;67;71 09:14:03 INFO - PROCESS | 1659 | __end_tp_report 09:14:03 INFO - PROCESS | 1659 | __start_cc_report 09:14:03 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1081 09:14:03 INFO - PROCESS | 1659 | __end_cc_report 09:14:03 INFO - PROCESS | 1659 | __startTimestamp1471882443965__endTimestamp 09:14:03 INFO - PROCESS | 1659 | 09:14:03 INFO - PROCESS | 1659 | ------- Summary: start ------- 09:14:03 INFO - PROCESS | 1659 | Number of tests: 14 09:14:03 INFO - PROCESS | 1659 | 09:14:03 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:115.10 Median:117.00 stddev:3.81 (3.3%) stddev-sans-first:2.69 09:14:03 INFO - PROCESS | 1659 | Values: 107.0 116.0 109.0 117.0 117.0 117.0 118.0 117.0 116.0 117.0 09:14:03 INFO - PROCESS | 1659 | 09:14:03 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:139.50 stddev:23.90 (17.1%) stddev-sans-first:25.34 09:14:03 INFO - PROCESS | 1659 | Values: 138.0 108.0 131.0 157.0 112.0 133.0 141.0 146.0 186.0 110.0 09:14:03 INFO - PROCESS | 1659 | 09:14:03 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:229.90 Median:246.50 stddev:41.49 (16.8%) stddev-sans-first:42.26 09:14:03 INFO - PROCESS | 1659 | Values: 197.0 200.0 195.0 220.0 187.0 273.0 280.0 192.0 274.0 281.0 09:14:03 INFO - PROCESS | 1659 | 09:14:03 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:92.00 Median:83.50 stddev:29.13 (34.9%) stddev-sans-first:29.68 09:14:03 INFO - PROCESS | 1659 | Values: 69.0 84.0 75.0 140.0 98.0 83.0 88.0 54.0 145.0 84.0 09:14:03 INFO - PROCESS | 1659 | 09:14:03 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:86.10 Median:72.50 stddev:21.94 (30.3%) stddev-sans-first:22.75 09:14:03 INFO - PROCESS | 1659 | Values: 73.0 72.0 129.0 71.0 73.0 76.0 109.0 72.0 73.0 113.0 09:14:03 INFO - PROCESS | 1659 | 09:14:03 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:98.20 Median:86.50 stddev:21.02 (24.3%) stddev-sans-first:22.03 09:14:03 INFO - PROCESS | 1659 | Values: 89.0 77.0 137.0 131.0 89.0 85.0 88.0 113.0 88.0 85.0 09:14:03 INFO - PROCESS | 1659 | 09:14:03 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:125.10 Median:124.00 stddev:26.03 (21.0%) stddev-sans-first:27.18 09:14:03 INFO - PROCESS | 1659 | Values: 138.0 153.0 97.0 151.0 124.0 147.0 152.0 96.0 98.0 95.0 09:14:03 INFO - PROCESS | 1659 | 09:14:03 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:98.50 Median:91.50 stddev:14.10 (15.4%) stddev-sans-first:14.76 09:14:03 INFO - PROCESS | 1659 | Values: 92.0 94.0 90.0 91.0 96.0 101.0 137.0 91.0 101.0 92.0 09:14:03 INFO - PROCESS | 1659 | 09:14:03 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:58.50 stddev:1.57 (2.7%) stddev-sans-first:1.64 09:14:03 INFO - PROCESS | 1659 | Values: 58.0 60.0 59.0 57.0 62.0 57.0 58.0 60.0 58.0 58.0 09:14:03 INFO - PROCESS | 1659 | 09:14:03 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:71.50 stddev:3.14 (4.4%) stddev-sans-first:2.79 09:14:03 INFO - PROCESS | 1659 | Values: 66.0 69.0 69.0 76.0 75.0 72.0 68.0 71.0 70.0 73.0 09:14:03 INFO - PROCESS | 1659 | 09:14:03 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:88.00 stddev:2.36 (2.7%) stddev-sans-first:2.46 09:14:03 INFO - PROCESS | 1659 | Values: 87.0 86.0 87.0 88.0 85.0 88.0 88.0 90.0 92.0 92.0 09:14:03 INFO - PROCESS | 1659 | 09:14:03 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:151.30 Median:155.00 stddev:9.71 (6.3%) stddev-sans-first:9.49 09:14:03 INFO - PROCESS | 1659 | Values: 162.0 151.0 150.0 139.0 142.0 159.0 148.0 138.0 159.0 165.0 09:14:03 INFO - PROCESS | 1659 | 09:14:03 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:173.00 stddev:2.21 (1.3%) stddev-sans-first:2.26 09:14:03 INFO - PROCESS | 1659 | Values: 171.0 176.0 174.0 172.0 173.0 169.0 172.0 173.0 176.0 171.0 09:14:03 INFO - PROCESS | 1659 | 09:14:03 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:69.50 stddev:2.96 (4.3%) stddev-sans-first:3.14 09:14:03 INFO - PROCESS | 1659 | Values: 70.0 68.0 69.0 77.0 73.0 68.0 69.0 69.0 67.0 71.0 09:14:03 INFO - PROCESS | 1659 | -------- Summary: end -------- 09:14:03 INFO - PROCESS | 1659 | 09:14:04 INFO - TEST-INFO | 1659: exit 0 09:14:04 INFO - TEST-OK | kraken | took 60293ms 09:14:04 INFO - SUITE-END | took 1174s 09:14:05 INFO - Completed test suite (00:19:34) 09:14:05 INFO - javascript benchmark 09:14:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7433.398285063829, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3442.965570344297, 3445.672661097195, 3454.4300190468575, 3454.447288433851, 3471.965280347196, 5366.865828354288, 5367.838964831057, 5872.853178670535, 5916.822495325147, 5947.702614869261, 5697.914531282024, 5829.504492118164, 5877.794277200299, 5916.704164791765, 5982.641041537511, 4402.889927751799, 5292.206169074631, 5393.217983392406, 5439.5920305977015, 5465.672059676433, 5339.22581225722, 5467.398586155519, 5500.669959802424, 5504.394516603171, 5509.669419834802, 5235.476452354772, 5387.4612538746005, 5391.649542779746, 5393.056215162331, 5421.864453388657, 5260.210968354739, 5264.236685680555, 5306.0, 5333.226682131108, 5336.252924590522, 5260.684358938476, 5288.338957630296, 5302.708351040691, 5395.460453954613, 5401.162819762943, 5882.882342353172, 5920.0231961726695, 5988.131720900445, 6006.21919150512, 6013.939860601426, 6259.78090766821, 6259.874802503924, 6280.560360774748, 6320.873582528324, 6331.303556608769, 6383.329750376237, 6386.201724784402, 6391.105245265667, 6398.200224971879, 6409.93590064098, 5861.062230043172, 5961.016432288624, 6006.489448396936, 6076.392360763933, 6097.944866663664, 6459.773907913201, 6463.547551671432, 6474.0, 6482.481401487869, 6486.67566621667, 6280.026595877646, 6285.277193122758, 6285.748570057238, 6329.177206963065, 6333.746650134035, 6168.321484636686, 6234.376562343729, 6281.7173227204885, 6344.777932772331, 6364.109024736541, 6153.2000839890525, 6221.9377806222265, 6229.314775374705, 6257.998720204836, 6287.96856015717, 6237.376262373817, 6263.4362907337645, 6289.40250676185, 6290.968545157337, 6292.559520833589, 4984.501549845059, 5115.74421278942, 5131.102057139986, 5137.0753264412015, 5149.150390185652, 4250.893727656833, 4355.73865568067, 4528.320751887243, 4535.818567257339, 4568.428946381702, 5958.821235362946, 6046.941785187574, 6067.908981365283, 6078.331383547807, 6086.056661217518, 6172.845678857974, 6416.486681065504, 6419.807405777834, 6422.4862011039, 6425.935740642533, 5913.113033045078, 5961.612495187799, 5986.910196347058, 6036.939630603725, 6067.544934129958, 5591.273134492571, 5607.607467477237, 5616.269884914935, 5625.38120806711, 5632.127020311858, 6217.0, 6538.0, 6597.703103360456, 6619.371159739817, 6622.602643841385, 5291.444398338119, 6293.811185664437, 6320.905186422299, 6361.2048493938255, 6380.266269379081, 6479.449246813885, 6521.608703477807, 6531.379518945692, 6532.477401807749, 6553.036736569698, 6191.442770150708, 6319.368063193644, 6328.145700330397, 6332.683365831598, 6338.873222535616, 6255.655938923221, 6262.780802671885, 6312.242530896322, 6352.936470635234, 6355.269144048493, 6211.440970312694, 6252.874942501034, 6258.718357674006, 6267.247930248217, 6295.338989406229, 6090.69546522681, 6238.220222472191, 6307.621542707452, 6312.3056463788025, 6326.588771729823, 4754.0016596515115, 5659.830205093854, 6135.53983451234, 6235.376462353728, 6261.279952805304, 6247.843803904757, 6266.811995640138, 6273.811785646438, 6277.529185311028, 6292.52806039558, 4992.425871024733, 6116.235470566179, 6195.752169913333, 6242.438180563771, 6252.218472690914], "value": 5830.407511177839, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.44979422224003, 530.9893802123958, 534.4254925954599, 564.0974440894569, 575.3584753000406, 37907.62092379079, 38575.22849543011, 40197.995050123725, 40265.0, 40323.0, 41452.37821432681, 41572.16855662885, 42225.733228003206, 42298.0, 42413.78793106038, 8386.87419688705, 8662.913370866305, 11747.588834390797, 12018.4591693374, 12077.637670869888, 11792.528298868036, 11859.52561897523, 11916.940415297911, 11917.344546049964, 11923.701907452296, 11913.225640333394, 11956.282623042602, 11972.880271197264, 11974.281543107398, 12007.279563226235, 11832.40837958103, 11883.58407455735, 11893.405329733565, 11917.642470725892, 11944.104192185534, 11913.344766037864, 11923.224990375598, 11939.223950443193, 11992.880071199264, 12015.39923003855, 40158.59841401578, 40508.39237411412, 40615.187696246205, 40640.18719625621, 40692.59307406918, 3033.620797400325, 3585.0858031202138, 3587.712982961357, 3811.6188381161937, 3950.2889479893606, 31802.204944876332, 32389.190270243198, 32595.51106733401, 32653.346933061443, 33126.503102453484, 2876.4103358811394, 3163.73108285796, 3227.4351988402173, 3265.6081270247723, 3344.782589131723, 521488.0, 527173.0, 528370.0, 528397.0, 530514.0, 58018.709906450196, 58038.0, 58190.709046454496, 58215.417845821845, 58478.0, 60505.0, 60732.392676072675, 60752.69623651853, 60860.478488038156, 61038.0, 14550.708985820436, 15945.681086378207, 16261.51215463538, 16488.928219665682, 16510.257038433298, 11984.940075299568, 12122.666506684258, 12805.807912881315, 13010.414531346112, 13022.088453808143, 13224.0, 15320.387184512718, 15340.846591534166, 15352.309146088453, 15475.226238688021, 7161.242921475269, 7246.347828695442, 7255.854882902312, 7310.989477893516, 7352.19125896151, 864.4078806017898, 875.2429148786254, 979.8334283171878, 982.729749318943, 1089.5206109311878, 29323.706762932525, 30257.24356891095, 30282.394352112835, 30301.848490757406, 31340.843295783376, 1050.6532844161409, 1051.353417648141, 1077.4128100185417, 1079.266099052636, 1095.381109673048, 13720.8884272759, 14882.627934301729, 15856.603584910239, 15862.682746345008, 15906.0, 667723.0, 681090.0, 687622.0, 688653.0, 691608.6258706123, 45333.77333113313, 58372.70813645905, 58419.41580584225, 58558.414415855295, 58684.41315586789, 1159.756451145252, 1284.0882973089024, 1342.7717288061053, 1365.9726805463836, 1377.5522955039453, 29910.0, 30157.547636785028, 30160.7935682579, 30437.08688739253, 30605.387892242477, 50242.49757502378, 50606.49393506018, 50650.746746266035, 50686.0, 50792.492075080256, 600789.9802504972, 601414.0, 605694.9715251395, 606167.0, 607533.0, 31967.520487193175, 33489.665103348656, 39721.0, 39855.2028959425, 40395.394069089576, 46940.0, 47568.762156189, 47906.76046619745, 48483.27275090947, 48621.5137848617, 38884.805575971935, 39752.9405339379, 39900.8004959985, 41062.17875642411, 41333.58666413297, 39371.409428858016, 39377.803110985406, 39481.80259098686, 40641.0, 40975.1804963905, 37564.0, 38286.0, 38611.0, 38630.8410747678, 38696.0, 31101.377972439972, 35609.75365862183, 36003.099922502144, 36805.63194368022, 37020.814895925345, 22717.659235111158, 25463.61804572896, 25899.741002590486, 25949.0, 26588.0], "value": 20736.898644351302, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.3259602331711, 368.69030014787575, 371.946067820166, 383.2813474734872, 387.1077167129768, 19481.123349449274, 20792.16831326747, 21217.681734773993, 21221.045052972615, 21464.141434342608, 20131.89274589897, 20183.29358472454, 20735.585288294264, 20923.895380523078, 21069.94650267488, 5892.440218179277, 5985.910211346812, 5989.85025374367, 5995.460408563228, 6074.453299203071, 4077.55146933837, 5963.344032156459, 6014.278286605591, 6018.729157187915, 6403.327650596691, 6559.0, 6701.698423570951, 6708.865822683543, 6713.160854893138, 6715.529912906099, 5653.4911857932775, 5949.137375080589, 6002.3697511761075, 6028.457438830526, 6704.2625311215725, 5246.8688282792855, 5533.612647114704, 5758.7696492140685, 5784.248047753807, 5826.067829147316, 19255.711164332406, 24821.0, 25636.743632563623, 25829.74170258311, 26136.477270454674, 2142.207383268201, 2154.149111101122, 2257.6952111464907, 2367.1596583213054, 2585.31489155374, 9876.60493580256, 9988.0, 10611.734706632396, 12775.169613975062, 15531.990420622624, 1846.907654617277, 1853.3050106210171, 1853.369854249548, 1871.0616089739435, 1873.0821897270375, 117052.41473792662, 119473.20790188242, 122306.77693223042, 122808.0, 124240.0, 11135.331880087058, 11270.0, 11316.151288653384, 11501.654950351503, 11702.648920532398, 11687.649370518899, 14324.713505729827, 14330.140191588538, 14342.856571434151, 14364.425422982964, 6983.301669832976, 8106.878396823934, 8446.57767111642, 8461.323094152453, 8590.91409085901, 7422.775242084996, 8212.548309842896, 8416.549214821893, 8454.87317690235, 8602.87095693565, 4377.9124417511475, 4467.30756732707, 4478.813114524653, 4566.086782643484, 4572.314152877095, 1325.4698120751777, 1654.5036489053477, 1921.5484361175113, 1970.871893326958, 2005.0851436877747, 787.9874361445515, 900.9729708108767, 919.2324409118328, 950.4724877692809, 1004.9296549241483, 16388.590285242724, 17482.912585436992, 20943.790562094488, 21528.56942861134, 21628.4592885176, 929.61885626894, 951.8810148731409, 956.8421210500189, 958.7938593202495, 984.4683870709737, 10740.087092597218, 10904.781904362027, 11281.518066025461, 11430.942845285721, 11486.67903191127, 545110.0, 580446.0, 582350.0, 589867.0, 595533.0, 95741.52129239448, 132212.3557528844, 132296.0, 132432.0, 135994.0, 932.5803388475214, 938.4041133880036, 960.4237457525569, 962.6871266838306, 965.3242730088966, 14349.282535872955, 15458.768118478456, 15716.449924252596, 17585.736213956545, 18989.33537326187, 46294.07411851812, 47124.0, 54672.7990801383, 55214.343569692974, 56071.719641403164, 80721.0, 82771.29376707226, 83880.0, 85031.0, 85426.57286713527, 7271.4546409020595, 7365.558066516026, 7443.36731377839, 7489.15412143382, 7574.091109066947, 9763.267754918268, 10076.748081298027, 10316.587336506756, 11767.764644706887, 12857.164284321489, 8227.259546640831, 9676.83895924759, 10334.948325258325, 10423.061924426534, 10462.319949203582, 11380.260283081574, 11645.243059201124, 11717.88282117168, 11837.822432663344, 11920.0, 10966.890331096587, 11510.712232194262, 11863.466144023367, 11908.92819646236, 11973.401329933642, 7598.20218877032, 7706.497233039503, 8216.507009579444, 8216.794580135544, 8643.783905402415, 8347.666093356198, 9092.727218183465, 9207.58565864551, 11134.109271258118, 11300.378479183724], "value": 9443.976093382822, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.616214378902, 1462.4588902106218, 1653.9580064559325, 1813.5375479252805, 1856.0905156473323, 7901.644426000829, 8360.623771930263, 8455.112213217608, 8998.595063222163, 9008.234300084492, 8405.117462666423, 8616.267617252526, 8690.261327787146, 8696.1303869613, 8700.695475658353, 2343.695319608453, 2385.0936644075227, 2388.6297623868327, 2394.4732158925094, 2400.543896659638, 2357.1749887539395, 2357.976420235793, 2402.4834660547976, 2402.939926501843, 2405.4707964247923, 2204.4268490192503, 2214.1254204589177, 2374.715034195899, 2379.0364902214633, 2386.1171366594385, 1899.705545640428, 2243.9775602244013, 2262.6492893601517, 2276.0099356779856, 2364.2268298775916, 2357.634566642156, 2364.1252736487436, 2368.455255291293, 2371.6916800815784, 2377.191754803358, 7283.162436319838, 8790.912090879074, 8799.736007919773, 8821.647134114628, 8822.250108740765, 5192.688438693653, 5316.415194328621, 5339.145736682112, 5341.973290133564, 5411.0, 3083.3370825272673, 3487.9476807847905, 3535.5580552430947, 3675.3568125578186, 3679.337719210541, 1045.0803293102097, 1083.1713738989679, 1086.5219303506433, 1091.9454027298602, 1110.2339385823757, 9698.854517182177, 11418.771624567462, 11600.535978560933, 11627.476763545661, 11651.708707282385, 4551.112533056023, 4627.722336659811, 4792.880177995578, 4825.710457372569, 4843.709377437365, 8554.272886804567, 9629.651848741181, 9995.950020249853, 10018.699439016842, 10040.347377420445, 5313.309269794902, 5337.973310133424, 5342.706151161646, 5354.303940487712, 5374.3013408256675, 4311.676624253194, 4698.3187437821325, 4830.203016502308, 4862.7325497098, 4877.219644856806, 3357.7481688872945, 3388.9152771180425, 3898.2983063048355, 3996.2407142643387, 4063.8577649782114, 1077.932846481977, 1161.4192903548226, 1283.6726634708277, 1335.8492826549248, 1339.6249050265942, 845.9915400845913, 883.3330835219497, 904.4985324361528, 907.1744712311896, 912.0651332384359, 5600.971995140079, 5867.61860479076, 5902.085176797603, 5944.7324870380935, 6084.269887613515, 799.8200404908849, 943.9008904064974, 972.8783902012249, 980.2696990741942, 992.8709267795285, 3895.8636447724193, 3980.820863061111, 4009.8195581198916, 4026.6913253192242, 4050.9392359114636, 9250.306227033, 9995.300328976902, 10658.840117398246, 10754.56981720738, 10792.190585706103, 10399.376037437627, 10662.680119596425, 10699.893001070046, 10724.356538607708, 10733.83899241512, 7965.840683186304, 8160.3471722262075, 8184.836303273901, 8204.753857384288, 8290.08809031006, 5704.914426283692, 5735.54115670737, 5759.56803239767, 5861.1501332305725, 5881.0, 10002.599896004078, 10067.798644026932, 10075.395476271447, 10132.392056476636, 10173.389596624227, 8465.746027619181, 9977.800443990935, 10141.239407044648, 10206.642767503101, 10283.794324113325, 6498.74005039812, 6868.828279292858, 6957.965210173917, 7098.29017098286, 7135.0, 8439.071702112886, 8523.275521580486, 8526.82946341082, 8533.658653654033, 8574.742757717278, 6809.557378770364, 7428.814279643052, 7531.209223031503, 7580.620968951641, 7690.538567685957, 7100.751473698396, 7322.450816188701, 7394.075740532434, 7422.294881986203, 7462.0, 6979.162500499972, 6992.930070699228, 7071.292870712888, 7077.82305442368, 7091.43268538526, 4619.191641462798, 4895.7062576245535, 4940.407151141886, 4960.553550180501, 5007.7245751484015, 4912.066707325596, 4935.210366341368, 4935.309056731989, 4987.950120498894, 4993.325901003318], "value": 4543.3185799725825, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.75117896251294, 302.4344475830197, 316.61689355879395, 316.9698878606533, 318.1251558214909, 5371.623986320949, 5522.818486697752, 5587.05020146575, 5661.943380566198, 5748.419184724197, 4847.981923796007, 5214.530692237698, 5639.674676451031, 5654.886902261963, 5681.403452637475, 3734.2344819311975, 4316.84891028814, 4324.815967936188, 4351.303791393378, 4369.694121411502, 3566.7681600695873, 3996.240714264295, 4023.7988100595, 4367.323064924942, 4382.020226246152, 4191.727537710054, 4252.489701235856, 4267.658587313023, 4280.0, 4301.892452688677, 3549.290141971616, 4268.38108474271, 4272.636825869805, 4277.721948073366, 4325.3728209409455, 3479.2693534357563, 3618.9685939507112, 3641.1443310821937, 3646.690031347339, 3733.8133093345223, 4851.0, 5137.768800403991, 5484.780608775644, 5487.341519017704, 5588.720563971826, 4159.521655009652, 4781.402324709411, 4872.878178045542, 4884.242942343943, 4910.656254062217, 4921.360223171001, 5701.603107238711, 5954.4938680212235, 6029.8191054268445, 6060.848438796658, 3989.6409323160765, 3998.3402738548107, 4005.959940400588, 4018.176273863851, 4026.295398305285, 5892.292924849003, 5980.880382392371, 6183.876322473526, 6215.0, 6313.747450101991, 3839.4432807242792, 4005.0588111793704, 4042.0703238255364, 4044.170944956336, 4052.3111071117983, 3449.1721986723005, 3695.9260814784093, 3979.880603581897, 4102.487189101363, 4127.463429754112, 4659.487456379796, 4720.33915251865, 4847.684900481458, 4862.95137048632, 4883.267509873547, 4737.881552961204, 5876.030454974882, 5970.432808883149, 6082.171790117616, 6103.603265787799, 1202.991005021616, 1229.569650622275, 1256.1520973342956, 1302.693866941268, 1375.8899288056932, 778.3345239819986, 864.4942708515463, 895.3106108296575, 935.3499317974079, 938.3150300280834, 4914.164592019365, 5461.453854614507, 5514.869451762379, 5519.819671229841, 5554.666719996813, 6062.423170329526, 6086.417531441857, 6086.665233412116, 6093.329733729286, 6108.511319094462, 4877.951220487821, 4901.235555200125, 5456.454354564591, 5473.989305881749, 5494.780208791683, 2126.606577783115, 2374.3707917401557, 2379.5003049359484, 2549.171519256249, 2629.541378810818, 4490.820367185342, 5066.923996140061, 5119.87200319995, 5203.947960520422, 5303.36359636846, 4306.80619372129, 4415.933760993587, 4795.832145874878, 5143.485651434827, 5329.26798790387, 4338.945128924767, 4920.926186107211, 4977.352944117241, 5109.926915347744, 5295.828710228865, 4433.911321773611, 4858.319835223142, 4999.950000500094, 5012.598992080552, 5095.974520127375, 5009.323741294878, 5018.874528136826, 5494.725263736877, 6141.293751218667, 6175.660338681416, 5339.97081109176, 6329.7151628175925, 6332.208473940757, 6472.0, 6531.216254049545, 3424.880129195466, 3568.553930758655, 4038.6970977176243, 4058.1680755445655, 4067.9593204067583, 5890.9116363253725, 5956.940430595639, 6063.756410128281, 6140.815775526741, 6171.259448866164, 5878.647281163144, 6008.429199226067, 6011.699415029144, 6012.458878700763, 6023.397660233942, 4727.976360118315, 4913.0, 5051.812823986434, 5951.191237607848, 6062.42406971337, 4672.859814205579, 4741.83403580873, 5088.363954505687, 5843.561732870136, 5888.587798854039, 5604.971975140098, 5970.820875373745, 5995.013316144715, 6023.608465449732, 6047.395260473917, 5117.7717347837, 5588.720563971704, 5657.151427285776, 5917.674527900835, 5921.644701317935], "value": 4155.616051525386, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.9361957423831, 764.7858599592113, 768.5465575310569, 803.144650946742, 850.9489430634164, 12863.678408039803, 15033.473828416008, 15724.449644262468, 16027.919860400696, 16098.275577599035, 14184.432622695105, 14308.785368219485, 14325.498607548738, 14342.0, 14375.0, 828.9544075075869, 835.6448509383488, 866.8439680857443, 876.2770714160811, 877.3858299190592, 858.6651206029653, 863.2877875752498, 866.8916385451819, 870.6430363550945, 873.2751815992742, 907.686848037426, 917.9127982841653, 920.5121285718579, 921.0467166482691, 921.2491819167391, 722.6495149852317, 815.9673613055501, 842.8862103615994, 892.607252808762, 896.7802888292377, 592.1739173852452, 663.1577896071962, 669.6618207805076, 672.0893189727946, 677.9118714567124, 15510.302036408277, 15533.922330388275, 15538.689226215412, 15547.989380690218, 15565.688686226325, 13730.862691373059, 13750.381232844546, 14128.434862605483, 14223.857761422356, 14435.607632206424, 10155.0, 11664.475098620498, 11740.236884602473, 12068.456919438646, 12336.198147120409, 3791.317562838688, 3870.845166193349, 3948.506436695413, 3983.8406463741417, 3993.900152496182, 119823.80176198213, 124186.75813241843, 124959.3752031243, 125406.0, 125595.0, 11070.833937490945, 11073.0, 11216.55133794639, 11259.662210133709, 11480.253783504046, 22401.66397504039, 22695.319140425814, 22723.88638056799, 22734.0, 22734.772652273266, 5958.821235362946, 6769.661516924134, 6880.862382752317, 7065.6113913735235, 7066.293370662996, 4197.9370309445385, 4260.211860805761, 4267.0825772459075, 4295.183915056129, 4353.1293741251875, 3639.6178401267484, 3757.981210093932, 3762.097096696773, 3762.247550489913, 3873.69010479161, 636.6530241018563, 722.6459035072882, 738.7635956493978, 739.6708464733142, 758.2493331601675, 548.7996881138436, 597.3339726205337, 638.5211091681239, 662.5329142954206, 671.3823282580038, 8247.835043299221, 8899.421537600036, 9326.440413575207, 9453.52732363379, 9878.851817222747, 538.7360193505154, 561.9381867994517, 604.1481511069459, 607.8419610901109, 614.5698011391954, 4542.1824071667415, 4754.2588993224235, 4883.95116048835, 5015.523525265094, 5349.170878513836, 100407.0, 129896.0, 154745.0, 156581.0, 159504.0, 115518.8448115525, 126210.36894815651, 127663.0, 129884.3505782465, 137236.0, 103412.96587034184, 110026.0, 111326.44336778265, 116046.0, 117583.0, 8436.578171091298, 9010.819783604422, 9888.357256778287, 10028.29801913859, 10029.548670309707, 48874.511254886995, 50658.0, 64527.35472645401, 64643.0, 65631.01553476606, 71454.64272678603, 75250.0, 88532.0, 89339.55330223308, 89369.55315223642, 12646.367681615699, 12865.742685146432, 13497.785199332107, 13515.797263041259, 13697.657558561115, 12978.935105324414, 14555.68998790114, 14847.554573362817, 15033.473828415952, 15291.033036182218, 13890.097143685629, 13930.993218986594, 13957.860421395657, 14103.929480352532, 14587.0, 13937.860621393656, 14023.36894839755, 14039.50861719835, 14424.134551926918, 14539.927300363854, 13644.0, 13896.374663140385, 13942.651433714238, 14032.719345613235, 14374.990692987825, 9185.908140918506, 11405.315681059163, 11418.31490110596, 11579.0, 11602.583209140586, 8831.602577883883, 9806.85289720669, 10407.791844163226, 11698.2981021139, 11757.0], "value": 7824.773263174931, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1593.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 116.0, 109.0, 117.0, 117.0, 117.0, 118.0, 117.0, 116.0, 117.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 108.0, 131.0, 157.0, 112.0, 133.0, 141.0, 146.0, 186.0, 110.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 200.0, 195.0, 220.0, 187.0, 273.0, 280.0, 192.0, 274.0, 281.0], "value": 229.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 84.0, 75.0, 140.0, 98.0, 83.0, 88.0, 54.0, 145.0, 84.0], "value": 92.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 129.0, 71.0, 73.0, 76.0, 109.0, 72.0, 73.0, 113.0], "value": 86.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 77.0, 137.0, 131.0, 89.0, 85.0, 88.0, 113.0, 88.0, 85.0], "value": 98.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 153.0, 97.0, 151.0, 124.0, 147.0, 152.0, 96.0, 98.0, 95.0], "value": 125.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 90.0, 91.0, 96.0, 101.0, 137.0, 91.0, 101.0, 92.0], "value": 98.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 59.0, 57.0, 62.0, 57.0, 58.0, 60.0, 58.0, 58.0], "value": 58.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 69.0, 76.0, 75.0, 72.0, 68.0, 71.0, 70.0, 73.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 87.0, 88.0, 85.0, 88.0, 88.0, 90.0, 92.0, 92.0], "value": 88.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 151.0, 150.0, 139.0, 142.0, 159.0, 148.0, 138.0, 159.0, 165.0], "value": 151.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 176.0, 174.0, 172.0, 173.0, 169.0, 172.0, 173.0, 176.0, 171.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 69.0, 77.0, 73.0, 68.0, 69.0, 69.0, 67.0, 71.0], "value": 70.1, "unit": "score"}]}]} 09:14:05 INFO - Return code: 0 09:14:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:14:05 ERROR - # TBPL SUCCESS # 09:14:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:14:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:14:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:14:05 INFO - 2016-08-22 09:14:05.287 screenresolution[1664:10517] starting screenresolution argv=screenresolution get 09:14:05 INFO - 2016-08-22 09:14:05.289 screenresolution[1664:10517] Display 0: 1600x1200x32@60 09:14:05 INFO - 2016-08-22 09:14:05.295 screenresolution[1665:10520] starting screenresolution argv=screenresolution list 09:14:05 INFO - Available Modes on Display 0 09:14:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:14:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:14:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:14:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:14:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:14:05 INFO - Intel Iris: 09:14:05 INFO - Chipset Model: Intel Iris 09:14:05 INFO - Type: GPU 09:14:05 INFO - Bus: Built-In 09:14:05 INFO - VRAM (Dynamic, Max): 1536 MB 09:14:05 INFO - Vendor: Intel (0x8086) 09:14:05 INFO - Device ID: 0x0a2e 09:14:05 INFO - Revision ID: 0x0009 09:14:05 INFO - Displays: 09:14:05 INFO - Display: 09:14:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:14:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:14:05 INFO - Display Serial Number: 1600x1200 60 09:14:05 INFO - Main Display: Yes 09:14:05 INFO - Mirror: Off 09:14:05 INFO - Online: Yes 09:14:05 INFO - Rotation: Supported 09:14:05 INFO - Return code: 0 09:14:05 INFO - Running post-action listener: _resource_record_post_action 09:14:05 INFO - [mozharness: 2016-08-22 16:14:05.531511Z] Finished run-tests step (success) 09:14:05 INFO - Running post-run listener: _resource_record_post_run 09:14:05 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 37110784; Write bytes: 709609984; Read time: 245; Write time: 2064 09:14:05 INFO - TinderboxPrint: CPU usage
54.4% 09:14:05 INFO - TinderboxPrint: I/O read bytes / time
37,110,784 / 245 09:14:05 INFO - TinderboxPrint: I/O write bytes / time
709,609,984 / 2,064 09:14:05 INFO - TinderboxPrint: CPU idle
2,205.3 (45.6%) 09:14:05 INFO - TinderboxPrint: CPU system
979.4 (20.2%) 09:14:05 INFO - TinderboxPrint: CPU user
1,653.0 (34.2%) 09:14:05 INFO - TinderboxPrint: Swap in / out
442,859,520 / 0 09:14:05 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 408855040; Write bytes: 398824960; Read time: 29931; Write time: 865 09:14:05 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 29723648; Write bytes: 298689536; Read time: 181; Write time: 1162 09:14:06 INFO - Running post-run listener: _upload_blobber_files 09:14:06 INFO - Blob upload gear active. 09:14:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:14:06 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 09:14:06 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:14:06 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:14:06 INFO - (blobuploader) - INFO - Open directory for files ... 09:14:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:14:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:14:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:07 INFO - (blobuploader) - INFO - Done attempting. 09:14:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:14:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:14:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:08 INFO - (blobuploader) - INFO - Done attempting. 09:14:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:14:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:14:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:10 INFO - (blobuploader) - INFO - Done attempting. 09:14:10 INFO - (blobuploader) - INFO - Iteration through files over. 09:14:10 INFO - Return code: 0 09:14:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:14:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:14:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82c8e1d33af77882488d8147697ca72b8e6d4ba05a2f9e85f365ff36f7ea2fd0d7e99221d7e814c9184828384d865497be1c8eb89b09ebb5f5e2eb079f934381", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a29719606624dc5591865fec1afb9692a6ae83b86364414bc71c0cbf96ef424c44b377b3114f5ed5b888a3b0801fe733d1577853c10d890cae9d0d5cf1e4f3b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a49d82aa74b044417f7396794a0fdd09132a968a1485989261945dc86a8e70fdc645a577b0cfb7ae31c7fe08341f79daf5b2677b78726e45be05070b3110cbd"} 09:14:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:14:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:14:10 INFO - Contents: 09:14:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82c8e1d33af77882488d8147697ca72b8e6d4ba05a2f9e85f365ff36f7ea2fd0d7e99221d7e814c9184828384d865497be1c8eb89b09ebb5f5e2eb079f934381", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a29719606624dc5591865fec1afb9692a6ae83b86364414bc71c0cbf96ef424c44b377b3114f5ed5b888a3b0801fe733d1577853c10d890cae9d0d5cf1e4f3b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a49d82aa74b044417f7396794a0fdd09132a968a1485989261945dc86a8e70fdc645a577b0cfb7ae31c7fe08341f79daf5b2677b78726e45be05070b3110cbd"} 09:14:10 INFO - Running post-run listener: copy_logs_to_upload_dir 09:14:10 INFO - Copying logs to upload dir... 09:14:10 INFO - mkdir: /builds/slave/test/build/upload/logs 09:14:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.691082 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-22 09:14:10.837110) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 09:14:10.840378) ========= 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.CDiwvgpsyW/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.X0OkSBJcVb/Listeners TMPDIR=/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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/Firefox/sha512/82c8e1d33af77882488d8147697ca72b8e6d4ba05a2f9e85f365ff36f7ea2fd0d7e99221d7e814c9184828384d865497be1c8eb89b09ebb5f5e2eb079f934381", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a29719606624dc5591865fec1afb9692a6ae83b86364414bc71c0cbf96ef424c44b377b3114f5ed5b888a3b0801fe733d1577853c10d890cae9d0d5cf1e4f3b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a49d82aa74b044417f7396794a0fdd09132a968a1485989261945dc86a8e70fdc645a577b0cfb7ae31c7fe08341f79daf5b2677b78726e45be05070b3110cbd"} build_url:https://queue.taskcluster.net/v1/task/F86j7ptdQKKrb-Oj9HCH9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011067 build_url: 'https://queue.taskcluster.net/v1/task/F86j7ptdQKKrb-Oj9HCH9Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82c8e1d33af77882488d8147697ca72b8e6d4ba05a2f9e85f365ff36f7ea2fd0d7e99221d7e814c9184828384d865497be1c8eb89b09ebb5f5e2eb079f934381", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a29719606624dc5591865fec1afb9692a6ae83b86364414bc71c0cbf96ef424c44b377b3114f5ed5b888a3b0801fe733d1577853c10d890cae9d0d5cf1e4f3b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a49d82aa74b044417f7396794a0fdd09132a968a1485989261945dc86a8e70fdc645a577b0cfb7ae31c7fe08341f79daf5b2677b78726e45be05070b3110cbd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 09:14:10.873506) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:14:10.873868) ========= 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.CDiwvgpsyW/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.X0OkSBJcVb/Listeners TMPDIR=/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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.005103 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:14:10.923052) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 09:14:10.923438) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 09:14:10.923965) ========= ========= Total master_lag: 0.17 =========