builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0383 starttime: 1472314970.04 results: success (0) buildid: 20160827055712 builduid: 65c8787e2cd94a6b8a6faedfa5414b90 revision: 1a5b53a831e5a6c20de1b081c774feb3ff76756c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-27 09:22:50.041778) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-27 09:22:50.042264) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-27 09:22:50.042572) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-27 09:22:50.530738) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-27 09:22:50.531201) ========= 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.egkkwt36VD/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.p8claiKdtt/Listeners TMPDIR=/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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-27 09:22:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 154M=0s 2016-08-27 09:22:51 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.602104 ========= master_lag: 0.42 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-27 09:22:51.554387) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 09:22:51.554742) ========= 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.egkkwt36VD/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.p8claiKdtt/Listeners TMPDIR=/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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.020735 ========= master_lag: 0.16 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 09:22:51.732957) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-27 09:22:51.733302) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1a5b53a831e5a6c20de1b081c774feb3ff76756c --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 1a5b53a831e5a6c20de1b081c774feb3ff76756c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.egkkwt36VD/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.p8claiKdtt/Listeners TMPDIR=/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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-27 09:22:52,738 truncating revision to first 12 chars 2016-08-27 09:22:52,738 Setting DEBUG logging. 2016-08-27 09:22:52,738 attempt 1/10 2016-08-27 09:22:52,738 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1a5b53a831e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-27 09:22:53,938 unpacking tar archive at: mozilla-central-1a5b53a831e5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.460850 ========= master_lag: 1.16 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-27 09:22:54.354258) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-27 09:22:54.354573) ========= script_repo_revision: 1a5b53a831e5a6c20de1b081c774feb3ff76756c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-27 09:22:54.354961) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-27 09:22:54.355220) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-27 09:22:54.381956) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-08-27 09:22:54.382305) ========= /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.egkkwt36VD/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.p8claiKdtt/Listeners TMPDIR=/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 09:22:54 INFO - MultiFileLogger online at 20160827 09:22:54 in /builds/slave/test 09:22:54 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 09:22:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:22:54 INFO - {'append_to_log': False, 09:22:54 INFO - 'base_work_dir': '/builds/slave/test', 09:22:54 INFO - 'blob_upload_branch': 'Firefox', 09:22:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:22:54 INFO - 'branch': 'Firefox', 09:22:54 INFO - 'buildbot_json_path': 'buildprops.json', 09:22:54 INFO - 'config_files': ('talos/mac_config.py',), 09:22:54 INFO - 'default_actions': ('clobber', 09:22:54 INFO - 'read-buildbot-config', 09:22:54 INFO - 'download-and-extract', 09:22:54 INFO - 'populate-webroot', 09:22:54 INFO - 'create-virtualenv', 09:22:54 INFO - 'install', 09:22:54 INFO - 'run-tests'), 09:22:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:22:54 INFO - 'download_minidump_stackwalk': True, 09:22:54 INFO - 'download_symbols': 'ondemand', 09:22:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:22:54 INFO - 'tooltool.py': '/tools/tooltool.py', 09:22:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:22:54 INFO - '/tools/misc-python/virtualenv.py')}, 09:22:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:22:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:22:54 INFO - 'installer_path': 'installer.exe', 09:22:54 INFO - 'log_level': 'info', 09:22:54 INFO - 'log_name': 'talos', 09:22:54 INFO - 'log_to_console': True, 09:22:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:22:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:22:54 INFO - 'opt_config_files': (), 09:22:54 INFO - 'pip_index': False, 09:22:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:22:54 INFO - 'cmd': ('bash', 09:22:54 INFO - '-c', 09:22:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:22:54 INFO - 'enabled': True, 09:22:54 INFO - 'halt_on_failure': False, 09:22:54 INFO - 'name': 'check_screen_resolution'},), 09:22:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:22:54 INFO - 'cmd': ('bash', 09:22:54 INFO - '-c', 09:22:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:22:54 INFO - 'enabled': True, 09:22:54 INFO - 'halt_on_failure': False, 09:22:54 INFO - 'name': 'check_screen_resolution'},), 09:22:54 INFO - 'run_cmd_checks_enabled': True, 09:22:54 INFO - 'sps_profile': False, 09:22:54 INFO - 'sps_profile_interval': 0, 09:22:54 INFO - 'suite': 'dromaeojs-e10s', 09:22:54 INFO - 'system_bits': '32', 09:22:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:22:54 INFO - 'title': 't-yosemite-r7-0383', 09:22:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:22:54 INFO - 'use_talos_json': True, 09:22:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:22:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:22:54 INFO - 'work_dir': 'build'} 09:22:54 INFO - [mozharness: 2016-08-27 16:22:54.574036Z] Running clobber step. 09:22:54 INFO - Running pre-action listener: _resource_record_pre_action 09:22:54 INFO - Running main action method: clobber 09:22:54 INFO - rmtree: /builds/slave/test/build 09:22:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:22:55 INFO - Running post-action listener: _resource_record_post_action 09:22:55 INFO - [mozharness: 2016-08-27 16:22:55.491439Z] Finished clobber step (success) 09:22:55 INFO - [mozharness: 2016-08-27 16:22:55.491690Z] Running read-buildbot-config step. 09:22:55 INFO - Running pre-action listener: _resource_record_pre_action 09:22:55 INFO - Running main action method: read_buildbot_config 09:22:55 INFO - Using buildbot properties: 09:22:55 INFO - { 09:22:55 INFO - "project": "", 09:22:55 INFO - "product": "firefox", 09:22:55 INFO - "script_repo_revision": "production", 09:22:55 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 09:22:55 INFO - "repository": "", 09:22:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 09:22:55 INFO - "buildid": "20160827055712", 09:22:55 INFO - "pgo_build": "False", 09:22:55 INFO - "basedir": "/builds/slave/test", 09:22:55 INFO - "buildnumber": 42, 09:22:55 INFO - "slavename": "t-yosemite-r7-0383", 09:22:55 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 09:22:55 INFO - "platform": "yosemite_r7", 09:22:55 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:22:55 INFO - "branch": "mozilla-central", 09:22:55 INFO - "repo_path": "mozilla-central", 09:22:55 INFO - "revision": "1a5b53a831e5a6c20de1b081c774feb3ff76756c", 09:22:55 INFO - "stage_platform": "macosx64", 09:22:55 INFO - "builduid": "65c8787e2cd94a6b8a6faedfa5414b90", 09:22:55 INFO - "slavebuilddir": "test" 09:22:55 INFO - } 09:22:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 09:22:55 INFO - Running post-action listener: _resource_record_post_action 09:22:55 INFO - [mozharness: 2016-08-27 16:22:55.497517Z] Finished read-buildbot-config step (success) 09:22:55 INFO - [mozharness: 2016-08-27 16:22:55.497698Z] Running download-and-extract step. 09:22:55 INFO - Running pre-action listener: _resource_record_pre_action 09:22:55 INFO - Running main action method: download_and_extract 09:22:55 INFO - mkdir: /builds/slave/test/build/tests 09:22: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')]} 09:22:55 INFO - trying https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 09:22:55 INFO - Downloading https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/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 09:22:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/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 09:22:57 INFO - Downloaded 1199 bytes. 09:22:57 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 09:22:57 INFO - Using the following test package requirements: 09:22:57 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 09:22:57 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:22:57 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 09:22:57 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:22:57 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 09:22:57 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:22:57 INFO - u'jsshell-mac.zip'], 09:22:57 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:22:57 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 09:22:57 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 09:22:57 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:22:57 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 09:22:57 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:22:57 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 09:22:57 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:22:57 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 09:22:57 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:22:57 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 09:22:57 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:57 INFO - trying https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 09:22:57 INFO - Downloading https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/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 09:22:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/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 09:22:57 INFO - Downloaded 16369283 bytes. 09:22:57 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 09:23:04 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 09:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:04 INFO - trying https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 09:23:04 INFO - Downloading https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/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 09:23:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/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 09:23:05 INFO - Downloaded 16369283 bytes. 09:23:05 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 09:23: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')]} 09:23:11 INFO - trying https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 09:23:11 INFO - Downloading https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/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 09:23:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/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 09:23:13 INFO - Downloaded 14413998 bytes. 09:23:13 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 09:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:14 INFO - trying https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 09:23:14 INFO - Downloading https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 09:23:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/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 09:23:17 INFO - Downloaded 111541368 bytes. 09:23:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 09:23:17 INFO - mkdir: /builds/slave/test/properties 09:23:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:23:17 INFO - Writing to file /builds/slave/test/properties/build_url 09:23:17 INFO - Contents: 09:23:17 INFO - build_url:https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 09:23:17 INFO - Running post-action listener: _resource_record_post_action 09:23:17 INFO - Running post-action listener: set_extra_try_arguments 09:23:17 INFO - [mozharness: 2016-08-27 16:23:17.894552Z] Finished download-and-extract step (success) 09:23:17 INFO - [mozharness: 2016-08-27 16:23:17.894687Z] Running populate-webroot step. 09:23:17 INFO - Running pre-action listener: _resource_record_pre_action 09:23:17 INFO - Running main action method: populate_webroot 09:23:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:23:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:23:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:23:17 INFO - '--tppagecycles', 09:23:17 INFO - '7'], 09:23:17 INFO - 'tests': ['tsvgm']}}, 09:23:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:23:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:23:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:23:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:23:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:23:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:23:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:17 INFO - 'talos_options': ['--disable-e10s'], 09:23:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:17 INFO - 'talos_options': ['--disable-e10s'], 09:23:17 INFO - 'tests': ['damp', 'tps']}, 09:23:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:17 INFO - 'tests': ['damp', 'tps']}, 09:23:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:23:17 INFO - 'tests': ['dromaeo_dom']}, 09:23:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:23:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:23:17 INFO - 'tests': ['basic_compositor_video']}, 09:23:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:23:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:23:17 INFO - 'tests': ['a11yr', 09:23:17 INFO - 'ts_paint', 09:23:17 INFO - 'tpaint', 09:23:17 INFO - 'sessionrestore', 09:23:17 INFO - 'sessionrestore_no_auto_restore', 09:23:17 INFO - 'tabpaint']}, 09:23:17 INFO - 'other-e10s': {'tests': ['a11yr', 09:23:17 INFO - 'ts_paint', 09:23:17 INFO - 'tpaint', 09:23:17 INFO - 'sessionrestore', 09:23:17 INFO - 'sessionrestore_no_auto_restore', 09:23:17 INFO - 'tabpaint']}, 09:23:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:23:17 INFO - 'ts_paint', 09:23:17 INFO - 'tpaint', 09:23:17 INFO - 'sessionrestore', 09:23:17 INFO - 'sessionrestore_no_auto_restore', 09:23:17 INFO - 'tabpaint']}, 09:23:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:23:17 INFO - 'ts_paint', 09:23:17 INFO - 'tpaint', 09:23:17 INFO - 'sessionrestore', 09:23:17 INFO - 'sessionrestore_no_auto_restore', 09:23:17 INFO - 'tabpaint']}, 09:23:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:23:17 INFO - 'tests': ['a11yr', 09:23:17 INFO - 'ts_paint', 09:23:17 INFO - 'tpaint', 09:23:17 INFO - 'sessionrestore', 09:23:17 INFO - 'sessionrestore_no_auto_restore', 09:23:17 INFO - 'tabpaint']}, 09:23:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:23:17 INFO - 'tests': ['a11yr', 09:23:17 INFO - 'ts_paint', 09:23:17 INFO - 'tpaint', 09:23:17 INFO - 'sessionrestore', 09:23:17 INFO - 'sessionrestore_no_auto_restore', 09:23:17 INFO - 'tabpaint']}, 09:23:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:23:17 INFO - 'tests': ['tsvgx', 09:23:17 INFO - 'tsvgr_opacity', 09:23:17 INFO - 'tart', 09:23:17 INFO - 'tscrollx', 09:23:17 INFO - 'cart']}, 09:23:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:23:17 INFO - 'tsvgr_opacity', 09:23:17 INFO - 'tart', 09:23:17 INFO - 'tscrollx', 09:23:17 INFO - 'cart']}, 09:23:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:17 INFO - 'talos_options': ['--disable-e10s'], 09:23:17 INFO - 'tests': ['tp5o']}, 09:23:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:17 INFO - 'tests': ['tp5o']}, 09:23:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:17 INFO - 'talos_options': ['--disable-e10s', 09:23:17 INFO - '--xperf_path', 09:23:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:17 INFO - 'tests': ['tp5n']}, 09:23:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:17 INFO - 'talos_options': ['--xperf_path', 09:23:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:17 INFO - 'tests': ['tp5n']}}, 09:23:17 INFO - 'talos.zip': {'path': '', 09:23:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:23:17 INFO - Running post-action listener: _resource_record_post_action 09:23:17 INFO - [mozharness: 2016-08-27 16:23:17.913640Z] Finished populate-webroot step (success) 09:23:17 INFO - [mozharness: 2016-08-27 16:23:17.913771Z] Running create-virtualenv step. 09:23:17 INFO - Running pre-action listener: _resource_record_pre_action 09:23:17 INFO - Running main action method: create_virtualenv 09:23:17 INFO - Creating virtualenv /builds/slave/test/build/venv 09:23:17 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 09:23:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:23:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:23:18 INFO - Using real prefix '/tools/python27' 09:23:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:23:18 INFO - Installing distribute.............................................................................................................................................................................................done. 09:23:21 INFO - Installing pip.................done. 09:23:21 INFO - Return code: 0 09:23:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:23:21 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')]} 09:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:21 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')]} 09:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:21 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 0x10b243a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2d8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc24a5592f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1a7d30>, '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 0x10af0cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b19fb20>, '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.egkkwt36VD/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.p8claiKdtt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 09:23:21 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 09:23:21 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 09:23:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.egkkwt36VD/Render', 09:23:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:21 INFO - 'HOME': '/Users/cltbld', 09:23:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:21 INFO - 'LOGNAME': 'cltbld', 09:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:21 INFO - 'MOZ_NO_REMOTE': '1', 09:23:21 INFO - 'NO_EM_RESTART': '1', 09:23:21 INFO - 'PAGER': '/bin/cat', 09:23:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:21 INFO - 'PWD': '/builds/slave/test', 09:23:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:21 INFO - 'SHELL': '/bin/bash', 09:23:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p8claiKdtt/Listeners', 09:23:21 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 09:23:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:21 INFO - 'USER': 'cltbld', 09:23:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:21 INFO - 'XPC_FLAGS': '0x0', 09:23:21 INFO - 'XPC_SERVICE_NAME': '0', 09:23:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:21 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 09:23:21 INFO - Cleaning up... 09:23:21 INFO - Return code: 0 09:23:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:23:21 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')]} 09:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:21 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')]} 09:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:21 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 0x10b243a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2d8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc24a5592f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1a7d30>, '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 0x10af0cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b19fb20>, '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.egkkwt36VD/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.p8claiKdtt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 09:23:21 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 09:23:21 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 09:23:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.egkkwt36VD/Render', 09:23:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:21 INFO - 'HOME': '/Users/cltbld', 09:23:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:21 INFO - 'LOGNAME': 'cltbld', 09:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:21 INFO - 'MOZ_NO_REMOTE': '1', 09:23:21 INFO - 'NO_EM_RESTART': '1', 09:23:21 INFO - 'PAGER': '/bin/cat', 09:23:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:21 INFO - 'PWD': '/builds/slave/test', 09:23:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:21 INFO - 'SHELL': '/bin/bash', 09:23:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p8claiKdtt/Listeners', 09:23:21 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 09:23:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:21 INFO - 'USER': 'cltbld', 09:23:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:21 INFO - 'XPC_FLAGS': '0x0', 09:23:21 INFO - 'XPC_SERVICE_NAME': '0', 09:23:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:22 INFO - Downloading/unpacking psutil>=3.1.1 09:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:23:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:25 INFO - Installing collected packages: psutil 09:23:25 INFO - Running setup.py install for psutil 09:23:25 INFO - building 'psutil._psutil_osx' extension 09:23:25 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 09:23:25 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 09:23:25 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 09:23:26 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 09:23:26 INFO - building 'psutil._psutil_posix' extension 09:23:26 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 09:23:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:23:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:23:26 INFO - ^ 09:23:26 INFO - 1 warning generated. 09:23:26 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 09:23:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:26 INFO - Successfully installed psutil 09:23:26 INFO - Cleaning up... 09:23:26 INFO - Return code: 0 09:23:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:23:26 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')]} 09:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:26 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')]} 09:23:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:26 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 0x10b243a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2d8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc24a5592f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1a7d30>, '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 0x10af0cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b19fb20>, '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.egkkwt36VD/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.p8claiKdtt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 09:23:26 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 09:23:26 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 09:23:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.egkkwt36VD/Render', 09:23:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:26 INFO - 'HOME': '/Users/cltbld', 09:23:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:26 INFO - 'LOGNAME': 'cltbld', 09:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:26 INFO - 'MOZ_NO_REMOTE': '1', 09:23:26 INFO - 'NO_EM_RESTART': '1', 09:23:26 INFO - 'PAGER': '/bin/cat', 09:23:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:26 INFO - 'PWD': '/builds/slave/test', 09:23:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:26 INFO - 'SHELL': '/bin/bash', 09:23:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p8claiKdtt/Listeners', 09:23:26 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 09:23:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:26 INFO - 'USER': 'cltbld', 09:23:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:26 INFO - 'XPC_FLAGS': '0x0', 09:23:26 INFO - 'XPC_SERVICE_NAME': '0', 09:23:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:23:26 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 09:23:26 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 09:23:26 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 09:23:26 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 09:23:26 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 09:23:26 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 09:23:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:23:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:23:29 INFO - Installing collected packages: mozsystemmonitor 09:23:29 INFO - Running setup.py install for mozsystemmonitor 09:23:29 INFO - Successfully installed mozsystemmonitor 09:23:29 INFO - Cleaning up... 09:23:29 INFO - Return code: 0 09:23:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b243a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2d8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc24a5592f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1a7d30>, '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 0x10af0cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b19fb20>, '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.egkkwt36VD/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.p8claiKdtt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 09:23:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:23:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.egkkwt36VD/Render', 09:23:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:29 INFO - 'HOME': '/Users/cltbld', 09:23:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:29 INFO - 'LOGNAME': 'cltbld', 09:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:29 INFO - 'MOZ_NO_REMOTE': '1', 09:23:29 INFO - 'NO_EM_RESTART': '1', 09:23:29 INFO - 'PAGER': '/bin/cat', 09:23:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:29 INFO - 'PWD': '/builds/slave/test', 09:23:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:29 INFO - 'SHELL': '/bin/bash', 09:23:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p8claiKdtt/Listeners', 09:23:29 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 09:23:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:29 INFO - 'USER': 'cltbld', 09:23:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:29 INFO - 'XPC_FLAGS': '0x0', 09:23:29 INFO - 'XPC_SERVICE_NAME': '0', 09:23:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:29 INFO - Downloading/unpacking jsonschema==2.5.1 09:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:23:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:23: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 09:23: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 09:23: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 09:23: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 09:23: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 09:23: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 09:23:32 INFO - Downloading functools32-3.2.3-2.tar.gz 09:23:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:23:32 INFO - warning: no files found matching '*.txt' 09:23:32 INFO - no previously-included directories found matching 'build' 09:23:32 INFO - no previously-included directories found matching 'dist' 09:23:32 INFO - no previously-included directories found matching '.git*' 09:23:32 INFO - Installing collected packages: jsonschema, functools32 09:23:32 INFO - Running setup.py install for functools32 09:23:32 INFO - warning: no files found matching '*.txt' 09:23:32 INFO - no previously-included directories found matching 'build' 09:23:32 INFO - no previously-included directories found matching 'dist' 09:23:32 INFO - no previously-included directories found matching '.git*' 09:23:32 INFO - Successfully installed jsonschema functools32 09:23:32 INFO - Cleaning up... 09:23:32 INFO - Return code: 0 09:23:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:23: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')]} 09:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23: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')]} 09:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23: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', '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 0x10b243a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2d8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc24a5592f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1a7d30>, '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 0x10af0cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b19fb20>, '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.egkkwt36VD/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.p8claiKdtt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 09:23: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:23: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 functools32==3.2.3-2 09:23:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.egkkwt36VD/Render', 09:23:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:32 INFO - 'HOME': '/Users/cltbld', 09:23:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:32 INFO - 'LOGNAME': 'cltbld', 09:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:32 INFO - 'MOZ_NO_REMOTE': '1', 09:23:32 INFO - 'NO_EM_RESTART': '1', 09:23:32 INFO - 'PAGER': '/bin/cat', 09:23:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:32 INFO - 'PWD': '/builds/slave/test', 09:23:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:32 INFO - 'SHELL': '/bin/bash', 09:23:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p8claiKdtt/Listeners', 09:23:32 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 09:23:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:32 INFO - 'USER': 'cltbld', 09:23:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:32 INFO - 'XPC_FLAGS': '0x0', 09:23:32 INFO - 'XPC_SERVICE_NAME': '0', 09:23:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:23:33 INFO - Cleaning up... 09:23:33 INFO - Return code: 0 09:23:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b243a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2d8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc24a5592f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1a7d30>, '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 0x10af0cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b19fb20>, '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.egkkwt36VD/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.p8claiKdtt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 09:23:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:23:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.egkkwt36VD/Render', 09:23:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:33 INFO - 'HOME': '/Users/cltbld', 09:23:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:33 INFO - 'LOGNAME': 'cltbld', 09:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:33 INFO - 'MOZ_NO_REMOTE': '1', 09:23:33 INFO - 'NO_EM_RESTART': '1', 09:23:33 INFO - 'PAGER': '/bin/cat', 09:23:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:33 INFO - 'PWD': '/builds/slave/test', 09:23:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:33 INFO - 'SHELL': '/bin/bash', 09:23:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p8claiKdtt/Listeners', 09:23:33 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 09:23:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:33 INFO - 'USER': 'cltbld', 09:23:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:33 INFO - 'XPC_FLAGS': '0x0', 09:23:33 INFO - 'XPC_SERVICE_NAME': '0', 09:23:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:33 INFO - Downloading/unpacking blobuploader==1.2.4 09:23:33 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 09:23:33 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 09:23:33 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 09:23:33 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 09:23:33 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 09:23:33 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 09:23:35 INFO - Downloading blobuploader-1.2.4.tar.gz 09:23:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:23:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:23: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 09:23: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 09:23: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 09:23: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 09:23: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 09:23: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 09:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:23:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:36 INFO - Downloading docopt-0.6.1.tar.gz 09:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:23:37 INFO - Installing collected packages: blobuploader, requests, docopt 09:23:37 INFO - Running setup.py install for blobuploader 09:23:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:23:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:23:37 INFO - Running setup.py install for requests 09:23:37 INFO - Running setup.py install for docopt 09:23:37 INFO - Successfully installed blobuploader requests docopt 09:23:37 INFO - Cleaning up... 09:23:37 INFO - Return code: 0 09:23:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:37 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')]} 09:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:37 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')]} 09:23:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:37 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 0x10b243a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2d8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc24a5592f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1a7d30>, '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 0x10af0cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b19fb20>, '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.egkkwt36VD/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.p8claiKdtt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 09:23:37 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 09:23:37 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 09:23:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.egkkwt36VD/Render', 09:23:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:37 INFO - 'HOME': '/Users/cltbld', 09:23:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:37 INFO - 'LOGNAME': 'cltbld', 09:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:37 INFO - 'MOZ_NO_REMOTE': '1', 09:23:37 INFO - 'NO_EM_RESTART': '1', 09:23:37 INFO - 'PAGER': '/bin/cat', 09:23:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:37 INFO - 'PWD': '/builds/slave/test', 09:23:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:37 INFO - 'SHELL': '/bin/bash', 09:23:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p8claiKdtt/Listeners', 09:23:37 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 09:23:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:37 INFO - 'USER': 'cltbld', 09:23:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:37 INFO - 'XPC_FLAGS': '0x0', 09:23:37 INFO - 'XPC_SERVICE_NAME': '0', 09:23:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:23:38 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-M3VU7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:23:38 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-pcDS5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:23:38 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-HJTUM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:23:38 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-xoGtNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:23:38 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-ZAkYhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:23:38 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-z0jdOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:23:38 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-Df0MBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:23:38 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-cHaC9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:23:39 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-Rn5qnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:23:39 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-fqGPDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:23:39 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-LBxw6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:23:39 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-_dojWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:23:39 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-0pofVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:23:39 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-6o_55O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:39 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-GU_1ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:23:39 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-1AJPqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:23:39 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-qkM612-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:23:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:23:39 INFO - Running setup.py install for manifestparser 09:23:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:23:40 INFO - Running setup.py install for mozcrash 09:23:40 INFO - Running setup.py install for mozdebug 09:23:40 INFO - Running setup.py install for mozdevice 09:23:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:23:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:23:40 INFO - Running setup.py install for mozfile 09:23:40 INFO - Running setup.py install for mozhttpd 09:23:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:23:40 INFO - Running setup.py install for mozinfo 09:23:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:23:40 INFO - Running setup.py install for mozInstall 09:23:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:23:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:23:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:23:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:23:41 INFO - Running setup.py install for mozleak 09:23:41 INFO - Running setup.py install for mozlog 09:23:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:23:41 INFO - Running setup.py install for moznetwork 09:23:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:23:41 INFO - Running setup.py install for mozprocess 09:23:41 INFO - Running setup.py install for mozprofile 09:23:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:23:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:23:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:23:41 INFO - Running setup.py install for mozrunner 09:23:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:23:42 INFO - Running setup.py install for mozscreenshot 09:23:42 INFO - Running setup.py install for moztest 09:23:42 INFO - Running setup.py install for mozversion 09:23:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:23:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:23:42 INFO - Cleaning up... 09:23:42 INFO - Return code: 0 09:23:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:42 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')]} 09:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:42 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')]} 09:23:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:42 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 0x10b243a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2d8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc24a5592f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1a7d30>, '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 0x10af0cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b19fb20>, '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.egkkwt36VD/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.p8claiKdtt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 09:23:42 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 09:23:42 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 09:23:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.egkkwt36VD/Render', 09:23:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:42 INFO - 'HOME': '/Users/cltbld', 09:23:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:42 INFO - 'LOGNAME': 'cltbld', 09:23:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:42 INFO - 'MOZ_NO_REMOTE': '1', 09:23:42 INFO - 'NO_EM_RESTART': '1', 09:23:42 INFO - 'PAGER': '/bin/cat', 09:23:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:42 INFO - 'PWD': '/builds/slave/test', 09:23:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:42 INFO - 'SHELL': '/bin/bash', 09:23:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p8claiKdtt/Listeners', 09:23:42 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 09:23:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:42 INFO - 'USER': 'cltbld', 09:23:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:42 INFO - 'XPC_FLAGS': '0x0', 09:23:42 INFO - 'XPC_SERVICE_NAME': '0', 09:23:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:23:42 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-aGoPVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:23:42 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)) 09:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:23:42 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-0YajsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:23:43 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)) 09:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:23:43 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-1ZKYwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:23:43 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)) 09:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:23:43 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-7LMmuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:23:43 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)) 09:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:23:43 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-4oz10I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:23:43 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)) 09:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:23:43 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-I9v8LD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:23:43 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)) 09:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:23:43 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-KNpEU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:23:43 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)) 09:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:23:43 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-tpnVST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:23:43 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)) 09:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:23:43 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-clAUrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:23:43 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)) 09:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:23:43 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-2WlosX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:23:43 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)) 09:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:23:43 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-R9KKMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:23:43 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)) 09:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:23:44 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-vlaOxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:23:44 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)) 09:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:23:44 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-ihDtDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:23:44 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)) 09:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:23:44 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-FJplTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:23:44 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)) 09:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:44 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-9Uj8gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:44 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)) 09:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:23:44 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-_3RIIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:23:44 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)) 09:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:23:44 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-MFMLC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:23:44 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)) 09:23:44 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)) 09:23:44 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)) 09:23:44 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)) 09:23:44 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)) 09:23:44 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)) 09:23:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:47 INFO - Downloading blessings-1.6.tar.gz 09:23:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:23:47 INFO - Installing collected packages: blessings 09:23:47 INFO - Running setup.py install for blessings 09:23:47 INFO - Successfully installed blessings 09:23:47 INFO - Cleaning up... 09:23:47 INFO - Return code: 0 09:23:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:23:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:23:47 INFO - Reading from file tmpfile_stdout 09:23:47 INFO - Current package versions: 09:23:47 INFO - blessings == 1.6 09:23:47 INFO - blobuploader == 1.2.4 09:23:47 INFO - docopt == 0.6.1 09:23:47 INFO - functools32 == 3.2.3-2 09:23:47 INFO - jsonschema == 2.5.1 09:23:47 INFO - manifestparser == 1.1 09:23:47 INFO - mozInstall == 1.12 09:23:47 INFO - mozcrash == 0.17 09:23:47 INFO - mozdebug == 0.1 09:23:47 INFO - mozdevice == 0.48 09:23:47 INFO - mozfile == 1.2 09:23:47 INFO - mozhttpd == 0.7 09:23:47 INFO - mozinfo == 0.9 09:23:47 INFO - mozleak == 0.1 09:23:47 INFO - mozlog == 3.3 09:23:47 INFO - moznetwork == 0.27 09:23:47 INFO - mozprocess == 0.23 09:23:47 INFO - mozprofile == 0.28 09:23:47 INFO - mozrunner == 6.12 09:23:47 INFO - mozscreenshot == 0.1 09:23:47 INFO - mozsystemmonitor == 0.3 09:23:47 INFO - moztest == 0.7 09:23:47 INFO - mozversion == 1.4 09:23:47 INFO - psutil == 3.1.1 09:23:47 INFO - requests == 1.2.3 09:23:47 INFO - wsgiref == 0.1.2 09:23:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:47 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 0x10b243a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2d8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc24a5592f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1a7d30>, '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 0x10af0cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b19fb20>, '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.egkkwt36VD/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.p8claiKdtt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 09:23:47 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 09:23:47 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 09:23:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.egkkwt36VD/Render', 09:23:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:47 INFO - 'HOME': '/Users/cltbld', 09:23:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:47 INFO - 'LOGNAME': 'cltbld', 09:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:47 INFO - 'MOZ_NO_REMOTE': '1', 09:23:47 INFO - 'NO_EM_RESTART': '1', 09:23:47 INFO - 'PAGER': '/bin/cat', 09:23:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:47 INFO - 'PWD': '/builds/slave/test', 09:23:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:47 INFO - 'SHELL': '/bin/bash', 09:23:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p8claiKdtt/Listeners', 09:23:47 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 09:23:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:47 INFO - 'USER': 'cltbld', 09:23:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:47 INFO - 'XPC_FLAGS': '0x0', 09:23:47 INFO - 'XPC_SERVICE_NAME': '0', 09:23:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:47 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)) 09:23:47 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)) 09:23:47 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)) 09:23:47 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)) 09:23:47 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)) 09:23:47 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)) 09:23:47 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)) 09:23:47 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)) 09:23:47 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)) 09:23:47 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)) 09:23:47 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)) 09:23:47 INFO - Cleaning up... 09:23:47 INFO - Return code: 0 09:23:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:47 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 0x10b243a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b2d8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc24a5592f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1a7d30>, '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 0x10af0cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b19fb20>, '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.egkkwt36VD/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.p8claiKdtt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 09:23:47 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 09:23:47 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 09:23:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.egkkwt36VD/Render', 09:23:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:47 INFO - 'HOME': '/Users/cltbld', 09:23:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:47 INFO - 'LOGNAME': 'cltbld', 09:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:47 INFO - 'MOZ_NO_REMOTE': '1', 09:23:47 INFO - 'NO_EM_RESTART': '1', 09:23:47 INFO - 'PAGER': '/bin/cat', 09:23:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:47 INFO - 'PWD': '/builds/slave/test', 09:23:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:47 INFO - 'SHELL': '/bin/bash', 09:23:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p8claiKdtt/Listeners', 09:23:47 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 09:23:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:47 INFO - 'USER': 'cltbld', 09:23:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:47 INFO - 'XPC_FLAGS': '0x0', 09:23:47 INFO - 'XPC_SERVICE_NAME': '0', 09:23:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:23:48 INFO - Cleaning up... 09:23:48 INFO - Return code: 0 09:23:48 INFO - Running post-action listener: _resource_record_post_action 09:23:48 INFO - Running post-action listener: _start_resource_monitoring 09:23:48 INFO - Starting resource monitoring. 09:23:48 INFO - [mozharness: 2016-08-27 16:23:48.257719Z] Finished create-virtualenv step (success) 09:23:48 INFO - [mozharness: 2016-08-27 16:23:48.258729Z] Running install step. 09:23:48 INFO - Running pre-action listener: _resource_record_pre_action 09:23:48 INFO - Running main action method: install 09:23:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:23:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:23:48 INFO - Reading from file tmpfile_stdout 09:23:48 INFO - Detecting whether we're running mozinstall >=1.0... 09:23:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:23:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:23:48 INFO - Reading from file tmpfile_stdout 09:23:48 INFO - Output received: 09:23:48 INFO - Usage: mozinstall [options] installer 09:23:48 INFO - Options: 09:23:48 INFO - -h, --help show this help message and exit 09:23:48 INFO - -d DEST, --destination=DEST 09:23:48 INFO - Directory to install application into. [default: 09:23:48 INFO - "/builds/slave/test"] 09:23:48 INFO - --app=APP Application being installed. [default: firefox] 09:23:48 INFO - mkdir: /builds/slave/test/build/application 09:23:48 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'] 09:23:48 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 09:24:23 INFO - Reading from file tmpfile_stdout 09:24:23 INFO - Output received: 09:24:23 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:24:23 INFO - Running post-action listener: _resource_record_post_action 09:24:23 INFO - [mozharness: 2016-08-27 16:24:23.064659Z] Finished install step (success) 09:24:23 INFO - [mozharness: 2016-08-27 16:24:23.064869Z] Running run-tests step. 09:24:23 INFO - Running pre-action listener: _resource_record_pre_action 09:24:23 INFO - Running main action method: run_tests 09:24:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:24:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:24:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:24:23 INFO - 2016-08-27 09:24:23.079 screenresolution[1981:20652] starting screenresolution argv=screenresolution get 09:24:23 INFO - 2016-08-27 09:24:23.082 screenresolution[1981:20652] Display 0: 1600x1200x32@60 09:24:23 INFO - 2016-08-27 09:24:23.087 screenresolution[1982:20654] starting screenresolution argv=screenresolution list 09:24:23 INFO - Available Modes on Display 0 09:24:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:24:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:24:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:24:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:24:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:24:23 INFO - Intel Iris: 09:24:23 INFO - Chipset Model: Intel Iris 09:24:23 INFO - Type: GPU 09:24:23 INFO - Bus: Built-In 09:24:23 INFO - VRAM (Dynamic, Max): 1536 MB 09:24:23 INFO - Vendor: Intel (0x8086) 09:24:23 INFO - Device ID: 0x0a2e 09:24:23 INFO - Revision ID: 0x0009 09:24:23 INFO - Displays: 09:24:23 INFO - Display: 09:24:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:24:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:24:23 INFO - Display Serial Number: 1600x1200 60 09:24:23 INFO - Main Display: Yes 09:24:23 INFO - Mirror: Off 09:24:23 INFO - Online: Yes 09:24:23 INFO - Rotation: Supported 09:24:23 INFO - Return code: 0 09:24:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:24:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:24:23 INFO - Python 2.7.3 09:24:23 INFO - Return code: 0 09:24:23 INFO - grabbing minidump binary from tooltool 09:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:23 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 0x10b1a7d30>, '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 0x10af0cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b19fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:24:23 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 09:24:23 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 09:24:23 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 09:24:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:24:23 INFO - Return code: 0 09:24:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:24:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:24:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:24:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:24:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:24:23 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/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0383', '--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 09:24:23 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/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0383 --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 09:24:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.egkkwt36VD/Render', 09:24:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:23 INFO - 'HOME': '/Users/cltbld', 09:24:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:23 INFO - 'LOGNAME': 'cltbld', 09:24:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:24:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:23 INFO - 'MOZ_NO_REMOTE': '1', 09:24:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:24:23 INFO - 'NO_EM_RESTART': '1', 09:24:23 INFO - 'PAGER': '/bin/cat', 09:24:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:23 INFO - 'PWD': '/builds/slave/test', 09:24:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:24:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:23 INFO - 'SHELL': '/bin/bash', 09:24:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p8claiKdtt/Listeners', 09:24:23 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 09:24:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:23 INFO - 'USER': 'cltbld', 09:24:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:23 INFO - 'XPC_FLAGS': '0x0', 09:24:23 INFO - 'XPC_SERVICE_NAME': '0', 09:24:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:23 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/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0383', '--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 09:24:23 INFO - mozversion application_buildid: 20160827055712 09:24:23 INFO - mozversion application_changeset: 1a5b53a831e5a6c20de1b081c774feb3ff76756c 09:24:23 INFO - mozversion application_display_name: Nightly 09:24:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:24:23 INFO - mozversion application_name: Firefox 09:24:23 INFO - mozversion application_remotingname: firefox 09:24:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:24:23 INFO - mozversion application_vendor: Mozilla 09:24:23 INFO - mozversion application_version: 51.0a1 09:24:23 INFO - mozversion platform_buildid: 20160827055712 09:24:23 INFO - mozversion platform_changeset: 1a5b53a831e5a6c20de1b081c774feb3ff76756c 09:24:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:24:23 INFO - mozversion platform_version: 51.0a1 09:24:23 INFO - using testdate: 1472315063 09:24:23 INFO - actual date: 1472315063 09:24:23 INFO - starting webserver on 'localhost:49593' 09:24:23 INFO - SUITE-START | Running 2 tests 09:24:23 INFO - TEST-START | dromaeo_css 09:24:23 INFO - operating with platform_type : mac_ 09:24:23 INFO - Initialising browser for dromaeo_css test... 09:24:23 INFO - TEST-INFO | started process 1992 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/tmpfsLCb1/profile http://localhost:49593/getInfo.html) 09:24:26 INFO - PROCESS | 1992 | __metrics Screen width/height:1600/1200 09:24:26 INFO - PROCESS | 1992 | colorDepth:24 09:24:26 INFO - PROCESS | 1992 | Browser inner width/height: 1024/689 09:24:26 INFO - PROCESS | 1992 | __metrics 09:24:26 ERROR - PROCESS | 1992 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 09:24:27 INFO - TEST-INFO | 1992: exit 0 09:24:27 INFO - Browser initialized. 09:24:27 INFO - Running cycle 1/1 for dromaeo_css test... 09:24:27 INFO - TEST-INFO | started process 1995 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/tmpfsLCb1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:24:39 INFO - PROCESS | 1995 | RSS: Main: 243843072 09:24:39 INFO - PROCESS | 1995 | 09:25:28 INFO - PROCESS | 1995 | 1472315128701 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] 09:27:40 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49593/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49593/tests/dromaeo/cssquery-ext.html) 09:27:42 INFO - PROCESS | 1995 | RSS: Main: 266813440 09:27:42 INFO - PROCESS | 1995 | 09:30:44 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49593/tests/dromaeo/cssquery-ext.html (next: http://localhost:49593/tests/dromaeo/cssquery-jquery.html) 09:30:45 INFO - PROCESS | 1995 | RSS: Main: 275714048 09:30:45 INFO - PROCESS | 1995 | 09:33:47 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49593/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49593/tests/dromaeo/cssquery-mootools.html) 09:33:47 INFO - PROCESS | 1995 | RSS: Main: 277360640 09:33:47 INFO - PROCESS | 1995 | 09:36:49 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49593/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49593/tests/dromaeo/cssquery-prototype.html) 09:36:50 INFO - PROCESS | 1995 | RSS: Main: 272683008 09:36:50 INFO - PROCESS | 1995 | 09:39:52 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49593/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49593/tests/dromaeo/cssquery-yui.html) 09:39:53 INFO - PROCESS | 1995 | RSS: Main: 277827584 09:39:53 INFO - PROCESS | 1995 | 09:42:56 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49593/tests/dromaeo/cssquery-yui.html (next: http://localhost:49593/tests/dromaeo/cssquery-dojo.html) 09:42:56 INFO - PROCESS | 1995 | RSS: Main: 280997888 09:42:56 INFO - PROCESS | 1995 | 09:42:56 INFO - PROCESS | 1995 | __start_tp_report 09:42:56 INFO - PROCESS | 1995 | _x_x_mozilla_page_load 09:42:56 INFO - PROCESS | 1995 | _x_x_mozilla_page_load_details 09:42:56 INFO - PROCESS | 1995 | |i|pagename|runs| 09:42:56 INFO - PROCESS | 1995 | |0;dojo.html;3056.2817737831606;3381.6280209177003;3403.45544712846;3404.948925766113;3415.658434156584;5668.659880407178;5741.511971482424;5838.883222335561;5839.7372118254625;5848.391317810873;5720.456556627114;5759.452851979066;5776.711164441782;5795.391483894183;5896.292444906617;5154.948450515484;5298.1522956327;5300.549453296474;5346.973265133688;5353;5147.408048074463;5208.2968799212;5287.101192797234;5291.31212942317;5406.83779486616;5227.059129356714;5295.7881684732565;5304.389995150568;5326.067938110835;5371.57027437804;5285.101532739443;5295.947040529584;5296.867578310535;5325.973370133163;5390.811321603725;5136.717480538568;5202.895942081137;5267.973660131714;5319.095753721838;5334.5732341412595;5580.972095139539;5724.284464441945;5740.138979153118;5754.741036653319;5761.971190144022;4937.851864444073;5121.770775014007;6016.42843929826;6271.717772700239;6307.9684601577155;5286.5506431952945;6181.505479561624;6243.906341404882;6265.342139075377;6266.279377871558;5952.196453478811;5964.194833697396;5968.403159683997;5977;6029.427204415573;5348.812791552277;6329.050642403677;6350.841228969312;6353.110564520971;6371.936280637135;6053.51571874249;6125.662799505599;6169.96915015431;6172.9074063889075;6266.185395898504;6254.343293954069;6259.624422534663;6272.937270627326;6279.529035322369;6280.120783090371;6226.59527130735;6257.655828929453;6282.717277722513;6296.464800491918;6313.40022697843;6189.721462534107;6218.844528886814;6229.906551401733;6245.156903818017;6283.874322513524;4986.276989836453;5021.623378246646;5039.244113382949;5051.419086805065;5065.417476990193;4172.5410204877435;4518.570735780096;4552.9772351138035;4559.088182363541;4559.293309536961;5704.058830293038;5949.286085669747;5961.2846458425265;5994.940050599525;6044.395560443921;6250.093736408196;6250.624962502174;6261.624302541862;6263.060540918898;6278.968605156945;5981.790637327673;6006.339302676702;6006.789762358297;6007.879842403127;6058.091286307089;5394.056040192951;5457.45425457459;5482.91775623358;5516.089845175501;5528.55771538276;6236.906446403307;6266.624002559861;6301.338359472281;6314.400131987454;6395.456386207225;6178.073289006685;6251.9062214067735;6255.78104766331;6264.655443950626;6322.146510221245;6178.443940045418;6359.618422894641;6370.458511026614;6373.235211774617;6388.1376014237485;6166.260048794174;6198.297566239161;6227.128202051807;6257.09272155544;6271.96864015677;6227.128202051807;6237.688115594293;6257.2491301044165;6260.843478913063;6274.843128921813;5630.155476678531;6033.54748393881;6101.511879049576;6143.082036032849;6202.069689546423;6123.892747182578;6133.548895741652;6143.450468055886;6180.7527698891545;6203.596766210362;5082.263071854634;6044.879102418015;6056.9697151513965;6082.787102451393;6085.4523092921845;6051.1830902829315;6221.688915554114;6225.62646241227;6231.53263505248;6240.188775459162;5985.012472941916;6016.759329626941;6018.097285407224;6036.215292012011;6095.2685677718955 09:42:56 INFO - PROCESS | 1995 | |1;ext.html;474.9811654002165;497.5149229501236;530.8407477756672;533.8985592737379;535.8211933745761;38884.22231555367;39749.60876369328;39978.40032399509;39995.40006899892;40048;40515.54329023805;41048;41135.58864411355;41138.79430602843;41144.76565703034;9627.181689556395;9871.062249086326;9872.210223182128;9886.505674716236;9892.703218903409;8735.475871447734;8952.820943581124;9513.43028400313;9776.217902567812;9937.304388692759;9206.815863682723;9293.44239345638;9876.96291889352;9965.651202207924;10069.295149339549;9834.655787047455;9861.506924653739;9879.851802222973;9894.90105098947;9927.652532161339;9733.756656083584;9752.853707194397;9840.11438970489;9860.06329398706;9878.802423951553;38401;38419.039524011845;38529.61470385288;38732.41901371482;38848.41727374092;3305.9173520661934;3438.329525742481;3450.3789317922765;3591.407417776064;3942.4874766280486;30026;30506;31090.844545777127;31167.844160779277;31221.37557248865;3218.09893229896;3246.8376581171083;3255.869765209389;3282.2286762610765;3342.9832850835833;372787.99999999726;428240;430865.8456707728;431237;433728;32627.673723262462;33558.49662255068;57257;57647;57708;33149.3370132596;33194.66805331964;33208.66791332104;33427.83002594898;33608.83195584006;14312;14390.208538530482;14430.927845360917;14435.133891966516;14448.2662080551;12260.386980650932;12326.81509777354;12330.383480826102;12348.506059757688;12380.504779808707;7462.02993610838;7550.056242969629;7567.697292108364;7616.961915190389;7643.694252229849;3163.636181839118;3231.9838400807844;3233.3856567252146;3247.366763481146;3257.6253730820786;876.5923845411914;883.337496877342;900.5587262241454;1028.5165971993151;1133.886611338876;28030.85984570105;29022.709772902424;29154;29286.707132928823;29679.703202968125;1018.332991890313;1067.765091679829;1106.2919731371928;1115.9442027898572;1121.9551217951355;14745.705085898437;15327.398061455771;15389.153596552072;15452.5364239073;15606.84393156054;579763;582026;582208;583656;584883;52842.67893302621;53667.463325367025;53981.730091349295;54057.72971135119;54067.45932540703;1217.4643157010887;1343.8051482534977;1358.280111540885;1381.530279704885;1381.9032667713366;26739.732602673725;28540.001099961402;28725.71274287314;28735.28161795888;29501.85249073741;46479;46609.53390466052;46698;46939.53060469488;46949;501144;506009;507108;507110;507651;25109.372265693502;25250.873745631154;25356.366090847878;25562;26236.475270494866;44289.77855110704;44370;44972.325415118146;45031;46379.07241855212;34813.9555813326;37552.62447375491;37641.81179094087;38422.615773841906;39199;34519.61921523111;37511;37844.810775945945;38255.97330632258;38858.80570597242;32089.67910320867;37210.25579488341;37258.254834903695;37651.05872353104;37896.67361642329;32677.673223267462;32841.67158328386;33638.49542256917;33953.83023084869;34319;21670.34988950334;24759.62860557057;24972.37569060788;24975.375615609755;25441.872790635927 09:42:56 INFO - PROCESS | 1995 | |2;jquery.html;316.2930849551253;334.89985397967666;359.2581319575077;377.91496913194516;383.82919600777666;17024;20015.19939202432;20569.588608227827;21067.0519826608;21363.893180534076;18066.72899906499;20741.377758667226;20920;21424.46438839026;21434.89282553585;5904.55715821313;6103.847403814896;6188;6228.346023667517;6233.7818176363835;6020.909686354708;6141.969290153543;6151.784687535937;6159.73725386297;6165.445109940105;5701.372848986629;5951;6012.9398706013035;6067.271927368722;6104.9389506105035;5530.087535556629;6060.606060606046;6087.634741915499;6090.939090609081;6108.083787431899;4885.975570122162;5747.626404283708;5771.336296325934;5785.132230165509;5788.305403351625;12810.29543375114;13166.144200627024;13279.668008299774;13480.39338229782;13498.595042148652;2422.1643532981093;2625;2716.755492005729;2794.2315863137596;2794.776417886564;8254.380921430917;9808.215342772632;9830.803383932353;10045.899541004643;10085.747856303578;1826.4611939477752;1828.5337239003968;1847.214933653192;1893.517153125944;1944.3777991042873;110893;125746;127752;131621.3418932899;133683.33158334243;9732.854007189897;11186.32882027081;11314.434278286053;11653.766924661459;11676.299422034705;14590.708185836436;14601.488947886985;14618.707625847635;14649.267536623127;14666.926665366818;8393;8658.090900455361;8660.48037117775;8765.824683506422;8786.428882122642;8665.566721663892;8672.69645562415;8701.17338852808;8808.955955220183;8840.939087309564;4392.297232442857;4460.643148548108;4543.432070991126;4585.358049873021;4620.052889157714;1901.6862217734197;1915.7413749143966;1917.8561607879465;1934.5550523379702;1948.5156425557245;770.5684816502776;810.5825499867454;870.3472395703222;936.8454205056089;953.2040745977048;20050;21127.471813204793;21492.24777132793;21510;21597.67603485949;890.0743227043931;909.6497848328441;926.4765407544851;951.8667386565886;953.1374106433689;10546.894531054591;10643;11230.494627741771;11368.147388945863;11491.77016459666;476175;549236;578628;603489;605362;126801.09798353032;131681;132292;137824.6217537832;144180;845.4082142500274;894.3381897395881;992.0327680511443;1007.6624330849247;1025.6974192613197;16178.433754818525;19006.524836879187;19447.902760486108;19850.305239316556;19906;52674;53012.73493632507;54969.1754623689;55009;55572.72213638906;74101.8487966334;76593.61703191671;78277.8258326137;80338;82770;11989.22070065443;12445.315507647167;12486.687832804253;12723.491060357483;12759.681007974876;13674.521391751241;13727;13911.930440347733;13934.930325348309;13953.651158721113;9751;10906.781864362509;11358.488868000795;11763.176577639482;11996.940015299868;10545.420001899969;11694.649160525198;11830.822537662114;11843.940780296043;12204.511819527119;10598.788024239626;11138.665840024812;11694.824577631172;12091.576794812492;12246;9903.752406189902;12133.939330303645;12247.816282755588;12358.752824943631;12645.241285522898;11661.941690291495;11984.40077996114;12050.879491205327;12112.636620901387;12142 09:42:56 INFO - PROCESS | 1995 | |3;mootools.html;1500.5423345879506;1531.6247519357757;1738.2091148527422;1838.6690395728763;1854.8145185481453;7987.760367188979;8425.36809739269;8588.355873309496;8956.910430895698;8975.685850995216;8682.348823838222;8696.91303086969;8811.295096392274;8819.51492667903;8837;1929.9421017369466;2318.8608683479047;2326.8603883767028;2327.278543651465;2328.7541165476473;2286.942826429336;2307.238611258281;2325.430269583954;2325.616273314901;2334.9066037358484;2308.9422764430856;2323.256557901472;2341.4146463384154;2345.7536958619357;2347.4600841806396;1982.5043739065234;2000.7198992141111;2281.4866655002656;2297.597920363938;2306.7001289832215;1949.3567122849427;2310.260716570698;2313.363824948136;2314.930552083423;2326.1858349577683;8803.691870784492;8868.37921345506;8869.911300886974;8925.107489251088;8938.703887936277;5231.581473482151;5394.083005889008;5398.6220964532495;5412.134058550652;5412.4858138477175;3429.4855771634207;3448.3620530201993;3512.102515424785;3565.8248468434235;3661.3958696814993;1063.728749168957;1073.5544748929185;1081.3457857995877;1086.1745073744012;1102.9834552481718;11232.775344493064;11544.191906566544;11545.191836571443;11552.191346605741;11577.363245021605;4603.746793926366;4605.078984203105;4790.281457781291;4797.160496913027;4798.304245884327;9904.15814655748;9973.351732137533;9985.900140998643;9990.100890919852;10028.949855250678;5351.598630102758;5375.9462405376225;5384.9461505385225;5385.219143224289;5392.433794451605;4402.0755641315045;4654.325122857234;4782.832600858953;4922.9753851231235;4932.1122198004705;3902.785346805953;3922;4026.154507553388;4054.5134583850127;4055.5538890721996;1273.6879464531248;1277.8083287506763;1280.609414128681;1290.9096363254482;1294.9741005179844;819.4760138772566;882.6910581296495;885.7254251182154;912.7353067610452;938.0853667674099;5563.582731295169;5794.913076303858;5961.791337303173;5966.0841732768495;6076.210092687922;443.4124784660338;447.57480393626184;450.5111953530456;1012.4077414712476;1018.8777346718441;3792.2036372362113;3834.9616503835164;3940.1134744682217;3942.1918506706056;3995.3019966514116;9393.624255029723;10597.986382587284;10606.363618182779;10726.517306721216;10823.56705731762;9936.80126397468;10185.898141018642;10484.790304193873;10665.200109991782;10679.83980240297;6500.707468163944;7976.322012628992;8100.878486822702;8204.712835050745;8206.712765053315;4952.331435256195;5875.618084824473;5911.349751527243;5947.702614869153;6022.156898034366;9668.661596844358;9713.514324283899;9873.555689993824;9930.801383972135;10005.749856253651;10142.898571014195;10207.387556746618;10211.438370889673;10221.23340749432;10225.386476811414;6600.471962242913;6867.896981545181;7256.238094999949;7427.740029098955;7442.4418168636485;8307;8361.456505327134;8430.030546487233;8432.03031651368;8454.704085356983;7192.244814294424;7391.40868730511;7523.661435235537;7634.351080158249;7712.151663317143;7165.534240274365;7309.122905251404;7317.707291708272;7428.2571742825285;7472.476926615085;6943.79168624942;6971.721131154697;7012.789616311519;7025.0516180317045;7029.472789540702;4272.376496931146;4971;4986.476419975996;5022.949770502249;5111.131107711623;4479.70881892676;4594.5864872161665;4902.2156454967035;4973.875653108701;5080.46655101209 09:42:56 INFO - PROCESS | 1995 | |4;prototype.html;244.91795248591714;262.6336260916022;293.68868998861194;311.6602902835908;313.374817239607;5468.152436372358;5560.249366335549;5591.524720398766;5629.268195134627;5750.769969201232;4673.6494762892835;5678.318601767784;5698.951061182258;5755.453231942969;5761.193432919395;4366.912661746763;4368.584984426474;4380.540043295456;4392.560743925598;4405.3391991201415;3589.53336066311;4000.1398999715198;4081.877483691994;4425.114977004596;4440.844570440036;4194.951262184454;4221.197972385252;4224.584764104029;4262.957370426287;4282.957170428287;3582.946255806165;4266.168097221043;4266.935995960063;4298.398224248592;4307.427788857076;3496.8776092836883;3498.247876706495;3548;3631.1648320886343;3634.872779452733;4105.768269519132;5252.3171987641745;5484.232207490954;5568.1301495460675;5568.691357530977;4368.49762277339;4921.7785199666105;4933.235348520985;4949.950500494985;4964.329815474901;5175.739284250935;5901.586888917777;5996.220491336142;6033.668148251844;6043.8186854394435;3901.551321597996;3958.5843486434087;3967.3850553164307;4000.439938408625;4013.7591744495426;5500.944990550123;6210.223722034746;6229.162397092869;6314.305426403138;6394.840128996812;3426.3489936911906;3784.375578029594;4027.375756757707;4028.3756017817286;4058.857939972087;3280.114369120324;3423.5891692997;3591.5690117186105;4074.3277359235394;4138.461999940048;4290.806913688892;4793.976030119827;4852;4886.971906658697;4911.45973942866;5425.864353391197;6098.878022439526;6099.664518451527;6132.044831084015;6145.907811382833;1188.7741329147434;1225.994684358835;1386.5147198480452;1399.734050530396;1403.9087459315112;744.8901137305376;761.9428542859197;818.5129847740585;829.4649950781712;835.8787975743484;4515.7967891444305;4698.718076915327;4750.596199323097;4786.7845946932475;4929.679570827885;4327.653787696977;4884.658073934862;4960.0327936052845;5119.283300337956;5136.640435169502;3991.042149884007;4349.6294519486955;4377.627901628397;4543.977280113644;4724.7635369771815;2291.346966114649;2426.866522341288;2519.685039370079;2710.79070557495;2796.972030279712;4507.977460112678;4786.7845946932475;4977.506747975665;5288.646552284274;5407.053460754126;4955.950440495549;5011.949880501221;5058.684741967115;5108.642395032386;5393.757280922289;4793.424789025269;4855.708657480563;4856.68431551948;5201;5240.030594339983;4842.903141937212;5012.674176178537;5072.239164125411;5136.587438454455;5189.870253243699;4130.772807495617;4587.77061146948;5072.641221831718;5082.870745342778;5144.897102057863;4489.865304040884;4890.951090489049;4969.527894849984;5201.947980520146;5454.209139674805;3017.6227971503563;3331.766776325634;3586;3595.5865075515603;3622.192800579572;4331.848385306499;4491.73049617024;4745.786439610157;4897.730624815526;5207.921881171861;5435.755391007493;5879.470847623564;5879.794207202898;5942.662900847275;5969.343372228965;5018.598512118949;5904.557158213237;5906.793262235973;5922.482944748551;5986.07215881539;5133.486651334986;5517.503424691797;5661.547076233974;5696.0095949626775;5782.363939966516;4955.11705551888;5137.717425541631;5391.649542779707;5566.693831839288;5678.14827775837;5508.56199711164;5547.890421915714;5773.393793651606;5861.325947515919;5887.4406931341455 09:42:56 INFO - PROCESS | 1995 | |5;yui.html;700.6426722371591;717.8743719849028;725.5030304241599;762.60725726251;786.3434032582795;15009.924950375247;15790.763138552917;15797.842021579781;15798.289076991534;15800.130992795392;14146;14241.857581424183;14400.27998600071;14463.20452375119;15280.044316021133;846.1327139681829;854.6538651846013;870.2428886868433;870.4472659861002;873.6461732998114;831.9833603327929;857.0786404615033;857.1685465098844;857.5797859049084;860.165639329849;697.2817997462622;874.3398733955854;902.7021083042613;906.4425378392307;906.8503696890006;862.9611667474978;894.3828758156851;896.1307531694246;898.4968417686117;898.595631965618;640.1198352265635;647.3979199344608;653.7417720000573;662.8740539297567;662.993370066298;14997.550073497703;15039.548813535612;15072.397104115822;15311.234438278041;15412.229388530528;13513.797293040514;13591.592252232449;13591.86408135916;13613.863861361458;13952.720945581133;12810.23138611677;13075.411606477732;13153.473861045546;13244.86755132446;13260.73478530424;3995.4006898965386;4476.84331048415;4514.157588745351;4525.9547404525865;4585.95414045862;98297;105131.3993003996;120494;125868;127405;8984.46093234408;10118.139958103497;10752.40861752611;10786.622468213733;11204.327740335606;20572.79427205739;20714.067866946025;20909.05909234088;20974.370768876957;21015;7736.149023607399;7829.217078292239;7905.723299684599;7907.288344049063;7995.7601271960775;4331.242032644338;4361.666508417981;4381.452318460192;4429;4531.478879928851;3104.3170502489866;3470.809105499222;3530.470429435605;3550.1124718820297;3592.4252119660728;606.342118801097;655.5804285257439;662.867426514699;663.4427081251772;669.0866966590569;512.7564406906764;527.733494585232;555.5971920357708;625.680902739606;641.7657554992394;9022.413543119676;9199.908000919904;9281.90718092824;9299.767505812273;9391.248700103975;589.9174115623816;624.8687775567091;628.9622622642656;630.2972186012655;633.9539759397031;4321.67587430944;4367.170237654836;4427.358033085185;4560.7122372128715;4615.284630882219;96907.51546242223;97354;98366;134075;137673.3116334432;109573;118986.40506797584;120890.99999999824;121859.17211241838;124089;104527;105378.41932371174;107123;109750;115414.42292788482;8008.639611217625;8854.778630534289;8989.786378839035;9166.587503562223;9969;64632;64956.67521662361;66378.66810665916;66406.66796665985;67177.66411167913;92549.537252316;94725.52637236769;97614;97779;98395;12997;13006.544770933351;13040.934795325962;13059.477620895057;13413.798793017917;11831.585894493652;14106.435742570182;14494.202818844644;14513.564593062225;15255.847441525442;13540.187588744708;13592.592222233348;13634.591352161959;13716.451341946211;14337.85662143407;13567.118137321042;13622.318884055956;14007.509737159151;14132.717345652823;14323.355449005028;13345.866541334462;13415.463381464631;13634.86365136336;13749.175049497062;13899.235542045284;10968.23222374426;11088.223824332219;11197.272177308449;11253;11466;9273.211776999031;9439.81120377575;10780;11100.15215872085;11523.078153747847 09:42:56 INFO - PROCESS | 1995 | __end_tp_report 09:42:56 INFO - PROCESS | 1995 | __start_cc_report 09:42:56 INFO - PROCESS | 1995 | _x_x_mozilla_cycle_collect,371 09:42:56 INFO - PROCESS | 1995 | __end_cc_report 09:42:56 INFO - PROCESS | 1995 | __startTimestamp1472316176515__endTimestamp 09:42:56 INFO - PROCESS | 1995 | 09:42:56 INFO - PROCESS | 1995 | ------- Summary: start ------- 09:42:56 INFO - PROCESS | 1995 | Number of tests: 6 09:42:56 INFO - PROCESS | 1995 | 09:42:56 INFO - PROCESS | 1995 | [#0] dojo.html Cycles:165 Average:5779.63 Median:6029.43 stddev:643.98 (10.7%) stddev-sans-first:609.48 09:42:56 INFO - PROCESS | 1995 | Values: 3056.3 3381.6 3403.5 3404.9 3415.7 5668.7 5741.5 5838.9 5839.7 5848.4 5720.5 5759.5 5776.7 5795.4 5896.3 5154.9 5298.2 5300.5 5347.0 5353.0 5147.4 5208.3 5287.1 5291.3 5406.8 5227.1 5295.8 5304.4 5326.1 5371.6 5285.1 5295.9 5296.9 5326.0 5390.8 5136.7 5202.9 5268.0 5319.1 5334.6 5581.0 5724.3 5740.1 5754.7 5762.0 4937.9 5121.8 6016.4 6271.7 6308.0 5286.6 6181.5 6243.9 6265.3 6266.3 5952.2 5964.2 5968.4 5977.0 6029.4 5348.8 6329.1 6350.8 6353.1 6371.9 6053.5 6125.7 6170.0 6172.9 6266.2 6254.3 6259.6 6272.9 6279.5 6280.1 6226.6 6257.7 6282.7 6296.5 6313.4 6189.7 6218.8 6229.9 6245.2 6283.9 4986.3 5021.6 5039.2 5051.4 5065.4 4172.5 4518.6 4553.0 4559.1 4559.3 5704.1 5949.3 5961.3 5994.9 6044.4 6250.1 6250.6 6261.6 6263.1 6279.0 5981.8 6006.3 6006.8 6007.9 6058.1 5394.1 5457.5 5482.9 5516.1 5528.6 6236.9 6266.6 6301.3 6314.4 6395.5 6178.1 6251.9 6255.8 6264.7 6322.1 6178.4 6359.6 6370.5 6373.2 6388.1 6166.3 6198.3 6227.1 6257.1 6272.0 6227.1 6237.7 6257.2 6260.8 6274.8 5630.2 6033.5 6101.5 6143.1 6202.1 6123.9 6133.5 6143.5 6180.8 6203.6 5082.3 6044.9 6057.0 6082.8 6085.5 6051.2 6221.7 6225.6 6231.5 6240.2 5985.0 6016.8 6018.1 6036.2 6095.3 09:42:56 INFO - PROCESS | 1995 | 09:42:56 INFO - PROCESS | 1995 | [#1] ext.html Cycles:180 Average:62462.84 Median:38076.32 stddev:135446.31 (355.7%) stddev-sans-first:135746.31 09:42:56 INFO - PROCESS | 1995 | Values: 475.0 497.5 530.8 533.9 535.8 38884.2 39749.6 39978.4 39995.4 40048.0 40515.5 41048.0 41135.6 41138.8 41144.8 9627.2 9871.1 9872.2 9886.5 9892.7 8735.5 8952.8 9513.4 9776.2 9937.3 9206.8 9293.4 9877.0 9965.7 10069.3 9834.7 9861.5 9879.9 9894.9 9927.7 9733.8 9752.9 9840.1 9860.1 9878.8 38401.0 38419.0 38529.6 38732.4 38848.4 3305.9 3438.3 3450.4 3591.4 3942.5 30026.0 30506.0 31090.8 31167.8 31221.4 3218.1 3246.8 3255.9 3282.2 3343.0 372788.0 428240.0 430865.8 431237.0 433728.0 32627.7 33558.5 57257.0 57647.0 57708.0 33149.3 33194.7 33208.7 33427.8 33608.8 14312.0 14390.2 14430.9 14435.1 14448.3 12260.4 12326.8 12330.4 12348.5 12380.5 7462.0 7550.1 7567.7 7617.0 7643.7 3163.6 3232.0 3233.4 3247.4 3257.6 876.6 883.3 900.6 1028.5 1133.9 28030.9 29022.7 29154.0 29286.7 29679.7 1018.3 1067.8 1106.3 1115.9 1122.0 14745.7 15327.4 15389.2 15452.5 15606.8 579763.0 582026.0 582208.0 583656.0 584883.0 52842.7 53667.5 53981.7 54057.7 54067.5 1217.5 1343.8 1358.3 1381.5 1381.9 26739.7 28540.0 28725.7 28735.3 29501.9 46479.0 46609.5 46698.0 46939.5 46949.0 501144.0 506009.0 507108.0 507110.0 507651.0 25109.4 25250.9 25356.4 25562.0 26236.5 44289.8 44370.0 44972.3 45031.0 46379.1 34814.0 37552.6 37641.8 38422.6 39199.0 34519.6 37511.0 37844.8 38256.0 38858.8 32089.7 37210.3 37258.3 37651.1 37896.7 32677.7 32841.7 33638.5 33953.8 34319.0 21670.3 24759.6 24972.4 24975.4 25441.9 09:42:56 INFO - PROCESS | 1995 | 09:42:56 INFO - PROCESS | 1995 | [#2] jquery.html Cycles:180 Average:34492.17 Median:21394.18 stddev:94966.52 (443.9%) stddev-sans-first:95198.26 09:42:56 INFO - PROCESS | 1995 | Values: 316.3 334.9 359.3 377.9 383.8 17024.0 20015.2 20569.6 21067.1 21363.9 18066.7 20741.4 20920.0 21424.5 21434.9 5904.6 6103.8 6188.0 6228.3 6233.8 6020.9 6142.0 6151.8 6159.7 6165.4 5701.4 5951.0 6012.9 6067.3 6104.9 5530.1 6060.6 6087.6 6090.9 6108.1 4886.0 5747.6 5771.3 5785.1 5788.3 12810.3 13166.1 13279.7 13480.4 13498.6 2422.2 2625.0 2716.8 2794.2 2794.8 8254.4 9808.2 9830.8 10045.9 10085.7 1826.5 1828.5 1847.2 1893.5 1944.4 110893.0 125746.0 127752.0 131621.3 133683.3 9732.9 11186.3 11314.4 11653.8 11676.3 14590.7 14601.5 14618.7 14649.3 14666.9 8393.0 8658.1 8660.5 8765.8 8786.4 8665.6 8672.7 8701.2 8809.0 8840.9 4392.3 4460.6 4543.4 4585.4 4620.1 1901.7 1915.7 1917.9 1934.6 1948.5 770.6 810.6 870.3 936.8 953.2 20050.0 21127.5 21492.2 21510.0 21597.7 890.1 909.6 926.5 951.9 953.1 10546.9 10643.0 11230.5 11368.1 11491.8 476175.0 549236.0 578628.0 603489.0 605362.0 126801.1 131681.0 132292.0 137824.6 144180.0 845.4 894.3 992.0 1007.7 1025.7 16178.4 19006.5 19447.9 19850.3 19906.0 52674.0 53012.7 54969.2 55009.0 55572.7 74101.8 76593.6 78277.8 80338.0 82770.0 11989.2 12445.3 12486.7 12723.5 12759.7 13674.5 13727.0 13911.9 13934.9 13953.7 9751.0 10906.8 11358.5 11763.2 11996.9 10545.4 11694.6 11830.8 11843.9 12204.5 10598.8 11138.7 11694.8 12091.6 12246.0 9903.8 12133.9 12247.8 12358.8 12645.2 11661.9 11984.4 12050.9 12112.6 12142.0 09:42:56 INFO - PROCESS | 1995 | 09:42:56 INFO - PROCESS | 1995 | [#3] mootools.html Cycles:180 Average:5654.23 Median:4850.26 stddev:3185.37 (65.7%) stddev-sans-first:3179.01 09:42:56 INFO - PROCESS | 1995 | Values: 1500.5 1531.6 1738.2 1838.7 1854.8 7987.8 8425.4 8588.4 8956.9 8975.7 8682.3 8696.9 8811.3 8819.5 8837.0 1929.9 2318.9 2326.9 2327.3 2328.8 2286.9 2307.2 2325.4 2325.6 2334.9 2308.9 2323.3 2341.4 2345.8 2347.5 1982.5 2000.7 2281.5 2297.6 2306.7 1949.4 2310.3 2313.4 2314.9 2326.2 8803.7 8868.4 8869.9 8925.1 8938.7 5231.6 5394.1 5398.6 5412.1 5412.5 3429.5 3448.4 3512.1 3565.8 3661.4 1063.7 1073.6 1081.3 1086.2 1103.0 11232.8 11544.2 11545.2 11552.2 11577.4 4603.7 4605.1 4790.3 4797.2 4798.3 9904.2 9973.4 9985.9 9990.1 10028.9 5351.6 5375.9 5384.9 5385.2 5392.4 4402.1 4654.3 4782.8 4923.0 4932.1 3902.8 3922.0 4026.2 4054.5 4055.6 1273.7 1277.8 1280.6 1290.9 1295.0 819.5 882.7 885.7 912.7 938.1 5563.6 5794.9 5961.8 5966.1 6076.2 443.4 447.6 450.5 1012.4 1018.9 3792.2 3835.0 3940.1 3942.2 3995.3 9393.6 10598.0 10606.4 10726.5 10823.6 9936.8 10185.9 10484.8 10665.2 10679.8 6500.7 7976.3 8100.9 8204.7 8206.7 4952.3 5875.6 5911.3 5947.7 6022.2 9668.7 9713.5 9873.6 9930.8 10005.7 10142.9 10207.4 10211.4 10221.2 10225.4 6600.5 6867.9 7256.2 7427.7 7442.4 8307.0 8361.5 8430.0 8432.0 8454.7 7192.2 7391.4 7523.7 7634.4 7712.2 7165.5 7309.1 7317.7 7428.3 7472.5 6943.8 6971.7 7012.8 7025.1 7029.5 4272.4 4971.0 4986.5 5022.9 5111.1 4479.7 4594.6 4902.2 4973.9 5080.5 09:42:56 INFO - PROCESS | 1995 | 09:42:56 INFO - PROCESS | 1995 | [#4] prototype.html Cycles:180 Average:4474.04 Median:4894.34 stddev:1391.59 (28.4%) stddev-sans-first:1358.81 09:42:56 INFO - PROCESS | 1995 | Values: 244.9 262.6 293.7 311.7 313.4 5468.2 5560.2 5591.5 5629.3 5750.8 4673.6 5678.3 5699.0 5755.5 5761.2 4366.9 4368.6 4380.5 4392.6 4405.3 3589.5 4000.1 4081.9 4425.1 4440.8 4195.0 4221.2 4224.6 4263.0 4283.0 3582.9 4266.2 4266.9 4298.4 4307.4 3496.9 3498.2 3548.0 3631.2 3634.9 4105.8 5252.3 5484.2 5568.1 5568.7 4368.5 4921.8 4933.2 4950.0 4964.3 5175.7 5901.6 5996.2 6033.7 6043.8 3901.6 3958.6 3967.4 4000.4 4013.8 5500.9 6210.2 6229.2 6314.3 6394.8 3426.3 3784.4 4027.4 4028.4 4058.9 3280.1 3423.6 3591.6 4074.3 4138.5 4290.8 4794.0 4852.0 4887.0 4911.5 5425.9 6098.9 6099.7 6132.0 6145.9 1188.8 1226.0 1386.5 1399.7 1403.9 744.9 761.9 818.5 829.5 835.9 4515.8 4698.7 4750.6 4786.8 4929.7 4327.7 4884.7 4960.0 5119.3 5136.6 3991.0 4349.6 4377.6 4544.0 4724.8 2291.3 2426.9 2519.7 2710.8 2797.0 4508.0 4786.8 4977.5 5288.6 5407.1 4956.0 5011.9 5058.7 5108.6 5393.8 4793.4 4855.7 4856.7 5201.0 5240.0 4842.9 5012.7 5072.2 5136.6 5189.9 4130.8 4587.8 5072.6 5082.9 5144.9 4489.9 4891.0 4969.5 5201.9 5454.2 3017.6 3331.8 3586.0 3595.6 3622.2 4331.8 4491.7 4745.8 4897.7 5207.9 5435.8 5879.5 5879.8 5942.7 5969.3 5018.6 5904.6 5906.8 5922.5 5986.1 5133.5 5517.5 5661.5 5696.0 5782.4 4955.1 5137.7 5391.6 5566.7 5678.1 5508.6 5547.9 5773.4 5861.3 5887.4 09:42:56 INFO - PROCESS | 1995 | 09:42:56 INFO - PROCESS | 1995 | [#5] yui.html Cycles:180 Average:23912.47 Median:4346.45 stddev:36853.45 (847.9%) stddev-sans-first:36915.62 09:42:56 INFO - PROCESS | 1995 | Values: 700.6 717.9 725.5 762.6 786.3 15009.9 15790.8 15797.8 15798.3 15800.1 14146.0 14241.9 14400.3 14463.2 15280.0 846.1 854.7 870.2 870.4 873.6 832.0 857.1 857.2 857.6 860.2 697.3 874.3 902.7 906.4 906.9 863.0 894.4 896.1 898.5 898.6 640.1 647.4 653.7 662.9 663.0 14997.6 15039.5 15072.4 15311.2 15412.2 13513.8 13591.6 13591.9 13613.9 13952.7 12810.2 13075.4 13153.5 13244.9 13260.7 3995.4 4476.8 4514.2 4526.0 4586.0 98297.0 105131.4 120494.0 125868.0 127405.0 8984.5 10118.1 10752.4 10786.6 11204.3 20572.8 20714.1 20909.1 20974.4 21015.0 7736.1 7829.2 7905.7 7907.3 7995.8 4331.2 4361.7 4381.5 4429.0 4531.5 3104.3 3470.8 3530.5 3550.1 3592.4 606.3 655.6 662.9 663.4 669.1 512.8 527.7 555.6 625.7 641.8 9022.4 9199.9 9281.9 9299.8 9391.2 589.9 624.9 629.0 630.3 634.0 4321.7 4367.2 4427.4 4560.7 4615.3 96907.5 97354.0 98366.0 134075.0 137673.3 109573.0 118986.4 120891.0 121859.2 124089.0 104527.0 105378.4 107123.0 109750.0 115414.4 8008.6 8854.8 8989.8 9166.6 9969.0 64632.0 64956.7 66378.7 66406.7 67177.7 92549.5 94725.5 97614.0 97779.0 98395.0 12997.0 13006.5 13040.9 13059.5 13413.8 11831.6 14106.4 14494.2 14513.6 15255.8 13540.2 13592.6 13634.6 13716.5 14337.9 13567.1 13622.3 14007.5 14132.7 14323.4 13345.9 13415.5 13634.9 13749.2 13899.2 10968.2 11088.2 11197.3 11253.0 11466.0 9273.2 9439.8 10780.0 11100.2 11523.1 09:42:56 INFO - PROCESS | 1995 | -------- Summary: end -------- 09:42:56 INFO - PROCESS | 1995 | 09:42:57 INFO - TEST-INFO | 1995: exit 0 09:42:57 INFO - TEST-OK | dromaeo_css | took 1113446ms 09:42:57 INFO - TEST-START | kraken 09:42:57 INFO - operating with platform_type : mac_ 09:42:57 INFO - Initialising browser for kraken test... 09:42:57 INFO - TEST-INFO | started process 2000 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/tmpYs2K3N/profile http://localhost:49593/getInfo.html) 09:43:00 INFO - PROCESS | 2000 | __metrics Screen width/height:1600/1200 09:43:00 INFO - PROCESS | 2000 | colorDepth:24 09:43:00 INFO - PROCESS | 2000 | Browser inner width/height: 1024/689 09:43:00 INFO - PROCESS | 2000 | __metrics 09:43:00 ERROR - PROCESS | 2000 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 09:43:00 INFO - TEST-INFO | 2000: exit 0 09:43:00 INFO - Browser initialized. 09:43:00 INFO - Running cycle 1/1 for kraken test... 09:43:00 INFO - TEST-INFO | started process 2002 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/tmpYs2K3N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:43:12 INFO - PROCESS | 2002 | RSS: Main: 243802112 09:43:12 INFO - PROCESS | 2002 | 09:43:15 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49593/tests/kraken/driver.html?testName=audio-beat-detection) 09:43:16 INFO - PROCESS | 2002 | RSS: Main: 256692224 09:43:16 INFO - PROCESS | 2002 | 09:43:19 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49593/tests/kraken/driver.html?testName=audio-dft) 09:43:19 INFO - PROCESS | 2002 | RSS: Main: 265334784 09:43:19 INFO - PROCESS | 2002 | 09:43:23 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49593/tests/kraken/driver.html?testName=audio-fft) 09:43:24 INFO - PROCESS | 2002 | RSS: Main: 262103040 09:43:24 INFO - PROCESS | 2002 | 09:43:26 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49593/tests/kraken/driver.html?testName=audio-oscillator) 09:43:26 INFO - PROCESS | 2002 | RSS: Main: 264548352 09:43:26 INFO - PROCESS | 2002 | 09:43:28 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49593/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:43:29 INFO - PROCESS | 2002 | RSS: Main: 265003008 09:43:29 INFO - PROCESS | 2002 | 09:43:32 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49593/tests/kraken/driver.html?testName=imaging-darkroom) 09:43:33 INFO - PROCESS | 2002 | RSS: Main: 265957376 09:43:33 INFO - PROCESS | 2002 | 09:43:36 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49593/tests/kraken/driver.html?testName=imaging-desaturate) 09:43:36 INFO - PROCESS | 2002 | RSS: Main: 266166272 09:43:36 INFO - PROCESS | 2002 | 09:43:39 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49593/tests/kraken/driver.html?testName=json-parse-financial) 09:43:40 INFO - PROCESS | 2002 | RSS: Main: 266326016 09:43:40 INFO - PROCESS | 2002 | 09:43:41 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49593/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:43:42 INFO - PROCESS | 2002 | RSS: Main: 266129408 09:43:42 INFO - PROCESS | 2002 | 09:43:44 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49593/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:43:45 INFO - PROCESS | 2002 | RSS: Main: 265515008 09:43:45 INFO - PROCESS | 2002 | 09:43:47 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49593/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:43:48 INFO - PROCESS | 2002 | RSS: Main: 265793536 09:43:48 INFO - PROCESS | 2002 | 09:43:51 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49593/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:43:51 INFO - PROCESS | 2002 | RSS: Main: 265973760 09:43:51 INFO - PROCESS | 2002 | 09:43:54 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49593/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:43:55 INFO - PROCESS | 2002 | RSS: Main: 266244096 09:43:55 INFO - PROCESS | 2002 | 09:43:57 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49593/tests/kraken/driver.html?testName=ai-astar) 09:43:57 INFO - PROCESS | 2002 | RSS: Main: 268087296 09:43:57 INFO - PROCESS | 2002 | 09:43:57 INFO - PROCESS | 2002 | __start_tp_report 09:43:57 INFO - PROCESS | 2002 | _x_x_mozilla_page_load 09:43:57 INFO - PROCESS | 2002 | _x_x_mozilla_page_load_details 09:43:57 INFO - PROCESS | 2002 | |i|pagename|runs| 09:43:57 INFO - PROCESS | 2002 | |0;ai-astar;120;111;117;117;119;103;118;116;125;169 09:43:57 INFO - PROCESS | 2002 | |1;audio-beat-detection;149;110;173;160;110;132;135;140;175;114 09:43:57 INFO - PROCESS | 2002 | |2;audio-dft;233;261;229;265;220;199;235;283;203;191 09:43:57 INFO - PROCESS | 2002 | |3;audio-fft;71;88;78;142;60;57;60;75;127;60 09:43:57 INFO - PROCESS | 2002 | |4;audio-oscillator;70;69;117;97;71;81;120;96;102;141 09:43:57 INFO - PROCESS | 2002 | |5;imaging-gaussian-blur;91;89;108;88;116;129;90;87;96;119 09:43:57 INFO - PROCESS | 2002 | |6;imaging-darkroom;98;102;100;99;99;100;111;100;149;169 09:43:57 INFO - PROCESS | 2002 | |7;imaging-desaturate;92;85;153;143;91;90;93;92;92;91 09:43:57 INFO - PROCESS | 2002 | |8;json-parse-financial;56;58;58;58;56;58;58;71;51;52 09:43:57 INFO - PROCESS | 2002 | |9;json-stringify-tinderbox;68;85;85;92;105;110;68;99;64;70 09:43:57 INFO - PROCESS | 2002 | |10;stanford-crypto-aes;85;97;86;78;100;107;110;88;99;75 09:43:57 INFO - PROCESS | 2002 | |11;stanford-crypto-ccm;141;138;154;147;166;139;126;154;170;143 09:43:57 INFO - PROCESS | 2002 | |12;stanford-crypto-pbkdf2;219;231;184;170;172;171;204;155;165;179 09:43:57 INFO - PROCESS | 2002 | |13;stanford-crypto-sha256-iterative;85;89;85;89;84;77;69;72;88;65 09:43:57 INFO - PROCESS | 2002 | __end_tp_report 09:43:57 INFO - PROCESS | 2002 | __start_cc_report 09:43:57 INFO - PROCESS | 2002 | _x_x_mozilla_cycle_collect,950 09:43:57 INFO - PROCESS | 2002 | __end_cc_report 09:43:57 INFO - PROCESS | 2002 | __startTimestamp1472316237571__endTimestamp 09:43:57 INFO - PROCESS | 2002 | 09:43:57 INFO - PROCESS | 2002 | ------- Summary: start ------- 09:43:57 INFO - PROCESS | 2002 | Number of tests: 14 09:43:57 INFO - PROCESS | 2002 | 09:43:57 INFO - PROCESS | 2002 | [#0] ai-astar Cycles:10 Average:121.50 Median:118.50 stddev:17.68 (14.9%) stddev-sans-first:18.74 09:43:57 INFO - PROCESS | 2002 | Values: 120.0 111.0 117.0 117.0 119.0 103.0 118.0 116.0 125.0 169.0 09:43:57 INFO - PROCESS | 2002 | 09:43:57 INFO - PROCESS | 2002 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:144.50 stddev:24.40 (16.9%) stddev-sans-first:25.66 09:43:57 INFO - PROCESS | 2002 | Values: 149.0 110.0 173.0 160.0 110.0 132.0 135.0 140.0 175.0 114.0 09:43:57 INFO - PROCESS | 2002 | 09:43:57 INFO - PROCESS | 2002 | [#2] audio-dft Cycles:10 Average:231.90 Median:234.00 stddev:30.38 (13.0%) stddev-sans-first:32.22 09:43:57 INFO - PROCESS | 2002 | Values: 233.0 261.0 229.0 265.0 220.0 199.0 235.0 283.0 203.0 191.0 09:43:57 INFO - PROCESS | 2002 | 09:43:57 INFO - PROCESS | 2002 | [#3] audio-fft Cycles:10 Average:81.80 Median:65.50 stddev:29.67 (45.3%) stddev-sans-first:31.21 09:43:57 INFO - PROCESS | 2002 | Values: 71.0 88.0 78.0 142.0 60.0 57.0 60.0 75.0 127.0 60.0 09:43:57 INFO - PROCESS | 2002 | 09:43:57 INFO - PROCESS | 2002 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:70.50 stddev:24.34 (34.5%) stddev-sans-first:23.87 09:43:57 INFO - PROCESS | 2002 | Values: 70.0 69.0 117.0 97.0 71.0 81.0 120.0 96.0 102.0 141.0 09:43:57 INFO - PROCESS | 2002 | 09:43:57 INFO - PROCESS | 2002 | [#5] imaging-gaussian-blur Cycles:10 Average:101.30 Median:88.50 stddev:15.41 (17.4%) stddev-sans-first:15.88 09:43:57 INFO - PROCESS | 2002 | Values: 91.0 89.0 108.0 88.0 116.0 129.0 90.0 87.0 96.0 119.0 09:43:57 INFO - PROCESS | 2002 | 09:43:57 INFO - PROCESS | 2002 | [#6] imaging-darkroom Cycles:10 Average:112.70 Median:159.00 stddev:25.12 (15.8%) stddev-sans-first:26.08 09:43:57 INFO - PROCESS | 2002 | Values: 98.0 102.0 100.0 99.0 99.0 100.0 111.0 100.0 149.0 169.0 09:43:57 INFO - PROCESS | 2002 | 09:43:57 INFO - PROCESS | 2002 | [#7] imaging-desaturate Cycles:10 Average:102.20 Median:91.50 stddev:24.35 (26.6%) stddev-sans-first:25.55 09:43:57 INFO - PROCESS | 2002 | Values: 92.0 85.0 153.0 143.0 91.0 90.0 93.0 92.0 92.0 91.0 09:43:57 INFO - PROCESS | 2002 | 09:43:57 INFO - PROCESS | 2002 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.00 stddev:5.38 (9.3%) stddev-sans-first:5.67 09:43:57 INFO - PROCESS | 2002 | Values: 56.0 58.0 58.0 58.0 56.0 58.0 58.0 71.0 51.0 52.0 09:43:57 INFO - PROCESS | 2002 | 09:43:57 INFO - PROCESS | 2002 | [#9] json-stringify-tinderbox Cycles:10 Average:84.60 Median:77.50 stddev:16.71 (21.6%) stddev-sans-first:16.61 09:43:57 INFO - PROCESS | 2002 | Values: 68.0 85.0 85.0 92.0 105.0 110.0 68.0 99.0 64.0 70.0 09:43:57 INFO - PROCESS | 2002 | 09:43:57 INFO - PROCESS | 2002 | [#10] stanford-crypto-aes Cycles:10 Average:92.50 Median:85.50 stddev:11.88 (13.9%) stddev-sans-first:12.29 09:43:57 INFO - PROCESS | 2002 | Values: 85.0 97.0 86.0 78.0 100.0 107.0 110.0 88.0 99.0 75.0 09:43:57 INFO - PROCESS | 2002 | 09:43:57 INFO - PROCESS | 2002 | [#11] stanford-crypto-ccm Cycles:10 Average:147.80 Median:150.50 stddev:13.41 (8.9%) stddev-sans-first:14.00 09:43:57 INFO - PROCESS | 2002 | Values: 141.0 138.0 154.0 147.0 166.0 139.0 126.0 154.0 170.0 143.0 09:43:57 INFO - PROCESS | 2002 | 09:43:57 INFO - PROCESS | 2002 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.00 Median:181.50 stddev:24.86 (13.7%) stddev-sans-first:23.12 09:43:57 INFO - PROCESS | 2002 | Values: 219.0 231.0 184.0 170.0 172.0 171.0 204.0 155.0 165.0 179.0 09:43:57 INFO - PROCESS | 2002 | 09:43:57 INFO - PROCESS | 2002 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.30 Median:85.00 stddev:8.88 (10.5%) stddev-sans-first:9.26 09:43:57 INFO - PROCESS | 2002 | Values: 85.0 89.0 85.0 89.0 84.0 77.0 69.0 72.0 88.0 65.0 09:43:57 INFO - PROCESS | 2002 | -------- Summary: end -------- 09:43:57 INFO - PROCESS | 2002 | 09:43:58 INFO - TEST-INFO | 2002: exit 0 09:43:58 INFO - TEST-OK | kraken | took 61243ms 09:43:58 INFO - SUITE-END | took 1174s 09:43:58 INFO - Completed test suite (00:19:35) 09:43:58 INFO - javascript benchmark 09:43:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7220.0294895640245, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3056.2817737831606, 3381.6280209177003, 3403.45544712846, 3404.948925766113, 3415.658434156584, 5668.659880407178, 5741.511971482424, 5838.883222335561, 5839.7372118254625, 5848.391317810873, 5720.456556627114, 5759.452851979066, 5776.711164441782, 5795.391483894183, 5896.292444906617, 5154.948450515484, 5298.1522956327, 5300.549453296474, 5346.973265133688, 5353.0, 5147.408048074463, 5208.2968799212, 5287.101192797234, 5291.31212942317, 5406.83779486616, 5227.059129356714, 5295.7881684732565, 5304.389995150568, 5326.067938110835, 5371.57027437804, 5285.101532739443, 5295.947040529584, 5296.867578310535, 5325.973370133163, 5390.811321603725, 5136.717480538568, 5202.895942081137, 5267.973660131714, 5319.095753721838, 5334.5732341412595, 5580.972095139539, 5724.284464441945, 5740.138979153118, 5754.741036653319, 5761.971190144022, 4937.851864444073, 5121.770775014007, 6016.42843929826, 6271.717772700239, 6307.9684601577155, 5286.5506431952945, 6181.505479561624, 6243.906341404882, 6265.342139075377, 6266.279377871558, 5952.196453478811, 5964.194833697396, 5968.403159683997, 5977.0, 6029.427204415573, 5348.812791552277, 6329.050642403677, 6350.841228969312, 6353.110564520971, 6371.936280637135, 6053.51571874249, 6125.662799505599, 6169.96915015431, 6172.9074063889075, 6266.185395898504, 6254.343293954069, 6259.624422534663, 6272.937270627326, 6279.529035322369, 6280.120783090371, 6226.59527130735, 6257.655828929453, 6282.717277722513, 6296.464800491918, 6313.40022697843, 6189.721462534107, 6218.844528886814, 6229.906551401733, 6245.156903818017, 6283.874322513524, 4986.276989836453, 5021.623378246646, 5039.244113382949, 5051.419086805065, 5065.417476990193, 4172.5410204877435, 4518.570735780096, 4552.9772351138035, 4559.088182363541, 4559.293309536961, 5704.058830293038, 5949.286085669747, 5961.2846458425265, 5994.940050599525, 6044.395560443921, 6250.093736408196, 6250.624962502174, 6261.624302541862, 6263.060540918898, 6278.968605156945, 5981.790637327673, 6006.339302676702, 6006.789762358297, 6007.879842403127, 6058.091286307089, 5394.056040192951, 5457.45425457459, 5482.91775623358, 5516.089845175501, 5528.55771538276, 6236.906446403307, 6266.624002559861, 6301.338359472281, 6314.400131987454, 6395.456386207225, 6178.073289006685, 6251.9062214067735, 6255.78104766331, 6264.655443950626, 6322.146510221245, 6178.443940045418, 6359.618422894641, 6370.458511026614, 6373.235211774617, 6388.1376014237485, 6166.260048794174, 6198.297566239161, 6227.128202051807, 6257.09272155544, 6271.96864015677, 6227.128202051807, 6237.688115594293, 6257.2491301044165, 6260.843478913063, 6274.843128921813, 5630.155476678531, 6033.54748393881, 6101.511879049576, 6143.082036032849, 6202.069689546423, 6123.892747182578, 6133.548895741652, 6143.450468055886, 6180.7527698891545, 6203.596766210362, 5082.263071854634, 6044.879102418015, 6056.9697151513965, 6082.787102451393, 6085.4523092921845, 6051.1830902829315, 6221.688915554114, 6225.62646241227, 6231.53263505248, 6240.188775459162, 5985.012472941916, 6016.759329626941, 6018.097285407224, 6036.215292012011, 6095.2685677718955], "value": 5739.3031594518125, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.9811654002165, 497.5149229501236, 530.8407477756672, 533.8985592737379, 535.8211933745761, 38884.22231555367, 39749.60876369328, 39978.40032399509, 39995.40006899892, 40048.0, 40515.54329023805, 41048.0, 41135.58864411355, 41138.79430602843, 41144.76565703034, 9627.181689556395, 9871.062249086326, 9872.210223182128, 9886.505674716236, 9892.703218903409, 8735.475871447734, 8952.820943581124, 9513.43028400313, 9776.217902567812, 9937.304388692759, 9206.815863682723, 9293.44239345638, 9876.96291889352, 9965.651202207924, 10069.295149339549, 9834.655787047455, 9861.506924653739, 9879.851802222973, 9894.90105098947, 9927.652532161339, 9733.756656083584, 9752.853707194397, 9840.11438970489, 9860.06329398706, 9878.802423951553, 38401.0, 38419.039524011845, 38529.61470385288, 38732.41901371482, 38848.41727374092, 3305.9173520661934, 3438.329525742481, 3450.3789317922765, 3591.407417776064, 3942.4874766280486, 30026.0, 30506.0, 31090.844545777127, 31167.844160779277, 31221.37557248865, 3218.09893229896, 3246.8376581171083, 3255.869765209389, 3282.2286762610765, 3342.9832850835833, 372787.99999999726, 428240.0, 430865.8456707728, 431237.0, 433728.0, 32627.673723262462, 33558.49662255068, 57257.0, 57647.0, 57708.0, 33149.3370132596, 33194.66805331964, 33208.66791332104, 33427.83002594898, 33608.83195584006, 14312.0, 14390.208538530482, 14430.927845360917, 14435.133891966516, 14448.2662080551, 12260.386980650932, 12326.81509777354, 12330.383480826102, 12348.506059757688, 12380.504779808707, 7462.02993610838, 7550.056242969629, 7567.697292108364, 7616.961915190389, 7643.694252229849, 3163.636181839118, 3231.9838400807844, 3233.3856567252146, 3247.366763481146, 3257.6253730820786, 876.5923845411914, 883.337496877342, 900.5587262241454, 1028.5165971993151, 1133.886611338876, 28030.85984570105, 29022.709772902424, 29154.0, 29286.707132928823, 29679.703202968125, 1018.332991890313, 1067.765091679829, 1106.2919731371928, 1115.9442027898572, 1121.9551217951355, 14745.705085898437, 15327.398061455771, 15389.153596552072, 15452.5364239073, 15606.84393156054, 579763.0, 582026.0, 582208.0, 583656.0, 584883.0, 52842.67893302621, 53667.463325367025, 53981.730091349295, 54057.72971135119, 54067.45932540703, 1217.4643157010887, 1343.8051482534977, 1358.280111540885, 1381.530279704885, 1381.9032667713366, 26739.732602673725, 28540.001099961402, 28725.71274287314, 28735.28161795888, 29501.85249073741, 46479.0, 46609.53390466052, 46698.0, 46939.53060469488, 46949.0, 501144.0, 506009.0, 507108.0, 507110.0, 507651.0, 25109.372265693502, 25250.873745631154, 25356.366090847878, 25562.0, 26236.475270494866, 44289.77855110704, 44370.0, 44972.325415118146, 45031.0, 46379.07241855212, 34813.9555813326, 37552.62447375491, 37641.81179094087, 38422.615773841906, 39199.0, 34519.61921523111, 37511.0, 37844.810775945945, 38255.97330632258, 38858.80570597242, 32089.67910320867, 37210.25579488341, 37258.254834903695, 37651.05872353104, 37896.67361642329, 32677.673223267462, 32841.67158328386, 33638.49542256917, 33953.83023084869, 34319.0, 21670.34988950334, 24759.62860557057, 24972.37569060788, 24975.375615609755, 25441.872790635927], "value": 18081.77751000199, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.2930849551253, 334.89985397967666, 359.2581319575077, 377.91496913194516, 383.82919600777666, 17024.0, 20015.19939202432, 20569.588608227827, 21067.0519826608, 21363.893180534076, 18066.72899906499, 20741.377758667226, 20920.0, 21424.46438839026, 21434.89282553585, 5904.55715821313, 6103.847403814896, 6188.0, 6228.346023667517, 6233.7818176363835, 6020.909686354708, 6141.969290153543, 6151.784687535937, 6159.73725386297, 6165.445109940105, 5701.372848986629, 5951.0, 6012.9398706013035, 6067.271927368722, 6104.9389506105035, 5530.087535556629, 6060.606060606046, 6087.634741915499, 6090.939090609081, 6108.083787431899, 4885.975570122162, 5747.626404283708, 5771.336296325934, 5785.132230165509, 5788.305403351625, 12810.29543375114, 13166.144200627024, 13279.668008299774, 13480.39338229782, 13498.595042148652, 2422.1643532981093, 2625.0, 2716.755492005729, 2794.2315863137596, 2794.776417886564, 8254.380921430917, 9808.215342772632, 9830.803383932353, 10045.899541004643, 10085.747856303578, 1826.4611939477752, 1828.5337239003968, 1847.214933653192, 1893.517153125944, 1944.3777991042873, 110893.0, 125746.0, 127752.0, 131621.3418932899, 133683.33158334243, 9732.854007189897, 11186.32882027081, 11314.434278286053, 11653.766924661459, 11676.299422034705, 14590.708185836436, 14601.488947886985, 14618.707625847635, 14649.267536623127, 14666.926665366818, 8393.0, 8658.090900455361, 8660.48037117775, 8765.824683506422, 8786.428882122642, 8665.566721663892, 8672.69645562415, 8701.17338852808, 8808.955955220183, 8840.939087309564, 4392.297232442857, 4460.643148548108, 4543.432070991126, 4585.358049873021, 4620.052889157714, 1901.6862217734197, 1915.7413749143966, 1917.8561607879465, 1934.5550523379702, 1948.5156425557245, 770.5684816502776, 810.5825499867454, 870.3472395703222, 936.8454205056089, 953.2040745977048, 20050.0, 21127.471813204793, 21492.24777132793, 21510.0, 21597.67603485949, 890.0743227043931, 909.6497848328441, 926.4765407544851, 951.8667386565886, 953.1374106433689, 10546.894531054591, 10643.0, 11230.494627741771, 11368.147388945863, 11491.77016459666, 476175.0, 549236.0, 578628.0, 603489.0, 605362.0, 126801.09798353032, 131681.0, 132292.0, 137824.6217537832, 144180.0, 845.4082142500274, 894.3381897395881, 992.0327680511443, 1007.6624330849247, 1025.6974192613197, 16178.433754818525, 19006.524836879187, 19447.902760486108, 19850.305239316556, 19906.0, 52674.0, 53012.73493632507, 54969.1754623689, 55009.0, 55572.72213638906, 74101.8487966334, 76593.61703191671, 78277.8258326137, 80338.0, 82770.0, 11989.22070065443, 12445.315507647167, 12486.687832804253, 12723.491060357483, 12759.681007974876, 13674.521391751241, 13727.0, 13911.930440347733, 13934.930325348309, 13953.651158721113, 9751.0, 10906.781864362509, 11358.488868000795, 11763.176577639482, 11996.940015299868, 10545.420001899969, 11694.649160525198, 11830.822537662114, 11843.940780296043, 12204.511819527119, 10598.788024239626, 11138.665840024812, 11694.824577631172, 12091.576794812492, 12246.0, 9903.752406189902, 12133.939330303645, 12247.816282755588, 12358.752824943631, 12645.241285522898, 11661.941690291495, 11984.40077996114, 12050.879491205327, 12112.636620901387, 12142.0], "value": 9731.989052630912, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1500.5423345879506, 1531.6247519357757, 1738.2091148527422, 1838.6690395728763, 1854.8145185481453, 7987.760367188979, 8425.36809739269, 8588.355873309496, 8956.910430895698, 8975.685850995216, 8682.348823838222, 8696.91303086969, 8811.295096392274, 8819.51492667903, 8837.0, 1929.9421017369466, 2318.8608683479047, 2326.8603883767028, 2327.278543651465, 2328.7541165476473, 2286.942826429336, 2307.238611258281, 2325.430269583954, 2325.616273314901, 2334.9066037358484, 2308.9422764430856, 2323.256557901472, 2341.4146463384154, 2345.7536958619357, 2347.4600841806396, 1982.5043739065234, 2000.7198992141111, 2281.4866655002656, 2297.597920363938, 2306.7001289832215, 1949.3567122849427, 2310.260716570698, 2313.363824948136, 2314.930552083423, 2326.1858349577683, 8803.691870784492, 8868.37921345506, 8869.911300886974, 8925.107489251088, 8938.703887936277, 5231.581473482151, 5394.083005889008, 5398.6220964532495, 5412.134058550652, 5412.4858138477175, 3429.4855771634207, 3448.3620530201993, 3512.102515424785, 3565.8248468434235, 3661.3958696814993, 1063.728749168957, 1073.5544748929185, 1081.3457857995877, 1086.1745073744012, 1102.9834552481718, 11232.775344493064, 11544.191906566544, 11545.191836571443, 11552.191346605741, 11577.363245021605, 4603.746793926366, 4605.078984203105, 4790.281457781291, 4797.160496913027, 4798.304245884327, 9904.15814655748, 9973.351732137533, 9985.900140998643, 9990.100890919852, 10028.949855250678, 5351.598630102758, 5375.9462405376225, 5384.9461505385225, 5385.219143224289, 5392.433794451605, 4402.0755641315045, 4654.325122857234, 4782.832600858953, 4922.9753851231235, 4932.1122198004705, 3902.785346805953, 3922.0, 4026.154507553388, 4054.5134583850127, 4055.5538890721996, 1273.6879464531248, 1277.8083287506763, 1280.609414128681, 1290.9096363254482, 1294.9741005179844, 819.4760138772566, 882.6910581296495, 885.7254251182154, 912.7353067610452, 938.0853667674099, 5563.582731295169, 5794.913076303858, 5961.791337303173, 5966.0841732768495, 6076.210092687922, 443.4124784660338, 447.57480393626184, 450.5111953530456, 1012.4077414712476, 1018.8777346718441, 3792.2036372362113, 3834.9616503835164, 3940.1134744682217, 3942.1918506706056, 3995.3019966514116, 9393.624255029723, 10597.986382587284, 10606.363618182779, 10726.517306721216, 10823.56705731762, 9936.80126397468, 10185.898141018642, 10484.790304193873, 10665.200109991782, 10679.83980240297, 6500.707468163944, 7976.322012628992, 8100.878486822702, 8204.712835050745, 8206.712765053315, 4952.331435256195, 5875.618084824473, 5911.349751527243, 5947.702614869153, 6022.156898034366, 9668.661596844358, 9713.514324283899, 9873.555689993824, 9930.801383972135, 10005.749856253651, 10142.898571014195, 10207.387556746618, 10211.438370889673, 10221.23340749432, 10225.386476811414, 6600.471962242913, 6867.896981545181, 7256.238094999949, 7427.740029098955, 7442.4418168636485, 8307.0, 8361.456505327134, 8430.030546487233, 8432.03031651368, 8454.704085356983, 7192.244814294424, 7391.40868730511, 7523.661435235537, 7634.351080158249, 7712.151663317143, 7165.534240274365, 7309.122905251404, 7317.707291708272, 7428.2571742825285, 7472.476926615085, 6943.79168624942, 6971.721131154697, 7012.789616311519, 7025.0516180317045, 7029.472789540702, 4272.376496931146, 4971.0, 4986.476419975996, 5022.949770502249, 5111.131107711623, 4479.70881892676, 4594.5864872161665, 4902.2156454967035, 4973.875653108701, 5080.46655101209], "value": 4508.026400038745, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [244.91795248591714, 262.6336260916022, 293.68868998861194, 311.6602902835908, 313.374817239607, 5468.152436372358, 5560.249366335549, 5591.524720398766, 5629.268195134627, 5750.769969201232, 4673.6494762892835, 5678.318601767784, 5698.951061182258, 5755.453231942969, 5761.193432919395, 4366.912661746763, 4368.584984426474, 4380.540043295456, 4392.560743925598, 4405.3391991201415, 3589.53336066311, 4000.1398999715198, 4081.877483691994, 4425.114977004596, 4440.844570440036, 4194.951262184454, 4221.197972385252, 4224.584764104029, 4262.957370426287, 4282.957170428287, 3582.946255806165, 4266.168097221043, 4266.935995960063, 4298.398224248592, 4307.427788857076, 3496.8776092836883, 3498.247876706495, 3548.0, 3631.1648320886343, 3634.872779452733, 4105.768269519132, 5252.3171987641745, 5484.232207490954, 5568.1301495460675, 5568.691357530977, 4368.49762277339, 4921.7785199666105, 4933.235348520985, 4949.950500494985, 4964.329815474901, 5175.739284250935, 5901.586888917777, 5996.220491336142, 6033.668148251844, 6043.8186854394435, 3901.551321597996, 3958.5843486434087, 3967.3850553164307, 4000.439938408625, 4013.7591744495426, 5500.944990550123, 6210.223722034746, 6229.162397092869, 6314.305426403138, 6394.840128996812, 3426.3489936911906, 3784.375578029594, 4027.375756757707, 4028.3756017817286, 4058.857939972087, 3280.114369120324, 3423.5891692997, 3591.5690117186105, 4074.3277359235394, 4138.461999940048, 4290.806913688892, 4793.976030119827, 4852.0, 4886.971906658697, 4911.45973942866, 5425.864353391197, 6098.878022439526, 6099.664518451527, 6132.044831084015, 6145.907811382833, 1188.7741329147434, 1225.994684358835, 1386.5147198480452, 1399.734050530396, 1403.9087459315112, 744.8901137305376, 761.9428542859197, 818.5129847740585, 829.4649950781712, 835.8787975743484, 4515.7967891444305, 4698.718076915327, 4750.596199323097, 4786.7845946932475, 4929.679570827885, 4327.653787696977, 4884.658073934862, 4960.0327936052845, 5119.283300337956, 5136.640435169502, 3991.042149884007, 4349.6294519486955, 4377.627901628397, 4543.977280113644, 4724.7635369771815, 2291.346966114649, 2426.866522341288, 2519.685039370079, 2710.79070557495, 2796.972030279712, 4507.977460112678, 4786.7845946932475, 4977.506747975665, 5288.646552284274, 5407.053460754126, 4955.950440495549, 5011.949880501221, 5058.684741967115, 5108.642395032386, 5393.757280922289, 4793.424789025269, 4855.708657480563, 4856.68431551948, 5201.0, 5240.030594339983, 4842.903141937212, 5012.674176178537, 5072.239164125411, 5136.587438454455, 5189.870253243699, 4130.772807495617, 4587.77061146948, 5072.641221831718, 5082.870745342778, 5144.897102057863, 4489.865304040884, 4890.951090489049, 4969.527894849984, 5201.947980520146, 5454.209139674805, 3017.6227971503563, 3331.766776325634, 3586.0, 3595.5865075515603, 3622.192800579572, 4331.848385306499, 4491.73049617024, 4745.786439610157, 4897.730624815526, 5207.921881171861, 5435.755391007493, 5879.470847623564, 5879.794207202898, 5942.662900847275, 5969.343372228965, 5018.598512118949, 5904.557158213237, 5906.793262235973, 5922.482944748551, 5986.07215881539, 5133.486651334986, 5517.503424691797, 5661.547076233974, 5696.0095949626775, 5782.363939966516, 4955.11705551888, 5137.717425541631, 5391.649542779707, 5566.693831839288, 5678.14827775837, 5508.56199711164, 5547.890421915714, 5773.393793651606, 5861.325947515919, 5887.4406931341455], "value": 4019.07740325241, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.6426722371591, 717.8743719849028, 725.5030304241599, 762.60725726251, 786.3434032582795, 15009.924950375247, 15790.763138552917, 15797.842021579781, 15798.289076991534, 15800.130992795392, 14146.0, 14241.857581424183, 14400.27998600071, 14463.20452375119, 15280.044316021133, 846.1327139681829, 854.6538651846013, 870.2428886868433, 870.4472659861002, 873.6461732998114, 831.9833603327929, 857.0786404615033, 857.1685465098844, 857.5797859049084, 860.165639329849, 697.2817997462622, 874.3398733955854, 902.7021083042613, 906.4425378392307, 906.8503696890006, 862.9611667474978, 894.3828758156851, 896.1307531694246, 898.4968417686117, 898.595631965618, 640.1198352265635, 647.3979199344608, 653.7417720000573, 662.8740539297567, 662.993370066298, 14997.550073497703, 15039.548813535612, 15072.397104115822, 15311.234438278041, 15412.229388530528, 13513.797293040514, 13591.592252232449, 13591.86408135916, 13613.863861361458, 13952.720945581133, 12810.23138611677, 13075.411606477732, 13153.473861045546, 13244.86755132446, 13260.73478530424, 3995.4006898965386, 4476.84331048415, 4514.157588745351, 4525.9547404525865, 4585.95414045862, 98297.0, 105131.3993003996, 120494.0, 125868.0, 127405.0, 8984.46093234408, 10118.139958103497, 10752.40861752611, 10786.622468213733, 11204.327740335606, 20572.79427205739, 20714.067866946025, 20909.05909234088, 20974.370768876957, 21015.0, 7736.149023607399, 7829.217078292239, 7905.723299684599, 7907.288344049063, 7995.7601271960775, 4331.242032644338, 4361.666508417981, 4381.452318460192, 4429.0, 4531.478879928851, 3104.3170502489866, 3470.809105499222, 3530.470429435605, 3550.1124718820297, 3592.4252119660728, 606.342118801097, 655.5804285257439, 662.867426514699, 663.4427081251772, 669.0866966590569, 512.7564406906764, 527.733494585232, 555.5971920357708, 625.680902739606, 641.7657554992394, 9022.413543119676, 9199.908000919904, 9281.90718092824, 9299.767505812273, 9391.248700103975, 589.9174115623816, 624.8687775567091, 628.9622622642656, 630.2972186012655, 633.9539759397031, 4321.67587430944, 4367.170237654836, 4427.358033085185, 4560.7122372128715, 4615.284630882219, 96907.51546242223, 97354.0, 98366.0, 134075.0, 137673.3116334432, 109573.0, 118986.40506797584, 120890.99999999824, 121859.17211241838, 124089.0, 104527.0, 105378.41932371174, 107123.0, 109750.0, 115414.42292788482, 8008.639611217625, 8854.778630534289, 8989.786378839035, 9166.587503562223, 9969.0, 64632.0, 64956.67521662361, 66378.66810665916, 66406.66796665985, 67177.66411167913, 92549.537252316, 94725.52637236769, 97614.0, 97779.0, 98395.0, 12997.0, 13006.544770933351, 13040.934795325962, 13059.477620895057, 13413.798793017917, 11831.585894493652, 14106.435742570182, 14494.202818844644, 14513.564593062225, 15255.847441525442, 13540.187588744708, 13592.592222233348, 13634.591352161959, 13716.451341946211, 14337.85662143407, 13567.118137321042, 13622.318884055956, 14007.509737159151, 14132.717345652823, 14323.355449005028, 13345.866541334462, 13415.463381464631, 13634.86365136336, 13749.175049497062, 13899.235542045284, 10968.23222374426, 11088.223824332219, 11197.272177308449, 11253.0, 11466.0, 9273.211776999031, 9439.81120377575, 10780.0, 11100.15215872085, 11523.078153747847], "value": 7740.610471464295, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1635.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 111.0, 117.0, 117.0, 119.0, 103.0, 118.0, 116.0, 125.0, 169.0], "value": 121.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 110.0, 173.0, 160.0, 110.0, 132.0, 135.0, 140.0, 175.0, 114.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [233.0, 261.0, 229.0, 265.0, 220.0, 199.0, 235.0, 283.0, 203.0, 191.0], "value": 231.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 88.0, 78.0, 142.0, 60.0, 57.0, 60.0, 75.0, 127.0, 60.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 117.0, 97.0, 71.0, 81.0, 120.0, 96.0, 102.0, 141.0], "value": 96.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 108.0, 88.0, 116.0, 129.0, 90.0, 87.0, 96.0, 119.0], "value": 101.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 102.0, 100.0, 99.0, 99.0, 100.0, 111.0, 100.0, 149.0, 169.0], "value": 112.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 85.0, 153.0, 143.0, 91.0, 90.0, 93.0, 92.0, 92.0, 91.0], "value": 102.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 58.0, 58.0, 56.0, 58.0, 58.0, 71.0, 51.0, 52.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 85.0, 85.0, 92.0, 105.0, 110.0, 68.0, 99.0, 64.0, 70.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 97.0, 86.0, 78.0, 100.0, 107.0, 110.0, 88.0, 99.0, 75.0], "value": 92.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 138.0, 154.0, 147.0, 166.0, 139.0, 126.0, 154.0, 170.0, 143.0], "value": 147.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [219.0, 231.0, 184.0, 170.0, 172.0, 171.0, 204.0, 155.0, 165.0, 179.0], "value": 185.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 89.0, 85.0, 89.0, 84.0, 77.0, 69.0, 72.0, 88.0, 65.0], "value": 80.3, "unit": "score"}]}]} 09:43:58 INFO - Return code: 0 09:43:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:43:58 ERROR - # TBPL SUCCESS # 09:43:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:43:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:43:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:43:58 INFO - 2016-08-27 09:43:58.931 screenresolution[2007:23457] starting screenresolution argv=screenresolution get 09:43:58 INFO - 2016-08-27 09:43:58.934 screenresolution[2007:23457] Display 0: 1600x1200x32@60 09:43:58 INFO - 2016-08-27 09:43:58.940 screenresolution[2008:23460] starting screenresolution argv=screenresolution list 09:43:58 INFO - Available Modes on Display 0 09:43:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:43:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:43:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:43:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:43:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:43:59 INFO - Intel Iris: 09:43:59 INFO - Chipset Model: Intel Iris 09:43:59 INFO - Type: GPU 09:43:59 INFO - Bus: Built-In 09:43:59 INFO - VRAM (Dynamic, Max): 1536 MB 09:43:59 INFO - Vendor: Intel (0x8086) 09:43:59 INFO - Device ID: 0x0a2e 09:43:59 INFO - Revision ID: 0x0009 09:43:59 INFO - Displays: 09:43:59 INFO - Display: 09:43:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:43:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:43:59 INFO - Display Serial Number: 1600x1200 60 09:43:59 INFO - Main Display: Yes 09:43:59 INFO - Mirror: Off 09:43:59 INFO - Online: Yes 09:43:59 INFO - Rotation: Supported 09:43:59 INFO - Return code: 0 09:43:59 INFO - Running post-action listener: _resource_record_post_action 09:43:59 INFO - [mozharness: 2016-08-27 16:43:59.174267Z] Finished run-tests step (success) 09:43:59 INFO - Running post-run listener: _resource_record_post_run 09:43:59 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 954368; Write bytes: 708667904; Read time: 7; Write time: 1962 09:43:59 INFO - TinderboxPrint: CPU usage
54.7% 09:43:59 INFO - TinderboxPrint: I/O read bytes / time
954,368 / 7 09:43:59 INFO - TinderboxPrint: I/O write bytes / time
708,667,904 / 1,962 09:43:59 INFO - TinderboxPrint: CPU idle
2,194.0 (45.3%) 09:43:59 INFO - TinderboxPrint: CPU system
979.8 (20.2%) 09:43:59 INFO - TinderboxPrint: CPU user
1,668.0 (34.5%) 09:43:59 INFO - TinderboxPrint: Swap in / out
406,781,952 / 0 09:43:59 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 390160896; Write bytes: 384325120; Read time: 29114; Write time: 754 09:43:59 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 954368; Write bytes: 299079168; Read time: 7; Write time: 1147 09:43:59 INFO - Running post-run listener: _upload_blobber_files 09:43:59 INFO - Blob upload gear active. 09:43:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:43:59 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:43:59 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:43:59 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:44:00 INFO - Traceback (most recent call last): 09:44:00 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 09:44:00 INFO - main() 09:44:00 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 09:44:00 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 09:44:00 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 09:44:00 INFO - return set(response.json().get('whitelist', [])) 09:44:00 INFO - File "/builds/slave/test/build/venv/lib/python2.7/site-packages/requests/models.py", line 651, in json 09:44:00 INFO - return json.loads(self.text or self.content, **kwargs) 09:44:00 INFO - File "/tools/python27/lib/python2.7/json/__init__.py", line 326, in loads 09:44:00 INFO - return _default_decoder.decode(s) 09:44:00 INFO - File "/tools/python27/lib/python2.7/json/decoder.py", line 366, in decode 09:44:00 INFO - obj, end = self.raw_decode(s, idx=_w(s, 0).end()) 09:44:00 INFO - File "/tools/python27/lib/python2.7/json/decoder.py", line 384, in raw_decode 09:44:00 INFO - raise ValueError("No JSON object could be decoded") 09:44:00 INFO - ValueError: No JSON object could be decoded 09:44:00 ERROR - Return code: 1 09:44:00 INFO - Setting buildbot property blobber_files to {} 09:44:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:44:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:44:00 INFO - Contents: 09:44:00 INFO - blobber_files:{} 09:44:00 INFO - Running post-run listener: copy_logs_to_upload_dir 09:44:00 INFO - Copying logs to upload dir... 09:44:00 INFO - mkdir: /builds/slave/test/build/upload/logs 09:44:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.707008 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-08-27 09:44:00.135656) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-27 09:44:00.139117) ========= 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.egkkwt36VD/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.p8claiKdtt/Listeners TMPDIR=/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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:{} build_url:https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011376 build_url: 'https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-27 09:44:00.177732) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 09:44:00.178104) ========= 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.egkkwt36VD/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.p8claiKdtt/Listeners TMPDIR=/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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.004892 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 09:44:00.226920) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-27 09:44:00.227277) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-27 09:44:00.227719) ========= ========= Total master_lag: 1.86 =========