builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0101 starttime: 1472473549.87 results: success (0) buildid: 20160829030202 builduid: 73fccc28b65e4b278d9f8704a306e21f revision: 1a5b53a831e5a6c20de1b081c774feb3ff76756c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 05:25:49.867387) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 05:25:49.867801) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 05:25:49.868082) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 05:25:50.456714) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-08-29 05:25:50.457017) ========= 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.rRmArETzdm/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.Zo0hpWi88s/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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-29 05:25: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% 82.1M=0s 2016-08-29 05:25:50 (82.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083594 ========= master_lag: 4.51 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-08-29 05:25:55.054417) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-08-29 05:25:55.054752) ========= 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.rRmArETzdm/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.Zo0hpWi88s/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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.034244 ========= master_lag: 1.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-08-29 05:25:56.187184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-29 05:25:56.187560) ========= 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.rRmArETzdm/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.Zo0hpWi88s/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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-29 05:25:56,277 truncating revision to first 12 chars 2016-08-29 05:25:56,277 Setting DEBUG logging. 2016-08-29 05:25:56,277 attempt 1/10 2016-08-29 05:25:56,277 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-29 05:25:57,298 unpacking tar archive at: mozilla-central-1a5b53a831e5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.274858 ========= master_lag: 1.57 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-29 05:25:59.030488) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 05:25:59.030811) ========= script_repo_revision: 1a5b53a831e5a6c20de1b081c774feb3ff76756c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 05:25:59.031218) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 05:25:59.031505) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 05:25:59.113246) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-08-29 05:25:59.113709) ========= /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.rRmArETzdm/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.Zo0hpWi88s/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 05:25:59 INFO - MultiFileLogger online at 20160829 05:25:59 in /builds/slave/test 05:25:59 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 05:25:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:25:59 INFO - {'append_to_log': False, 05:25:59 INFO - 'base_work_dir': '/builds/slave/test', 05:25:59 INFO - 'blob_upload_branch': 'Firefox', 05:25:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:25:59 INFO - 'branch': 'Firefox', 05:25:59 INFO - 'buildbot_json_path': 'buildprops.json', 05:25:59 INFO - 'config_files': ('talos/mac_config.py',), 05:25:59 INFO - 'default_actions': ('clobber', 05:25:59 INFO - 'read-buildbot-config', 05:25:59 INFO - 'download-and-extract', 05:25:59 INFO - 'populate-webroot', 05:25:59 INFO - 'create-virtualenv', 05:25:59 INFO - 'install', 05:25:59 INFO - 'run-tests'), 05:25:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:25:59 INFO - 'download_minidump_stackwalk': True, 05:25:59 INFO - 'download_symbols': 'ondemand', 05:25:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:25:59 INFO - 'tooltool.py': '/tools/tooltool.py', 05:25:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:25:59 INFO - '/tools/misc-python/virtualenv.py')}, 05:25:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:25:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:25:59 INFO - 'installer_path': 'installer.exe', 05:25:59 INFO - 'log_level': 'info', 05:25:59 INFO - 'log_name': 'talos', 05:25:59 INFO - 'log_to_console': True, 05:25:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:25:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:25:59 INFO - 'opt_config_files': (), 05:25:59 INFO - 'pip_index': False, 05:25:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:25:59 INFO - 'cmd': ('bash', 05:25:59 INFO - '-c', 05:25:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:25:59 INFO - 'enabled': True, 05:25:59 INFO - 'halt_on_failure': False, 05:25:59 INFO - 'name': 'check_screen_resolution'},), 05:25:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:25:59 INFO - 'cmd': ('bash', 05:25:59 INFO - '-c', 05:25:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:25:59 INFO - 'enabled': True, 05:25:59 INFO - 'halt_on_failure': False, 05:25:59 INFO - 'name': 'check_screen_resolution'},), 05:25:59 INFO - 'run_cmd_checks_enabled': True, 05:25:59 INFO - 'sps_profile': False, 05:25:59 INFO - 'sps_profile_interval': 0, 05:25:59 INFO - 'suite': 'dromaeojs-e10s', 05:25:59 INFO - 'system_bits': '32', 05:25:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:25:59 INFO - 'title': 't-yosemite-r7-0101', 05:25:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:25:59 INFO - 'use_talos_json': True, 05:25:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:25:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:25:59 INFO - 'work_dir': 'build'} 05:25:59 INFO - [mozharness: 2016-08-29 12:25:59.316215Z] Running clobber step. 05:25:59 INFO - Running pre-action listener: _resource_record_pre_action 05:25:59 INFO - Running main action method: clobber 05:25:59 INFO - rmtree: /builds/slave/test/build 05:25:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:26:01 INFO - Running post-action listener: _resource_record_post_action 05:26:01 INFO - [mozharness: 2016-08-29 12:26:01.451769Z] Finished clobber step (success) 05:26:01 INFO - [mozharness: 2016-08-29 12:26:01.451883Z] Running read-buildbot-config step. 05:26:01 INFO - Running pre-action listener: _resource_record_pre_action 05:26:01 INFO - Running main action method: read_buildbot_config 05:26:01 INFO - Using buildbot properties: 05:26:01 INFO - { 05:26:01 INFO - "project": "", 05:26:01 INFO - "product": "firefox", 05:26:01 INFO - "script_repo_revision": "production", 05:26:01 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:26:01 INFO - "repository": "", 05:26:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:26:01 INFO - "buildid": "20160829030202", 05:26:01 INFO - "stage_platform": "macosx64", 05:26:01 INFO - "basedir": "/builds/slave/test", 05:26:01 INFO - "nightly_build": "True", 05:26:01 INFO - "buildnumber": 19, 05:26:01 INFO - "slavename": "t-yosemite-r7-0101", 05:26:01 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 05:26:01 INFO - "platform": "yosemite_r7", 05:26:01 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:26:01 INFO - "branch": "mozilla-central", 05:26:01 INFO - "repo_path": "mozilla-central", 05:26:01 INFO - "revision": "1a5b53a831e5a6c20de1b081c774feb3ff76756c", 05:26:01 INFO - "pgo_build": "False", 05:26:01 INFO - "builduid": "73fccc28b65e4b278d9f8704a306e21f", 05:26:01 INFO - "slavebuilddir": "test" 05:26:01 INFO - } 05:26:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/LTsN5JAOSeC6a7s-TA096w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 05:26:01 INFO - Running post-action listener: _resource_record_post_action 05:26:01 INFO - [mozharness: 2016-08-29 12:26:01.455269Z] Finished read-buildbot-config step (success) 05:26:01 INFO - [mozharness: 2016-08-29 12:26:01.455392Z] Running download-and-extract step. 05:26:01 INFO - Running pre-action listener: _resource_record_pre_action 05:26:01 INFO - Running main action method: download_and_extract 05:26:01 INFO - mkdir: /builds/slave/test/build/tests 05:26:01 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')]} 05:26:01 INFO - trying https://queue.taskcluster.net/v1/task/LTsN5JAOSeC6a7s-TA096w/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 05:26:01 INFO - Downloading https://queue.taskcluster.net/v1/task/LTsN5JAOSeC6a7s-TA096w/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 05:26:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LTsN5JAOSeC6a7s-TA096w/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 05:26:02 INFO - Downloaded 1199 bytes. 05:26:02 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:26:02 INFO - Using the following test package requirements: 05:26:02 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:26:02 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:26:02 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 05:26:02 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:26:02 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 05:26:02 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:26:02 INFO - u'jsshell-mac.zip'], 05:26:02 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:26:02 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 05:26:02 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:26:02 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:26:02 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 05:26:02 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:26:02 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 05:26:02 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:26:02 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 05:26:02 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:26:02 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 05:26:02 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:02 INFO - trying https://queue.taskcluster.net/v1/task/LTsN5JAOSeC6a7s-TA096w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:26:02 INFO - Downloading https://queue.taskcluster.net/v1/task/LTsN5JAOSeC6a7s-TA096w/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 05:26:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LTsN5JAOSeC6a7s-TA096w/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 05:26:03 INFO - Downloaded 16369481 bytes. 05:26:03 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 05:26:10 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 05:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:10 INFO - trying https://queue.taskcluster.net/v1/task/LTsN5JAOSeC6a7s-TA096w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:26:10 INFO - Downloading https://queue.taskcluster.net/v1/task/LTsN5JAOSeC6a7s-TA096w/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 05:26:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LTsN5JAOSeC6a7s-TA096w/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 05:26:11 INFO - Downloaded 16369481 bytes. 05:26:11 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 05:26:18 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')]} 05:26:18 INFO - trying https://queue.taskcluster.net/v1/task/LTsN5JAOSeC6a7s-TA096w/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:26:18 INFO - Downloading https://queue.taskcluster.net/v1/task/LTsN5JAOSeC6a7s-TA096w/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 05:26:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LTsN5JAOSeC6a7s-TA096w/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 05:26:19 INFO - Downloaded 14413998 bytes. 05:26:19 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 05:26:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:19 INFO - trying https://queue.taskcluster.net/v1/task/LTsN5JAOSeC6a7s-TA096w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:26:19 INFO - Downloading https://queue.taskcluster.net/v1/task/LTsN5JAOSeC6a7s-TA096w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 05:26:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LTsN5JAOSeC6a7s-TA096w/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 05:26:22 INFO - Downloaded 111682656 bytes. 05:26:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LTsN5JAOSeC6a7s-TA096w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:26:22 INFO - mkdir: /builds/slave/test/properties 05:26:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:26:22 INFO - Writing to file /builds/slave/test/properties/build_url 05:26:22 INFO - Contents: 05:26:22 INFO - build_url:https://queue.taskcluster.net/v1/task/LTsN5JAOSeC6a7s-TA096w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:26:23 INFO - Running post-action listener: _resource_record_post_action 05:26:23 INFO - Running post-action listener: set_extra_try_arguments 05:26:23 INFO - [mozharness: 2016-08-29 12:26:23.360572Z] Finished download-and-extract step (success) 05:26:23 INFO - [mozharness: 2016-08-29 12:26:23.360741Z] Running populate-webroot step. 05:26:23 INFO - Running pre-action listener: _resource_record_pre_action 05:26:23 INFO - Running main action method: populate_webroot 05:26:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:26:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:26:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:26:23 INFO - '--tppagecycles', 05:26:23 INFO - '7'], 05:26:23 INFO - 'tests': ['tsvgm']}}, 05:26:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:26:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:26:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:26:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:26:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:26:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:26:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:23 INFO - 'talos_options': ['--disable-e10s'], 05:26:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:26:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:26:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:23 INFO - 'talos_options': ['--disable-e10s'], 05:26:23 INFO - 'tests': ['damp', 'tps']}, 05:26:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:23 INFO - 'tests': ['damp', 'tps']}, 05:26:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:26:23 INFO - 'tests': ['dromaeo_dom']}, 05:26:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:26:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:26:23 INFO - 'tests': ['basic_compositor_video']}, 05:26:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:26:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:26:23 INFO - 'tests': ['a11yr', 05:26:23 INFO - 'ts_paint', 05:26:23 INFO - 'tpaint', 05:26:23 INFO - 'sessionrestore', 05:26:23 INFO - 'sessionrestore_no_auto_restore', 05:26:23 INFO - 'tabpaint']}, 05:26:23 INFO - 'other-e10s': {'tests': ['a11yr', 05:26:23 INFO - 'ts_paint', 05:26:23 INFO - 'tpaint', 05:26:23 INFO - 'sessionrestore', 05:26:23 INFO - 'sessionrestore_no_auto_restore', 05:26:23 INFO - 'tabpaint']}, 05:26:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:26:23 INFO - 'ts_paint', 05:26:23 INFO - 'tpaint', 05:26:23 INFO - 'sessionrestore', 05:26:23 INFO - 'sessionrestore_no_auto_restore', 05:26:23 INFO - 'tabpaint']}, 05:26:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:26:23 INFO - 'ts_paint', 05:26:23 INFO - 'tpaint', 05:26:23 INFO - 'sessionrestore', 05:26:23 INFO - 'sessionrestore_no_auto_restore', 05:26:23 INFO - 'tabpaint']}, 05:26:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:26:23 INFO - 'tests': ['a11yr', 05:26:23 INFO - 'ts_paint', 05:26:23 INFO - 'tpaint', 05:26:23 INFO - 'sessionrestore', 05:26:23 INFO - 'sessionrestore_no_auto_restore', 05:26:23 INFO - 'tabpaint']}, 05:26:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:26:23 INFO - 'tests': ['a11yr', 05:26:23 INFO - 'ts_paint', 05:26:23 INFO - 'tpaint', 05:26:23 INFO - 'sessionrestore', 05:26:23 INFO - 'sessionrestore_no_auto_restore', 05:26:23 INFO - 'tabpaint']}, 05:26:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:26:23 INFO - 'tests': ['tsvgx', 05:26:23 INFO - 'tsvgr_opacity', 05:26:23 INFO - 'tart', 05:26:23 INFO - 'tscrollx', 05:26:23 INFO - 'cart']}, 05:26:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:26:23 INFO - 'tsvgr_opacity', 05:26:23 INFO - 'tart', 05:26:23 INFO - 'tscrollx', 05:26:23 INFO - 'cart']}, 05:26:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:23 INFO - 'talos_options': ['--disable-e10s'], 05:26:23 INFO - 'tests': ['tp5o']}, 05:26:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:23 INFO - 'tests': ['tp5o']}, 05:26:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:23 INFO - 'talos_options': ['--disable-e10s', 05:26:23 INFO - '--xperf_path', 05:26:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:26:23 INFO - 'tests': ['tp5n']}, 05:26:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:23 INFO - 'talos_options': ['--xperf_path', 05:26:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:26:23 INFO - 'tests': ['tp5n']}}, 05:26:23 INFO - 'talos.zip': {'path': '', 05:26:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:26:23 INFO - Running post-action listener: _resource_record_post_action 05:26:23 INFO - [mozharness: 2016-08-29 12:26:23.379660Z] Finished populate-webroot step (success) 05:26:23 INFO - [mozharness: 2016-08-29 12:26:23.379789Z] Running create-virtualenv step. 05:26:23 INFO - Running pre-action listener: _resource_record_pre_action 05:26:23 INFO - Running main action method: create_virtualenv 05:26:23 INFO - Creating virtualenv /builds/slave/test/build/venv 05:26:23 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 05:26:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:26:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:26:23 INFO - Using real prefix '/tools/python27' 05:26:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:26:24 INFO - Installing distribute.............................................................................................................................................................................................done. 05:26:27 INFO - Installing pip.................done. 05:26:27 INFO - Return code: 0 05:26:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:26:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106163a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061f8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa23048a720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060c7d30>, '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 0x105e2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060bfb20>, '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.rRmArETzdm/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.Zo0hpWi88s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 05:26:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:26:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:26:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rRmArETzdm/Render', 05:26:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:27 INFO - 'HOME': '/Users/cltbld', 05:26:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:27 INFO - 'LOGNAME': 'cltbld', 05:26:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:27 INFO - 'MOZ_NO_REMOTE': '1', 05:26:27 INFO - 'NO_EM_RESTART': '1', 05:26:27 INFO - 'PAGER': '/bin/cat', 05:26:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:27 INFO - 'PWD': '/builds/slave/test', 05:26:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:27 INFO - 'SHELL': '/bin/bash', 05:26:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zo0hpWi88s/Listeners', 05:26:27 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 05:26:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:27 INFO - 'USER': 'cltbld', 05:26:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:27 INFO - 'XPC_FLAGS': '0x0', 05:26:27 INFO - 'XPC_SERVICE_NAME': '0', 05:26:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:27 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 05:26:27 INFO - Cleaning up... 05:26:27 INFO - Return code: 0 05:26:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:26:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106163a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061f8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa23048a720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060c7d30>, '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 0x105e2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060bfb20>, '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.rRmArETzdm/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.Zo0hpWi88s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 05:26:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:26:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:26:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rRmArETzdm/Render', 05:26:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:27 INFO - 'HOME': '/Users/cltbld', 05:26:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:27 INFO - 'LOGNAME': 'cltbld', 05:26:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:27 INFO - 'MOZ_NO_REMOTE': '1', 05:26:27 INFO - 'NO_EM_RESTART': '1', 05:26:27 INFO - 'PAGER': '/bin/cat', 05:26:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:27 INFO - 'PWD': '/builds/slave/test', 05:26:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:27 INFO - 'SHELL': '/bin/bash', 05:26:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zo0hpWi88s/Listeners', 05:26:27 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 05:26:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:27 INFO - 'USER': 'cltbld', 05:26:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:27 INFO - 'XPC_FLAGS': '0x0', 05:26:27 INFO - 'XPC_SERVICE_NAME': '0', 05:26:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:27 INFO - Downloading/unpacking psutil>=3.1.1 05:26:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:26:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:26:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:26:30 INFO - Installing collected packages: psutil 05:26:30 INFO - Running setup.py install for psutil 05:26:30 INFO - building 'psutil._psutil_osx' extension 05:26:30 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 05:26:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:26:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:26:31 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:26:31 INFO - building 'psutil._psutil_posix' extension 05:26:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:26:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:26:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:26:31 INFO - ^ 05:26:31 INFO - 1 warning generated. 05:26:31 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 05:26:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:26:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:26:31 INFO - Successfully installed psutil 05:26:31 INFO - Cleaning up... 05:26:31 INFO - Return code: 0 05:26:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106163a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061f8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa23048a720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060c7d30>, '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 0x105e2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060bfb20>, '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.rRmArETzdm/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.Zo0hpWi88s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 05:26:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:26:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:26:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rRmArETzdm/Render', 05:26:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:31 INFO - 'HOME': '/Users/cltbld', 05:26:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:31 INFO - 'LOGNAME': 'cltbld', 05:26:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:31 INFO - 'MOZ_NO_REMOTE': '1', 05:26:31 INFO - 'NO_EM_RESTART': '1', 05:26:31 INFO - 'PAGER': '/bin/cat', 05:26:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:31 INFO - 'PWD': '/builds/slave/test', 05:26:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:31 INFO - 'SHELL': '/bin/bash', 05:26:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zo0hpWi88s/Listeners', 05:26:31 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 05:26:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:31 INFO - 'USER': 'cltbld', 05:26:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:31 INFO - 'XPC_FLAGS': '0x0', 05:26:31 INFO - 'XPC_SERVICE_NAME': '0', 05:26:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:26: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 05:26: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 05:26: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 05:26: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 05:26: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 05:26: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 05:26:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:26:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:26:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:26:34 INFO - Installing collected packages: mozsystemmonitor 05:26:34 INFO - Running setup.py install for mozsystemmonitor 05:26:34 INFO - Successfully installed mozsystemmonitor 05:26:34 INFO - Cleaning up... 05:26:34 INFO - Return code: 0 05:26:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:26:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:34 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 0x106163a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061f8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa23048a720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060c7d30>, '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 0x105e2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060bfb20>, '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.rRmArETzdm/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.Zo0hpWi88s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 05:26:34 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 05:26:34 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 05:26:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rRmArETzdm/Render', 05:26:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:34 INFO - 'HOME': '/Users/cltbld', 05:26:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:34 INFO - 'LOGNAME': 'cltbld', 05:26:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:34 INFO - 'MOZ_NO_REMOTE': '1', 05:26:34 INFO - 'NO_EM_RESTART': '1', 05:26:34 INFO - 'PAGER': '/bin/cat', 05:26:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:34 INFO - 'PWD': '/builds/slave/test', 05:26:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:34 INFO - 'SHELL': '/bin/bash', 05:26:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zo0hpWi88s/Listeners', 05:26:34 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 05:26:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:34 INFO - 'USER': 'cltbld', 05:26:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:34 INFO - 'XPC_FLAGS': '0x0', 05:26:34 INFO - 'XPC_SERVICE_NAME': '0', 05:26:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:35 INFO - Downloading/unpacking jsonschema==2.5.1 05:26: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 05:26: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 05:26: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 05:26: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 05:26: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 05:26: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 05:26:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:26:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:26:37 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 05:26:37 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 05:26:37 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 05:26:37 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 05:26:37 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 05:26:37 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 05:26:38 INFO - Downloading functools32-3.2.3-2.tar.gz 05:26:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:26:38 INFO - warning: no files found matching '*.txt' 05:26:38 INFO - no previously-included directories found matching 'build' 05:26:38 INFO - no previously-included directories found matching 'dist' 05:26:38 INFO - no previously-included directories found matching '.git*' 05:26:38 INFO - Installing collected packages: jsonschema, functools32 05:26:38 INFO - Running setup.py install for functools32 05:26:38 INFO - warning: no files found matching '*.txt' 05:26:38 INFO - no previously-included directories found matching 'build' 05:26:38 INFO - no previously-included directories found matching 'dist' 05:26:38 INFO - no previously-included directories found matching '.git*' 05:26:38 INFO - Successfully installed jsonschema functools32 05:26:38 INFO - Cleaning up... 05:26:38 INFO - Return code: 0 05:26:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106163a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061f8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa23048a720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060c7d30>, '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 0x105e2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060bfb20>, '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.rRmArETzdm/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.Zo0hpWi88s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 05:26:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:26:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:26:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rRmArETzdm/Render', 05:26:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:38 INFO - 'HOME': '/Users/cltbld', 05:26:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:38 INFO - 'LOGNAME': 'cltbld', 05:26:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:38 INFO - 'MOZ_NO_REMOTE': '1', 05:26:38 INFO - 'NO_EM_RESTART': '1', 05:26:38 INFO - 'PAGER': '/bin/cat', 05:26:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:38 INFO - 'PWD': '/builds/slave/test', 05:26:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:38 INFO - 'SHELL': '/bin/bash', 05:26:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zo0hpWi88s/Listeners', 05:26:38 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 05:26:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:38 INFO - 'USER': 'cltbld', 05:26:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:38 INFO - 'XPC_FLAGS': '0x0', 05:26:38 INFO - 'XPC_SERVICE_NAME': '0', 05:26:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:26:38 INFO - Cleaning up... 05:26:38 INFO - Return code: 0 05:26:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106163a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061f8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa23048a720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060c7d30>, '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 0x105e2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060bfb20>, '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.rRmArETzdm/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.Zo0hpWi88s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 05:26:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:26:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:26:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rRmArETzdm/Render', 05:26:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:38 INFO - 'HOME': '/Users/cltbld', 05:26:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:38 INFO - 'LOGNAME': 'cltbld', 05:26:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:38 INFO - 'MOZ_NO_REMOTE': '1', 05:26:38 INFO - 'NO_EM_RESTART': '1', 05:26:38 INFO - 'PAGER': '/bin/cat', 05:26:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:38 INFO - 'PWD': '/builds/slave/test', 05:26:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:38 INFO - 'SHELL': '/bin/bash', 05:26:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zo0hpWi88s/Listeners', 05:26:38 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 05:26:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:38 INFO - 'USER': 'cltbld', 05:26:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:38 INFO - 'XPC_FLAGS': '0x0', 05:26:38 INFO - 'XPC_SERVICE_NAME': '0', 05:26:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:38 INFO - Downloading/unpacking blobuploader==1.2.4 05:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:41 INFO - Downloading blobuploader-1.2.4.tar.gz 05:26:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:26:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:26:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:42 INFO - Downloading docopt-0.6.1.tar.gz 05:26:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:26:42 INFO - Installing collected packages: blobuploader, requests, docopt 05:26:42 INFO - Running setup.py install for blobuploader 05:26:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:26:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:26:42 INFO - Running setup.py install for requests 05:26:43 INFO - Running setup.py install for docopt 05:26:43 INFO - Successfully installed blobuploader requests docopt 05:26:43 INFO - Cleaning up... 05:26:43 INFO - Return code: 0 05:26:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26:43 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')]} 05:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:43 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')]} 05:26:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:43 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 0x106163a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061f8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa23048a720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060c7d30>, '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 0x105e2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060bfb20>, '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.rRmArETzdm/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.Zo0hpWi88s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 05:26:43 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 05:26:43 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 05:26:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rRmArETzdm/Render', 05:26:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:43 INFO - 'HOME': '/Users/cltbld', 05:26:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:43 INFO - 'LOGNAME': 'cltbld', 05:26:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:43 INFO - 'MOZ_NO_REMOTE': '1', 05:26:43 INFO - 'NO_EM_RESTART': '1', 05:26:43 INFO - 'PAGER': '/bin/cat', 05:26:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:43 INFO - 'PWD': '/builds/slave/test', 05:26:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:43 INFO - 'SHELL': '/bin/bash', 05:26:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zo0hpWi88s/Listeners', 05:26:43 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 05:26:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:43 INFO - 'USER': 'cltbld', 05:26:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:43 INFO - 'XPC_FLAGS': '0x0', 05:26:43 INFO - 'XPC_SERVICE_NAME': '0', 05:26:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:26:44 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-KGWlUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:26:44 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-R6QsBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:26:44 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-4sjdY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:26:44 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-gQznOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:26:44 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Ib3raL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:26:44 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-F0CQ6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:26:44 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-m9RAV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:26:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:26:44 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-pQKjL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:26:45 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-IhF7Oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:26:45 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-tl3MI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:26:45 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-7ZtsPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:26:45 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-GPNy53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:26:45 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-fGaBoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:26:45 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-ZxdyVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:45 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-3vdjG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:26:45 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Lg4wP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:26:45 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-8XGfmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:26:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:26:45 INFO - Running setup.py install for manifestparser 05:26:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:26:46 INFO - Running setup.py install for mozcrash 05:26:46 INFO - Running setup.py install for mozdebug 05:26:46 INFO - Running setup.py install for mozdevice 05:26:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:26:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:26:46 INFO - Running setup.py install for mozfile 05:26:46 INFO - Running setup.py install for mozhttpd 05:26:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:26:46 INFO - Running setup.py install for mozinfo 05:26:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:26:46 INFO - Running setup.py install for mozInstall 05:26:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:26:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:26:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:26:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:26:47 INFO - Running setup.py install for mozleak 05:26:47 INFO - Running setup.py install for mozlog 05:26:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:26:47 INFO - Running setup.py install for moznetwork 05:26:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:26:47 INFO - Running setup.py install for mozprocess 05:26:47 INFO - Running setup.py install for mozprofile 05:26:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:26:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:26:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:26:47 INFO - Running setup.py install for mozrunner 05:26:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:26:48 INFO - Running setup.py install for mozscreenshot 05:26:48 INFO - Running setup.py install for moztest 05:26:48 INFO - Running setup.py install for mozversion 05:26:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:26:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:26:48 INFO - Cleaning up... 05:26:48 INFO - Return code: 0 05:26:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:48 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 0x106163a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061f8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa23048a720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060c7d30>, '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 0x105e2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060bfb20>, '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.rRmArETzdm/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.Zo0hpWi88s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 05:26:48 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 05:26:48 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 05:26:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rRmArETzdm/Render', 05:26:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:48 INFO - 'HOME': '/Users/cltbld', 05:26:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:48 INFO - 'LOGNAME': 'cltbld', 05:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:48 INFO - 'MOZ_NO_REMOTE': '1', 05:26:48 INFO - 'NO_EM_RESTART': '1', 05:26:48 INFO - 'PAGER': '/bin/cat', 05:26:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:48 INFO - 'PWD': '/builds/slave/test', 05:26:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:48 INFO - 'SHELL': '/bin/bash', 05:26:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zo0hpWi88s/Listeners', 05:26:48 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 05:26:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:48 INFO - 'USER': 'cltbld', 05:26:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:48 INFO - 'XPC_FLAGS': '0x0', 05:26:48 INFO - 'XPC_SERVICE_NAME': '0', 05:26:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:26:48 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-fbuuSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:26:48 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)) 05:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:26:48 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-I7LmHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:26:49 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)) 05:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:26:49 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-tUIfRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:26:49 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)) 05:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:26:49 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-fpXaet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:26:49 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)) 05:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:26:49 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-95EHPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:26:49 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)) 05:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:26:49 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-TXIoqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:26:49 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)) 05:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:26:49 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-tf8Ioh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:26:49 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)) 05:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:26:49 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Bzlmup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:26:49 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)) 05:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:26:49 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-z3sJiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:26:49 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)) 05:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:26:49 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-BWxOUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:26:49 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)) 05:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:26:49 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-TUXlB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:26:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:26:50 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-aP8UOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:26:50 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)) 05:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:26:50 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-wmUWAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:26:50 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)) 05:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:26:50 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-w0Sua1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:26:50 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)) 05:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:50 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-yv9jMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:50 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)) 05:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:26:50 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Wa0znk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:26:50 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)) 05:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:26:50 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-M2tap5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:26:50 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)) 05:26:50 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)) 05:26:50 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)) 05:26:50 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)) 05:26:50 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)) 05:26:50 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)) 05:26:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:26:50 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 05:26:50 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 05:26:50 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 05:26:50 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 05:26:50 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 05:26:50 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 05:26:53 INFO - Downloading blessings-1.6.tar.gz 05:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:26:53 INFO - Installing collected packages: blessings 05:26:53 INFO - Running setup.py install for blessings 05:26:53 INFO - Successfully installed blessings 05:26:53 INFO - Cleaning up... 05:26:53 INFO - Return code: 0 05:26:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:26:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:26:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:26:53 INFO - Reading from file tmpfile_stdout 05:26:53 INFO - Current package versions: 05:26:53 INFO - blessings == 1.6 05:26:53 INFO - blobuploader == 1.2.4 05:26:53 INFO - docopt == 0.6.1 05:26:53 INFO - functools32 == 3.2.3-2 05:26:53 INFO - jsonschema == 2.5.1 05:26:53 INFO - manifestparser == 1.1 05:26:53 INFO - mozInstall == 1.12 05:26:53 INFO - mozcrash == 0.17 05:26:53 INFO - mozdebug == 0.1 05:26:53 INFO - mozdevice == 0.48 05:26:53 INFO - mozfile == 1.2 05:26:53 INFO - mozhttpd == 0.7 05:26:53 INFO - mozinfo == 0.9 05:26:53 INFO - mozleak == 0.1 05:26:53 INFO - mozlog == 3.3 05:26:53 INFO - moznetwork == 0.27 05:26:53 INFO - mozprocess == 0.23 05:26:53 INFO - mozprofile == 0.28 05:26:53 INFO - mozrunner == 6.12 05:26:53 INFO - mozscreenshot == 0.1 05:26:53 INFO - mozsystemmonitor == 0.3 05:26:53 INFO - moztest == 0.7 05:26:53 INFO - mozversion == 1.4 05:26:53 INFO - psutil == 3.1.1 05:26:53 INFO - requests == 1.2.3 05:26:53 INFO - wsgiref == 0.1.2 05:26:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:53 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 0x106163a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061f8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa23048a720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060c7d30>, '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 0x105e2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060bfb20>, '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.rRmArETzdm/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.Zo0hpWi88s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 05:26:53 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 05:26:53 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 05:26:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rRmArETzdm/Render', 05:26:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:53 INFO - 'HOME': '/Users/cltbld', 05:26:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:53 INFO - 'LOGNAME': 'cltbld', 05:26:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:53 INFO - 'MOZ_NO_REMOTE': '1', 05:26:53 INFO - 'NO_EM_RESTART': '1', 05:26:53 INFO - 'PAGER': '/bin/cat', 05:26:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:53 INFO - 'PWD': '/builds/slave/test', 05:26:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:53 INFO - 'SHELL': '/bin/bash', 05:26:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zo0hpWi88s/Listeners', 05:26:53 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 05:26:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:53 INFO - 'USER': 'cltbld', 05:26:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:53 INFO - 'XPC_FLAGS': '0x0', 05:26:53 INFO - 'XPC_SERVICE_NAME': '0', 05:26:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:54 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)) 05:26:54 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)) 05:26:54 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)) 05:26:54 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)) 05:26:54 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)) 05:26:54 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)) 05:26:54 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)) 05:26:54 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)) 05:26:54 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)) 05:26:54 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)) 05:26:54 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)) 05:26:54 INFO - Cleaning up... 05:26:54 INFO - Return code: 0 05:26:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:54 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 0x106163a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061f8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa23048a720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060c7d30>, '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 0x105e2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060bfb20>, '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.rRmArETzdm/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.Zo0hpWi88s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 05:26:54 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 05:26:54 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 05:26:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rRmArETzdm/Render', 05:26:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:54 INFO - 'HOME': '/Users/cltbld', 05:26:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:54 INFO - 'LOGNAME': 'cltbld', 05:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:54 INFO - 'MOZ_NO_REMOTE': '1', 05:26:54 INFO - 'NO_EM_RESTART': '1', 05:26:54 INFO - 'PAGER': '/bin/cat', 05:26:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:54 INFO - 'PWD': '/builds/slave/test', 05:26:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:54 INFO - 'SHELL': '/bin/bash', 05:26:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zo0hpWi88s/Listeners', 05:26:54 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 05:26:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:54 INFO - 'USER': 'cltbld', 05:26:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:54 INFO - 'XPC_FLAGS': '0x0', 05:26:54 INFO - 'XPC_SERVICE_NAME': '0', 05:26:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:26:54 INFO - Cleaning up... 05:26:54 INFO - Return code: 0 05:26:54 INFO - Running post-action listener: _resource_record_post_action 05:26:54 INFO - Running post-action listener: _start_resource_monitoring 05:26:54 INFO - Starting resource monitoring. 05:26:54 INFO - [mozharness: 2016-08-29 12:26:54.368836Z] Finished create-virtualenv step (success) 05:26:54 INFO - [mozharness: 2016-08-29 12:26:54.369896Z] Running install step. 05:26:54 INFO - Running pre-action listener: _resource_record_pre_action 05:26:54 INFO - Running main action method: install 05:26:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:26:54 INFO - Reading from file tmpfile_stdout 05:26:54 INFO - Detecting whether we're running mozinstall >=1.0... 05:26:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:26:54 INFO - Reading from file tmpfile_stdout 05:26:54 INFO - Output received: 05:26:54 INFO - Usage: mozinstall [options] installer 05:26:54 INFO - Options: 05:26:54 INFO - -h, --help show this help message and exit 05:26:54 INFO - -d DEST, --destination=DEST 05:26:54 INFO - Directory to install application into. [default: 05:26:54 INFO - "/builds/slave/test"] 05:26:54 INFO - --app=APP Application being installed. [default: firefox] 05:26:54 INFO - mkdir: /builds/slave/test/build/application 05:26:54 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'] 05:26:54 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 05:27:28 INFO - Reading from file tmpfile_stdout 05:27:28 INFO - Output received: 05:27:28 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:27:28 INFO - Running post-action listener: _resource_record_post_action 05:27:28 INFO - [mozharness: 2016-08-29 12:27:28.713475Z] Finished install step (success) 05:27:28 INFO - [mozharness: 2016-08-29 12:27:28.713607Z] Running run-tests step. 05:27:28 INFO - Running pre-action listener: _resource_record_pre_action 05:27:28 INFO - Running main action method: run_tests 05:27:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:27:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:27:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:27:28 INFO - 2016-08-29 05:27:28.727 screenresolution[1632:7928] starting screenresolution argv=screenresolution get 05:27:28 INFO - 2016-08-29 05:27:28.730 screenresolution[1632:7928] Display 0: 1600x1200x32@60 05:27:28 INFO - 2016-08-29 05:27:28.736 screenresolution[1633:7930] starting screenresolution argv=screenresolution list 05:27:28 INFO - Available Modes on Display 0 05:27:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:27:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:27:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:27:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:27:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:27:28 INFO - Intel Iris: 05:27:28 INFO - Chipset Model: Intel Iris 05:27:28 INFO - Type: GPU 05:27:28 INFO - Bus: Built-In 05:27:28 INFO - VRAM (Dynamic, Max): 1536 MB 05:27:28 INFO - Vendor: Intel (0x8086) 05:27:28 INFO - Device ID: 0x0a2e 05:27:28 INFO - Revision ID: 0x0009 05:27:28 INFO - Displays: 05:27:28 INFO - Display: 05:27:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:27:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:27:28 INFO - Display Serial Number: 1600x1200 60 05:27:28 INFO - Main Display: Yes 05:27:28 INFO - Mirror: Off 05:27:28 INFO - Online: Yes 05:27:28 INFO - Rotation: Supported 05:27:28 INFO - Return code: 0 05:27:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:27:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:27:28 INFO - Python 2.7.3 05:27:28 INFO - Return code: 0 05:27:28 INFO - grabbing minidump binary from tooltool 05:27:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:28 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 0x1060c7d30>, '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 0x105e2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060bfb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:27:28 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 05:27:28 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 05:27:28 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 05:27:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:27:29 INFO - Return code: 0 05:27:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:27:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:27:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:27:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:27:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:27:29 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LTsN5JAOSeC6a7s-TA096w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0101', '--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 05:27:29 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LTsN5JAOSeC6a7s-TA096w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0101 --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 05:27:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rRmArETzdm/Render', 05:27:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:29 INFO - 'HOME': '/Users/cltbld', 05:27:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:29 INFO - 'LOGNAME': 'cltbld', 05:27:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:27:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:27:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:29 INFO - 'MOZ_NO_REMOTE': '1', 05:27:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:27:29 INFO - 'NO_EM_RESTART': '1', 05:27:29 INFO - 'PAGER': '/bin/cat', 05:27:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:29 INFO - 'PWD': '/builds/slave/test', 05:27:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:27:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:29 INFO - 'SHELL': '/bin/bash', 05:27:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zo0hpWi88s/Listeners', 05:27:29 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 05:27:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:29 INFO - 'USER': 'cltbld', 05:27:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:29 INFO - 'XPC_FLAGS': '0x0', 05:27:29 INFO - 'XPC_SERVICE_NAME': '0', 05:27:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:29 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LTsN5JAOSeC6a7s-TA096w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0101', '--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 05:27:29 INFO - mozversion application_buildid: 20160829030202 05:27:29 INFO - mozversion application_changeset: 1a5b53a831e5a6c20de1b081c774feb3ff76756c 05:27:29 INFO - mozversion application_display_name: Nightly 05:27:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:27:29 INFO - mozversion application_name: Firefox 05:27:29 INFO - mozversion application_remotingname: firefox 05:27:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:27:29 INFO - mozversion application_vendor: Mozilla 05:27:29 INFO - mozversion application_version: 51.0a1 05:27:29 INFO - mozversion platform_buildid: 20160829030202 05:27:29 INFO - mozversion platform_changeset: 1a5b53a831e5a6c20de1b081c774feb3ff76756c 05:27:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:27:29 INFO - mozversion platform_version: 51.0a1 05:27:29 INFO - using testdate: 1472473649 05:27:29 INFO - actual date: 1472473649 05:27:29 INFO - starting webserver on 'localhost:49262' 05:27:29 INFO - SUITE-START | Running 2 tests 05:27:29 INFO - TEST-START | dromaeo_css 05:27:29 INFO - operating with platform_type : mac_ 05:27:29 INFO - Initialising browser for dromaeo_css test... 05:27:29 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpIgaH7I/profile http://localhost:49262/getInfo.html) 05:27:32 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 05:27:32 INFO - PROCESS | 1643 | colorDepth:24 05:27:32 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 05:27:32 INFO - PROCESS | 1643 | __metrics 05:27:32 ERROR - PROCESS | 1643 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 05:27:33 INFO - TEST-INFO | 1643: exit 0 05:27:33 INFO - Browser initialized. 05:27:33 INFO - Running cycle 1/1 for dromaeo_css test... 05:27:33 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpIgaH7I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:27:45 INFO - PROCESS | 1647 | RSS: Main: 243867648 05:27:45 INFO - PROCESS | 1647 | 05:28:34 INFO - PROCESS | 1647 | 1472473714876 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] 05:30:46 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49262/tests/dromaeo/cssquery-ext.html) 05:30:48 INFO - PROCESS | 1647 | RSS: Main: 262471680 05:30:48 INFO - PROCESS | 1647 | 05:33:50 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-ext.html (next: http://localhost:49262/tests/dromaeo/cssquery-jquery.html) 05:33:51 INFO - PROCESS | 1647 | RSS: Main: 270929920 05:33:51 INFO - PROCESS | 1647 | 05:36:53 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49262/tests/dromaeo/cssquery-mootools.html) 05:36:54 INFO - PROCESS | 1647 | RSS: Main: 273039360 05:36:54 INFO - PROCESS | 1647 | 05:39:55 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49262/tests/dromaeo/cssquery-prototype.html) 05:39:56 INFO - PROCESS | 1647 | RSS: Main: 268324864 05:39:56 INFO - PROCESS | 1647 | 05:42:59 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49262/tests/dromaeo/cssquery-yui.html) 05:42:59 INFO - PROCESS | 1647 | RSS: Main: 274743296 05:42:59 INFO - PROCESS | 1647 | 05:46:02 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-yui.html (next: http://localhost:49262/tests/dromaeo/cssquery-dojo.html) 05:46:02 INFO - PROCESS | 1647 | RSS: Main: 277544960 05:46:02 INFO - PROCESS | 1647 | 05:46:02 INFO - PROCESS | 1647 | __start_tp_report 05:46:02 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 05:46:02 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 05:46:02 INFO - PROCESS | 1647 | |i|pagename|runs| 05:46:02 INFO - PROCESS | 1647 | |0;dojo.html;2808.508511010574;2858.6426696662916;3412.385770561298;3444.259484210895;3485.9825700871493;4934.481879402665;5396.64921780084;5638.548916086714;5833.824985250444;5885.823425297237;5750.137479378095;5752.28096487939;5769.3076830780265;5802.39074897136;5869.677167755783;5155.9484405155845;5178.145605975019;5265.341832270966;5352;5359.598030147735;5104.285400043997;5157.638965272433;5202.895942081156;5313.3092697949405;5319.255304257407;5247.527722504955;5259.684418934857;5259.710715910662;5263.26314315996;5306.8407947761625;5287.339082614673;5292.576593872481;5308.734563271821;5323.733813309319;5367.704776237305;5163.251328557376;5247.606429517801;5270.288511051036;5290.761915713802;5316;5688.914666280009;5768.596198266123;5773.740181691834;5774.422557744234;5840.678762668052;6205.317415084337;6249.218847644044;6283.7800676976085;6312.905306420407;6314.62112273265;6174.969125154345;6184.6907654617535;6245.18812554365;6251.249850018027;6257.780977665805;5943.197668314765;5955.225820643289;5966.31387390447;5972.402759723993;6015.939840601582;6352.587081839665;6381.840453988594;6391.105245265667;6414.679266036773;6422.261439934374;6072.332043475214;6096.677875983229;6159.876802463926;6161.507079433634;6211.2857021442205;6259.0924315973925;6275.780347687809;6278.6546739929745;6281.3404592518045;6299.937000630027;6225.595336303126;6240.906386404207;6273.686315684197;6309.558330916883;6329.430351268408;6091.994469032087;6174.691265436711;6176.598521096204;6277.78027769035;6287.46556542699;4224.408582798411;5012.1980483122525;5037.420696619863;5040.7731652075745;5079.5428411443145;4515.277555591156;4515.390422292949;4517.728936263835;4530.546945305509;4536.546345365503;5157.174852023658;5609.326880774333;5766.250387449605;5775.133729940459;5906.852328691817;6117.2184870185665;6167.136600875881;6197.349278325711;6260.843478912972;6265.96867015662;5748.367679555246;5748.770049198069;5749.8562535936935;5758.74085666146;5763.193152958589;5158.948410515922;5181.015607034651;5364.90019546;5408.350997880201;5446.91829622556;6308.3060863305;6331.651759153291;6351.714172862232;6428.035794630843;6443.194600674916;6208.410201030895;6275.215598050244;6279.560430769802;6292.465140463112;6299.275583307978;5419.9431110934565;5655.236543066633;6195.566310358232;6437.839054023687;6452.032195170762;6239.376062393724;6241.625502469867;6242.500599951902;6303.558750887577;6312.7159277833525;6274.968625156845;6276.686165691788;6280.968595157177;6281.654509001866;6299.748010079546;6059.212302400836;6121.696863452088;6160.722767475385;6203.658798766111;6248.12526246335;6116.724747386289;6129.664444256008;6222.62664240147;6223.37766223374;6225.657588832658;5953.345132035559;5997.610155339889;6075.68429974569;6077.908831367445;6133.539984501091;6045.78839740607;6092.360302168208;6142.222533141996;6232.407921247474;6242.719077641426;6050.878982420239;6068.787592434243;6098.9390106100145;6114.847128821815;6117.143599895929 05:46:02 INFO - PROCESS | 1647 | |1;ext.html;470.6540692590946;530.075019091685;536.2787051415845;537.100356902189;571.345809048639;37115.62884371156;39452;39492.60507394925;39508.01229969252;39510.80244598776;40334.19331613366;40928;40950.79524602373;41015.589844101625;41059.58940410595;9606.855897161531;9828.017198280151;9829.557669904836;9835.11483966443;9842.950785246063;9707.805843883118;9796.804063918717;9812.901870981306;9825.312228144032;9828.312018158731;9783.168430683365;9831.852522212173;9850.950745246264;9856.359336643096;9859.507024648774;9764.316497845119;9765.462899540522;9809.068138526829;9836.3606365586;9873.506324683809;8307.83384332316;9695.466749328783;9742.902570974271;9765.414075155513;9770.169535589412;32394.6760532394;38857.834264972094;39089.21821563553;39367;39442.60557394418;3269.6893795089427;3303.6696330367013;3404.2553191489314;3462.290230502741;3943.4873466449467;23381;30474.54288185679;30946.226344341347;30949.381012379625;31211.687883121107;3089.3049063960652;3253.349330133959;3307.470804671265;3310.420676381648;3319.286353434023;472601;478889.9999999965;479406;480032;480446;55385.44614553884;55683.72158139183;55704;55710;55817.72091139518;56829.71585142048;57425.42574574285;57576.13635795467;57598.71200644054;57742.133867992015;16048.277827497557;16137.354505819636;16225;16293.837061629469;16294.674106517803;12722.918551923005;12809.807852882213;12850.357482125857;12852.357382130856;12872.678183045498;9556.617735290649;13041.804372934414;15065.322060507304;15344.616384590252;15366.157260906544;5525.972370138124;6444;6549.312322206195;6552.213734351908;6592.9340706593275;699.909011828459;796.8127490039836;822.2805045585113;924.2393240876141;956.9377990430739;23827.7617223829;29234;29370.853145734134;30001.549976750368;30151.396972060436;1019.0980981831133;1031.5925209542188;1077.175960390302;1094.6332978452149;1103.9834402483968;13471.797923031163;14831.77752333716;14866.702665946837;15111.773323400157;15168;666181;669835;673809;675054.624726883;676794;52757.47242527602;52794.47205527896;52988.470115299126;53153.46846531562;53252;1343.7581235377727;1363.2297751770218;1389.6803735140975;1400.7758758598575;1402.6914078902626;26257.606135907594;28519.28701782472;28775;29874;30194.9431769887;46431.53568464407;51847.22229166641;53200;53368;56078.158827618434;478843;481601;482020;482118;482813;25271.851892589337;25372;25626.743732562434;25665.893457046783;25762.35594110162;42025.579744202165;42657;45531.77234113808;46235.53764462447;47414;38387.424188636636;38412;38783;39316;39873.60126398699;37485.25029499449;37512.43731344087;37603.81198094101;38880;38933.415998759476;32952;37263.62736372602;37342.62657373391;37768;38295.80852095722;30201.546976795806;33936.490952635235;34061.31877362489;34177.48733769045;34278.82860585681;24946.50106997886;25326;25679.409952088696;25687.486250274516;26100.608490873034 05:46:02 INFO - PROCESS | 1647 | |2;jquery.html;323.66015683532294;368.88564544991056;370.5479315235412;382.8755654412317;407.3279089502321;17681.91159044203;20252.69620955685;20290.59418811623;21015.47461313468;21244.256451024215;16574.337026518955;19915.60168796623;20365.490862728402;20807.583848323025;20962.580748385022;5480.232767412565;5618.325800903876;5625.40933202014;5638.718064096799;5928.940710592904;6038.577299589008;6173.938260617404;6185.876282474348;6186.257649082117;6194;5954.047352423613;6028.788992385267;6054.576179667425;6091.725872335755;6094.3905609438925;5946.732397042122;6092.878142437171;6144.815655530341;6172.382761723837;6172.814815555541;5388.299521062276;7228.241034691387;7634.198409167013;7699.499532530368;7775.533467991939;28232.576511352345;28650.283742906384;28847.71152288471;29147;29662.70337296621;2394.1022116706235;2702.594610808375;2822.463731890934;2832.745052945245;2989.327401334704;14498.565043048726;14861.443381180266;16263.430779922764;17418.78068535203;17754.733678994697;1673.916304184786;1778.5642517583276;1803.431918945528;2146.2380854796634;2148.3769706785015;105112.47443762809;109429.90570094356;109481.45259273732;140161;147456.2627186868;15842.28709708066;18668;19305.227790888206;20985.79014209869;21126.788732112484;34654.133646658534;34852.78015269453;35351;35437.46843797345;35525.644743552235;10461.529231184615;10468.469872944188;11020.834687479693;11037.448127593589;11096;8588.484690918565;9017.954910225408;9121.224695900923;9171.81656366869;9276.489793061312;9529.761755956157;9583.281253905845;9601.32790704658;9749.658761943298;9846.409215446953;2921.0214578116143;3649.7810131392202;3753.1930634913624;3822.7334235453004;3871.9806400967814;861.8965724113147;873.5021038008274;876.8684697295457;1013.4020927652721;1036.7926414717087;20435;20804;21006.684899726515;21028.158873644883;21074.47313817136;933.4352716606492;938.1424778937742;950.6054987180243;956.9473678947586;967.8016006718606;10400.27198096126;11083;11085.390303533382;11089.500972456259;11167.888321116685;587226;587280;590696;601100;601955;96764;107345.70617175382;126431.3678431602;128512;130534;874.5452364770284;959.1271942532262;966.9129778319985;968.9854652180223;969.2004096620317;18103.366382176562;19119.426417207505;19128.330508432136;19142.904285478482;19482.902585486983;52534.73732631465;52861;53675;54150.72924635352;54172.749635022024;76141.57362918793;76179.61910190413;76962.23037769551;77980.83028754687;78520.21479785358;8043.356531477585;8129.552874591955;8289.585520723818;8331.250187483156;8515.74452766418;11090.336449532311;12894.871051289367;13098.476060957455;13128.737425251633;13176.275304858325;9456.716298511055;11080;11157.442127893735;11339.036181924628;11393.202475826612;10335.793284134124;10927.289726168092;10938.726531836768;11043.558257669603;11402.429878506207;11310;11354.091672666333;11565.421728913689;11688.357140357022;11740.236884602473;8063.314618257514;8229.423940324119;8232.259096681328;8334.416590838584;8481.109483504144;8243.451846189726;10821.25796376627;11110;11437;11645.301281923112 05:46:02 INFO - PROCESS | 1647 | |3;mootools.html;1312.9015323850713;1498.1610298232988;1593.984060159398;1661.9861884250604;1854.3046357615895;7818.218178182179;8317.708880189195;8413.957930210341;8836.718675792014;8854;8463.19599638035;8651.178138076888;8653.048164701877;8653.653853845839;8704.43421177623;2359.3865594945264;2372.0986025310444;2379.4646204603914;2386.9283921482297;2389.223502361731;2335.8832058397097;2362.3621622162004;2391.3782416571644;2394.1381102802975;2396.8681722505257;2357.35172827473;2366.514864452783;2379.762023797624;2380.976190238093;2388.0567175965484;2336.2523992322463;2351.5061837014246;2352.0356653771955;2362.102401087593;2364.267077206063;2304.2626359564947;2319.3621754017613;2321.1991862807304;2322.5935461294375;2323.0011095229047;8674.089220631806;8675.826483470295;8723.956380218122;8762.605682744292;8766.780830479225;5156.226566015091;5316.760745766411;5320.308359913187;5320.866978325535;5329.440408757064;3553.822308884571;3591.44332628443;3609;3655.323765103464;3662.5788034375855;1022.2588623248085;1025.2157099818571;1040.9583616655325;1042.1194090993174;1049.1344640671477;11215.439228038647;11268.492917818636;11374.545018199262;11381.430928453545;11384.487698053608;3788.8484460621817;3985.8405663773706;3989;4512.5261847505535;4791.880202994953;9768.36505627132;9813;9827.803443931081;9840.753981150385;9850.655227067018;5296.602754793406;5307.230451584499;5328.573714102862;5328.813491527778;5344.144936810092;4360.389545463638;4723.740194289278;4843.539863712942;4883.853484395474;4888.926666100011;3821.694264458892;3880.3985382265796;3932.7050471214775;3970.7021973352116;3982.880513584597;1276.5659675710117;1282.5767496726244;1291.9870801291868;1292.8901043411415;1298.9870101299055;816.2816721285232;823.4812068396872;873.9038705742363;925.7824411263348;938.7183844846655;5926.111083337534;5964.940350596526;6014.609050411709;6083.604565703304;6252.280987686474;885.4156256870434;906.3474298505066;910.6539514984264;914.7895983923735;928.972130836076;3943.3099207638547;3945.4279129526058;3960.7029472789654;4000.3599424092004;4155.58444155588;10316.535755891004;10569.418681972566;10665.41340226295;10675.733106672395;10678.786424271471;10583.206259530412;10607.787844243072;10612.151027917902;10612.522436490377;10624;8093.109757926623;8187.795305117301;8209.8358032839;8216.507009579444;8249.546274954815;4953.504649535162;5532.589189756586;5610.7194640268635;5949.2266005419015;6017.338092809875;9824.4105353679;9844.803103937738;9919.603215871284;9972.401655900669;10007.699769006942;7839.176886426843;9616.182624476998;9744.635750994725;10082.798344033225;10146.79706405853;5617.354004289396;6443.355664433519;6784.253732089367;6882.896756548756;7037.648117593997;6417.26201486835;7740.684083705671;8378.748637540639;8447.070822209429;8473.110323416198;6403.6798160090875;7311;7439.330460258603;7475.327220550176;7543.849123017619;7106.147262328347;7225.349718525358;7366.300201480851;7413.629318533944;7468.066491688539;6838.8290292741085;6871.14110736158;6931.306869313028;6939.826504337432;6986.6855991481525;4266.65866730667;4945.307656928105;4972.577330926912;5028.421731500778;5031.245313202902;4882.36529251195;4886.755662216946;4897.191963326011;5004.574611158092;5040.84877453677 05:46:02 INFO - PROCESS | 1647 | |4;prototype.html;250.8582650802297;264.4050885507608;301.76613124828253;314.05939212059883;315.9383920135572;4691.648126390517;5144.202648589465;5483.8080667176655;5567.276254086968;5681.37504874464;5591.888162236753;5595.608307418483;5599.972000139994;5615.578831587627;5674.602777805555;3871.8838434847;4254;4266.381374700666;4284.250256205167;4295.656347492209;3710.424884142962;3724.9942515520793;3731.8880433587037;4196.748195108304;4215.262329092412;4157.729747566414;4162.646175075107;4162.875113746592;4166.10428757817;4167.187398457302;3852.1109168123908;4209.852655157055;4241.787910604488;4253.638440732557;4262.424572682679;3071.2014876132143;3628.909277268063;3639.344917914774;3696.464012718141;3720.3675375186285;4894.241392584155;5081.189108168874;5372.328458942632;5400.567954563626;5412.404635490093;4821.4696383397795;4830.637702172351;4882.731449770261;4901.1177987962155;4937.407511098655;5508.9724551377385;5873.735681894283;5942.316633587149;5963.717800672833;6045.909311360333;3868.6324799144036;3970.940435893464;4010.278149933011;4014.2172276406113;4017.9397309040387;5080.120355468501;5126.641135120543;5819;6244.908770158755;6373.5857169283845;4058.857939972087;4065.308897487375;4087.46862907826;4125.071858831739;4131.905045163035;3462.601800792941;3605.6214097519905;4112.485939257593;4122.6083522065355;4124.587541245852;4464.906098005944;4481.932771008437;4767.904641907143;4790.125924445305;4875.146849301358;5164.302819119371;5539.612227144142;5913.7876735269165;5984.132300816357;6110.755569777248;1109.4951796932376;1202.5430336472084;1252.2861968677948;1407.8451370349253;1430.885529157665;749.9812504687427;853.8804567360575;880.6257340630207;886.3175354976761;886.7629656629096;4109.2808758467145;4357.302831546937;4576.368588061878;4693.436787585511;4790.784414701347;5079.492050794965;5109.897802044013;5160.741962901915;5212.40057393397;5220.190870415092;4061.5126184858004;4258;4301.461957634725;4376.803043863034;4678.672492925531;2272.704548408696;2359.4809141988735;2422.8909699063584;2423.9272821815375;2712.620233167358;4616.4765627342895;5082.339295891585;5200.037992971313;5284.5772338212855;5366.302380690563;4743.865260632729;5117.108833509055;5128.871388453041;5170;5233.83353071394;4383.649308055348;4937.358143441402;5094.261332106824;5254.97372513135;5306.867328316823;4577.496475387638;5085.093090091215;5137.557836249647;5183;5188.846628649068;5016.297718319365;5038.647294689336;5047.570956468741;5108.310378099058;5756.712164391847;6404.551681382259;6423.9036414452885;6463.450606698483;6481.319461456479;6518.608883467007;3099.6900309968823;3678.50340204069;3991.6207960243732;4024.215278020758;4031.2945234583244;5145.639805213599;5315.3621565412395;6111.816645500642;6232.220972378453;6274.403931626488;4898.779554920108;5173.896522069613;5392.946070539245;5929.733162007634;5939.940600593939;5430.83707488776;5489.678744359765;5717.7712891485535;5941.613795103304;5972.745723398135;5477.75350109254;5776.7111644418455;5818.76724931015;5820.388859169896;5841.795537156179;5525.723713814374;5570.832875013756;5951.345352011189;5978.133170690313;6018.1875446815875;4784.712917224978;4928.654994150375;5601;5925.288965324189;5943.732532035982 05:46:02 INFO - PROCESS | 1647 | |5;yui.html;649.928507864135;657.4575974820774;664.7540410048283;739.6560599321315;791.7980914866708;15206.923965380185;15497.5350739478;16049.83950160498;16065.357385704572;16074.758878616816;12250.754984900297;14775.556733297992;14867.405303787862;14877;14892.702145957075;855.4311382930359;867.9132086791302;868.6004437958546;869.2220462685924;870.4646642314963;659.7954634063432;835.5028757889046;847.4110493207223;847.4576271186446;857.5497863621617;845.327964268405;848.0755975986174;879.5382424227267;890.7773056735816;900.1043961258557;867.0332579174207;879.1516186879628;888.6534251641865;892.2148509311796;894.5080205886736;649.9415052645237;656.1273506236694;658.9275179730225;660.2506155513479;662.8707402056601;14958.925205373904;15249.923750381287;15252.237388130548;15254.23728813566;15370.538883833502;13725.45098196071;13944.790828137586;14168.85831141696;14497.42010319586;14530.854691453056;11632.651020469399;11658;11663.825042624367;11721.765564688743;11781.469833857496;3528.072086345203;3684.3184010958057;3742.139307959185;3742.8877133686033;3801.8669346573015;97352.51323743406;109779;110032;111680;112506.43746781295;10340.948295258475;10512.474376281156;10605.893941060645;10711.678649640524;10807.729806754895;21140.260090896743;21229.363119106452;21255.574888502142;21286.019957206005;21334.893325533274;7760.844783104306;7907.56508392044;7925.524468531907;7926.48477848938;8091.474054186577;3841.9807900960877;4248.745075295492;4312.54718254585;4333.541772126748;4386;3531.911702207414;3659.853605855736;3662.3957047087465;3664.8534058637356;3670.4677821716236;544.2516539757833;582.4001278682963;621.9253689557282;646.9385408386196;647.2556559956088;498.28187238613276;563.3183847544435;625.5058503782052;629.3989240275525;660.3891400454656;8734.432261903083;9400.48297343639;9542.666006689733;9581.664641737505;9695.70912872615;583.9737211825478;601.1703848688782;606.233115109387;611.2909025530363;638.0493065332714;4427.313766366218;4436.46762388509;4452.220861349251;4539.795709193094;4610.561996610317;102153;147630;151896.2405187989;162412;170092;137763;139394.30302848623;142424.28787856203;143261.28369358086;143848.28075859553;123980.76019239872;125791.74208257983;128826.35586822193;129361.99999999812;130037.04944425842;8988.595513201792;9021.503817290111;9048.683296084606;9064.138906803842;9187.402818817023;44234.55765442304;57511.71244143753;58273.0863456834;58991.41008589859;62992.68503657453;65143;86886.13113869034;87025;87734.56132719296;96091;11771.999380052792;11946.76106477883;12516.812247816471;12878.806817897927;13075.476980920657;14403;14744.336504857522;14777.778333325225;14793.704125917206;15309.617259568155;11815.704607384883;12289;12965.962722982327;13333.799993000306;14277.714445711235;10501.30292834397;13154.276514791778;13449.924446976951;13474.124181928144;13499.257540835348;13269.933650331686;13366.131201471873;13404.195748255135;13413.932930335286;13577.456901723821;10904;10976.945115274373;11367.715807104558;11562.364069976233;11789.469473873867;7813.882791758015;9587.376820506644;11280.717982050515;11541.480633371686;11559.017483513995 05:46:02 INFO - PROCESS | 1647 | __end_tp_report 05:46:02 INFO - PROCESS | 1647 | __start_cc_report 05:46:02 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,382 05:46:02 INFO - PROCESS | 1647 | __end_cc_report 05:46:02 INFO - PROCESS | 1647 | __startTimestamp1472474762828__endTimestamp 05:46:02 INFO - PROCESS | 1647 | 05:46:02 INFO - PROCESS | 1647 | ------- Summary: start ------- 05:46:02 INFO - PROCESS | 1647 | Number of tests: 6 05:46:02 INFO - PROCESS | 1647 | 05:46:02 INFO - PROCESS | 1647 | [#0] dojo.html Cycles:165 Average:5774.13 Median:6068.79 stddev:673.94 (11.1%) stddev-sans-first:634.59 05:46:02 INFO - PROCESS | 1647 | Values: 2808.5 2858.6 3412.4 3444.3 3486.0 4934.5 5396.6 5638.5 5833.8 5885.8 5750.1 5752.3 5769.3 5802.4 5869.7 5155.9 5178.1 5265.3 5352.0 5359.6 5104.3 5157.6 5202.9 5313.3 5319.3 5247.5 5259.7 5259.7 5263.3 5306.8 5287.3 5292.6 5308.7 5323.7 5367.7 5163.3 5247.6 5270.3 5290.8 5316.0 5688.9 5768.6 5773.7 5774.4 5840.7 6205.3 6249.2 6283.8 6312.9 6314.6 6175.0 6184.7 6245.2 6251.2 6257.8 5943.2 5955.2 5966.3 5972.4 6015.9 6352.6 6381.8 6391.1 6414.7 6422.3 6072.3 6096.7 6159.9 6161.5 6211.3 6259.1 6275.8 6278.7 6281.3 6299.9 6225.6 6240.9 6273.7 6309.6 6329.4 6092.0 6174.7 6176.6 6277.8 6287.5 4224.4 5012.2 5037.4 5040.8 5079.5 4515.3 4515.4 4517.7 4530.5 4536.5 5157.2 5609.3 5766.3 5775.1 5906.9 6117.2 6167.1 6197.3 6260.8 6266.0 5748.4 5748.8 5749.9 5758.7 5763.2 5158.9 5181.0 5364.9 5408.4 5446.9 6308.3 6331.7 6351.7 6428.0 6443.2 6208.4 6275.2 6279.6 6292.5 6299.3 5419.9 5655.2 6195.6 6437.8 6452.0 6239.4 6241.6 6242.5 6303.6 6312.7 6275.0 6276.7 6281.0 6281.7 6299.7 6059.2 6121.7 6160.7 6203.7 6248.1 6116.7 6129.7 6222.6 6223.4 6225.7 5953.3 5997.6 6075.7 6077.9 6133.5 6045.8 6092.4 6142.2 6232.4 6242.7 6050.9 6068.8 6098.9 6114.8 6117.1 05:46:02 INFO - PROCESS | 1647 | 05:46:02 INFO - PROCESS | 1647 | [#1] ext.html Cycles:180 Average:67238.89 Median:39500.31 stddev:147519.78 (373.5%) stddev-sans-first:147848.43 05:46:02 INFO - PROCESS | 1647 | Values: 470.7 530.1 536.3 537.1 571.3 37115.6 39452.0 39492.6 39508.0 39510.8 40334.2 40928.0 40950.8 41015.6 41059.6 9606.9 9828.0 9829.6 9835.1 9843.0 9707.8 9796.8 9812.9 9825.3 9828.3 9783.2 9831.9 9851.0 9856.4 9859.5 9764.3 9765.5 9809.1 9836.4 9873.5 8307.8 9695.5 9742.9 9765.4 9770.2 32394.7 38857.8 39089.2 39367.0 39442.6 3269.7 3303.7 3404.3 3462.3 3943.5 23381.0 30474.5 30946.2 30949.4 31211.7 3089.3 3253.3 3307.5 3310.4 3319.3 472601.0 478890.0 479406.0 480032.0 480446.0 55385.4 55683.7 55704.0 55710.0 55817.7 56829.7 57425.4 57576.1 57598.7 57742.1 16048.3 16137.4 16225.0 16293.8 16294.7 12722.9 12809.8 12850.4 12852.4 12872.7 9556.6 13041.8 15065.3 15344.6 15366.2 5526.0 6444.0 6549.3 6552.2 6592.9 699.9 796.8 822.3 924.2 956.9 23827.8 29234.0 29370.9 30001.5 30151.4 1019.1 1031.6 1077.2 1094.6 1104.0 13471.8 14831.8 14866.7 15111.8 15168.0 666181.0 669835.0 673809.0 675054.6 676794.0 52757.5 52794.5 52988.5 53153.5 53252.0 1343.8 1363.2 1389.7 1400.8 1402.7 26257.6 28519.3 28775.0 29874.0 30194.9 46431.5 51847.2 53200.0 53368.0 56078.2 478843.0 481601.0 482020.0 482118.0 482813.0 25271.9 25372.0 25626.7 25665.9 25762.4 42025.6 42657.0 45531.8 46235.5 47414.0 38387.4 38412.0 38783.0 39316.0 39873.6 37485.3 37512.4 37603.8 38880.0 38933.4 32952.0 37263.6 37342.6 37768.0 38295.8 30201.5 33936.5 34061.3 34177.5 34278.8 24946.5 25326.0 25679.4 25687.5 26100.6 05:46:02 INFO - PROCESS | 1647 | 05:46:02 INFO - PROCESS | 1647 | [#2] jquery.html Cycles:180 Average:36108.18 Median:17488.90 stddev:98795.60 (564.9%) stddev-sans-first:99036.21 05:46:02 INFO - PROCESS | 1647 | Values: 323.7 368.9 370.5 382.9 407.3 17681.9 20252.7 20290.6 21015.5 21244.3 16574.3 19915.6 20365.5 20807.6 20962.6 5480.2 5618.3 5625.4 5638.7 5928.9 6038.6 6173.9 6185.9 6186.3 6194.0 5954.0 6028.8 6054.6 6091.7 6094.4 5946.7 6092.9 6144.8 6172.4 6172.8 5388.3 7228.2 7634.2 7699.5 7775.5 28232.6 28650.3 28847.7 29147.0 29662.7 2394.1 2702.6 2822.5 2832.7 2989.3 14498.6 14861.4 16263.4 17418.8 17754.7 1673.9 1778.6 1803.4 2146.2 2148.4 105112.5 109429.9 109481.5 140161.0 147456.3 15842.3 18668.0 19305.2 20985.8 21126.8 34654.1 34852.8 35351.0 35437.5 35525.6 10461.5 10468.5 11020.8 11037.4 11096.0 8588.5 9018.0 9121.2 9171.8 9276.5 9529.8 9583.3 9601.3 9749.7 9846.4 2921.0 3649.8 3753.2 3822.7 3872.0 861.9 873.5 876.9 1013.4 1036.8 20435.0 20804.0 21006.7 21028.2 21074.5 933.4 938.1 950.6 956.9 967.8 10400.3 11083.0 11085.4 11089.5 11167.9 587226.0 587280.0 590696.0 601100.0 601955.0 96764.0 107345.7 126431.4 128512.0 130534.0 874.5 959.1 966.9 969.0 969.2 18103.4 19119.4 19128.3 19142.9 19482.9 52534.7 52861.0 53675.0 54150.7 54172.7 76141.6 76179.6 76962.2 77980.8 78520.2 8043.4 8129.6 8289.6 8331.3 8515.7 11090.3 12894.9 13098.5 13128.7 13176.3 9456.7 11080.0 11157.4 11339.0 11393.2 10335.8 10927.3 10938.7 11043.6 11402.4 11310.0 11354.1 11565.4 11688.4 11740.2 8063.3 8229.4 8232.3 8334.4 8481.1 8243.5 10821.3 11110.0 11437.0 11645.3 05:46:02 INFO - PROCESS | 1647 | 05:46:02 INFO - PROCESS | 1647 | [#3] mootools.html Cycles:180 Average:5601.93 Median:5016.50 stddev:3124.89 (62.3%) stddev-sans-first:3117.03 05:46:02 INFO - PROCESS | 1647 | Values: 1312.9 1498.2 1594.0 1662.0 1854.3 7818.2 8317.7 8414.0 8836.7 8854.0 8463.2 8651.2 8653.0 8653.7 8704.4 2359.4 2372.1 2379.5 2386.9 2389.2 2335.9 2362.4 2391.4 2394.1 2396.9 2357.4 2366.5 2379.8 2381.0 2388.1 2336.3 2351.5 2352.0 2362.1 2364.3 2304.3 2319.4 2321.2 2322.6 2323.0 8674.1 8675.8 8724.0 8762.6 8766.8 5156.2 5316.8 5320.3 5320.9 5329.4 3553.8 3591.4 3609.0 3655.3 3662.6 1022.3 1025.2 1041.0 1042.1 1049.1 11215.4 11268.5 11374.5 11381.4 11384.5 3788.8 3985.8 3989.0 4512.5 4791.9 9768.4 9813.0 9827.8 9840.8 9850.7 5296.6 5307.2 5328.6 5328.8 5344.1 4360.4 4723.7 4843.5 4883.9 4888.9 3821.7 3880.4 3932.7 3970.7 3982.9 1276.6 1282.6 1292.0 1292.9 1299.0 816.3 823.5 873.9 925.8 938.7 5926.1 5964.9 6014.6 6083.6 6252.3 885.4 906.3 910.7 914.8 929.0 3943.3 3945.4 3960.7 4000.4 4155.6 10316.5 10569.4 10665.4 10675.7 10678.8 10583.2 10607.8 10612.2 10612.5 10624.0 8093.1 8187.8 8209.8 8216.5 8249.5 4953.5 5532.6 5610.7 5949.2 6017.3 9824.4 9844.8 9919.6 9972.4 10007.7 7839.2 9616.2 9744.6 10082.8 10146.8 5617.4 6443.4 6784.3 6882.9 7037.6 6417.3 7740.7 8378.7 8447.1 8473.1 6403.7 7311.0 7439.3 7475.3 7543.8 7106.1 7225.3 7366.3 7413.6 7468.1 6838.8 6871.1 6931.3 6939.8 6986.7 4266.7 4945.3 4972.6 5028.4 5031.2 4882.4 4886.8 4897.2 5004.6 5040.8 05:46:02 INFO - PROCESS | 1647 | 05:46:02 INFO - PROCESS | 1647 | [#4] prototype.html Cycles:180 Average:4540.93 Median:5027.47 stddev:1424.29 (28.3%) stddev-sans-first:1391.41 05:46:02 INFO - PROCESS | 1647 | Values: 250.9 264.4 301.8 314.1 315.9 4691.6 5144.2 5483.8 5567.3 5681.4 5591.9 5595.6 5600.0 5615.6 5674.6 3871.9 4254.0 4266.4 4284.3 4295.7 3710.4 3725.0 3731.9 4196.7 4215.3 4157.7 4162.6 4162.9 4166.1 4167.2 3852.1 4209.9 4241.8 4253.6 4262.4 3071.2 3628.9 3639.3 3696.5 3720.4 4894.2 5081.2 5372.3 5400.6 5412.4 4821.5 4830.6 4882.7 4901.1 4937.4 5509.0 5873.7 5942.3 5963.7 6045.9 3868.6 3970.9 4010.3 4014.2 4017.9 5080.1 5126.6 5819.0 6244.9 6373.6 4058.9 4065.3 4087.5 4125.1 4131.9 3462.6 3605.6 4112.5 4122.6 4124.6 4464.9 4481.9 4767.9 4790.1 4875.1 5164.3 5539.6 5913.8 5984.1 6110.8 1109.5 1202.5 1252.3 1407.8 1430.9 750.0 853.9 880.6 886.3 886.8 4109.3 4357.3 4576.4 4693.4 4790.8 5079.5 5109.9 5160.7 5212.4 5220.2 4061.5 4258.0 4301.5 4376.8 4678.7 2272.7 2359.5 2422.9 2423.9 2712.6 4616.5 5082.3 5200.0 5284.6 5366.3 4743.9 5117.1 5128.9 5170.0 5233.8 4383.6 4937.4 5094.3 5255.0 5306.9 4577.5 5085.1 5137.6 5183.0 5188.8 5016.3 5038.6 5047.6 5108.3 5756.7 6404.6 6423.9 6463.5 6481.3 6518.6 3099.7 3678.5 3991.6 4024.2 4031.3 5145.6 5315.4 6111.8 6232.2 6274.4 4898.8 5173.9 5392.9 5929.7 5939.9 5430.8 5489.7 5717.8 5941.6 5972.7 5477.8 5776.7 5818.8 5820.4 5841.8 5525.7 5570.8 5951.3 5978.1 6018.2 4784.7 4928.7 5601.0 5925.3 5943.7 05:46:02 INFO - PROCESS | 1647 | 05:46:02 INFO - PROCESS | 1647 | [#5] yui.html Cycles:180 Average:25143.69 Median:3663.62 stddev:41238.99 (1125.6%) stddev-sans-first:41313.67 05:46:02 INFO - PROCESS | 1647 | Values: 649.9 657.5 664.8 739.7 791.8 15206.9 15497.5 16049.8 16065.4 16074.8 12250.8 14775.6 14867.4 14877.0 14892.7 855.4 867.9 868.6 869.2 870.5 659.8 835.5 847.4 847.5 857.5 845.3 848.1 879.5 890.8 900.1 867.0 879.2 888.7 892.2 894.5 649.9 656.1 658.9 660.3 662.9 14958.9 15249.9 15252.2 15254.2 15370.5 13725.5 13944.8 14168.9 14497.4 14530.9 11632.7 11658.0 11663.8 11721.8 11781.5 3528.1 3684.3 3742.1 3742.9 3801.9 97352.5 109779.0 110032.0 111680.0 112506.4 10340.9 10512.5 10605.9 10711.7 10807.7 21140.3 21229.4 21255.6 21286.0 21334.9 7760.8 7907.6 7925.5 7926.5 8091.5 3842.0 4248.7 4312.5 4333.5 4386.0 3531.9 3659.9 3662.4 3664.9 3670.5 544.3 582.4 621.9 646.9 647.3 498.3 563.3 625.5 629.4 660.4 8734.4 9400.5 9542.7 9581.7 9695.7 584.0 601.2 606.2 611.3 638.0 4427.3 4436.5 4452.2 4539.8 4610.6 102153.0 147630.0 151896.2 162412.0 170092.0 137763.0 139394.3 142424.3 143261.3 143848.3 123980.8 125791.7 128826.4 129362.0 130037.0 8988.6 9021.5 9048.7 9064.1 9187.4 44234.6 57511.7 58273.1 58991.4 62992.7 65143.0 86886.1 87025.0 87734.6 96091.0 11772.0 11946.8 12516.8 12878.8 13075.5 14403.0 14744.3 14777.8 14793.7 15309.6 11815.7 12289.0 12966.0 13333.8 14277.7 10501.3 13154.3 13449.9 13474.1 13499.3 13269.9 13366.1 13404.2 13413.9 13577.5 10904.0 10976.9 11367.7 11562.4 11789.5 7813.9 9587.4 11280.7 11541.5 11559.0 05:46:02 INFO - PROCESS | 1647 | -------- Summary: end -------- 05:46:02 INFO - PROCESS | 1647 | 05:46:03 INFO - TEST-INFO | 1647: exit 0 05:46:03 INFO - TEST-OK | dromaeo_css | took 1114157ms 05:46:03 INFO - TEST-START | kraken 05:46:03 INFO - operating with platform_type : mac_ 05:46:03 INFO - Initialising browser for kraken test... 05:46:03 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmp1OMAqT/profile http://localhost:49262/getInfo.html) 05:46:06 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 05:46:06 INFO - PROCESS | 1657 | colorDepth:24 05:46:06 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 05:46:06 INFO - PROCESS | 1657 | __metrics 05:46:06 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 05:46:06 INFO - TEST-INFO | 1657: exit 0 05:46:06 INFO - Browser initialized. 05:46:06 INFO - Running cycle 1/1 for kraken test... 05:46:06 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmp1OMAqT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:46:18 INFO - PROCESS | 1660 | RSS: Main: 243859456 05:46:18 INFO - PROCESS | 1660 | 05:46:21 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection) 05:46:22 INFO - PROCESS | 1660 | RSS: Main: 256778240 05:46:22 INFO - PROCESS | 1660 | 05:46:25 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-dft) 05:46:26 INFO - PROCESS | 1660 | RSS: Main: 265494528 05:46:26 INFO - PROCESS | 1660 | 05:46:29 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-fft) 05:46:29 INFO - PROCESS | 1660 | RSS: Main: 264908800 05:46:29 INFO - PROCESS | 1660 | 05:46:31 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator) 05:46:32 INFO - PROCESS | 1660 | RSS: Main: 266371072 05:46:32 INFO - PROCESS | 1660 | 05:46:34 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:46:35 INFO - PROCESS | 1660 | RSS: Main: 266772480 05:46:35 INFO - PROCESS | 1660 | 05:46:37 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom) 05:46:38 INFO - PROCESS | 1660 | RSS: Main: 268406784 05:46:38 INFO - PROCESS | 1660 | 05:46:41 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate) 05:46:42 INFO - PROCESS | 1660 | RSS: Main: 268341248 05:46:42 INFO - PROCESS | 1660 | 05:46:44 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial) 05:46:45 INFO - PROCESS | 1660 | RSS: Main: 268926976 05:46:45 INFO - PROCESS | 1660 | 05:46:47 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:46:47 INFO - PROCESS | 1660 | RSS: Main: 268464128 05:46:47 INFO - PROCESS | 1660 | 05:46:49 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:46:50 INFO - PROCESS | 1660 | RSS: Main: 268378112 05:46:50 INFO - PROCESS | 1660 | 05:46:52 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:46:53 INFO - PROCESS | 1660 | RSS: Main: 268652544 05:46:53 INFO - PROCESS | 1660 | 05:46:56 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:46:56 INFO - PROCESS | 1660 | RSS: Main: 268673024 05:46:56 INFO - PROCESS | 1660 | 05:46:59 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:47:00 INFO - PROCESS | 1660 | RSS: Main: 269012992 05:47:00 INFO - PROCESS | 1660 | 05:47:02 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49262/tests/kraken/driver.html?testName=ai-astar) 05:47:02 INFO - PROCESS | 1660 | RSS: Main: 270934016 05:47:02 INFO - PROCESS | 1660 | 05:47:02 INFO - PROCESS | 1660 | __start_tp_report 05:47:02 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 05:47:02 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 05:47:02 INFO - PROCESS | 1660 | |i|pagename|runs| 05:47:02 INFO - PROCESS | 1660 | |0;ai-astar;112;116;115;115;118;117;113;117;117;131 05:47:02 INFO - PROCESS | 1660 | |1;audio-beat-detection;146;113;171;178;125;149;129;112;177;141 05:47:02 INFO - PROCESS | 1660 | |2;audio-dft;196;197;205;230;196;195;197;201;234;196 05:47:02 INFO - PROCESS | 1660 | |3;audio-fft;66;81;76;141;60;59;62;63;137;73 05:47:02 INFO - PROCESS | 1660 | |4;audio-oscillator;69;72;120;73;73;87;109;70;75;111 05:47:02 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;89;85;88;85;89;86;98;133;88;86 05:47:02 INFO - PROCESS | 1660 | |6;imaging-darkroom;153;123;94;94;95;95;94;93;95;94 05:47:02 INFO - PROCESS | 1660 | |7;imaging-desaturate;100;96;92;94;95;92;90;93;92;93 05:47:02 INFO - PROCESS | 1660 | |8;json-parse-financial;56;57;57;58;57;58;50;53;55;55 05:47:02 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;65;71;76;71;87;72;71;71;71;74 05:47:02 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;93;91;90;89;89;82;82;111;84;87 05:47:02 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;140;141;139;155;141;153;161;149;191;162 05:47:02 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;228;218;173;179;176;174;178;177;175;177 05:47:02 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;69;70;67;69;71;68;72;69;68;70 05:47:02 INFO - PROCESS | 1660 | __end_tp_report 05:47:02 INFO - PROCESS | 1660 | __start_cc_report 05:47:02 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,945 05:47:02 INFO - PROCESS | 1660 | __end_cc_report 05:47:02 INFO - PROCESS | 1660 | __startTimestamp1472474822285__endTimestamp 05:47:02 INFO - PROCESS | 1660 | 05:47:02 INFO - PROCESS | 1660 | ------- Summary: start ------- 05:47:02 INFO - PROCESS | 1660 | Number of tests: 14 05:47:02 INFO - PROCESS | 1660 | 05:47:02 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:117.10 Median:117.00 stddev:5.24 (4.5%) stddev-sans-first:5.22 05:47:02 INFO - PROCESS | 1660 | Values: 112.0 116.0 115.0 115.0 118.0 117.0 113.0 117.0 117.0 131.0 05:47:02 INFO - PROCESS | 1660 | 05:47:02 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:147.50 stddev:24.91 (16.9%) stddev-sans-first:26.41 05:47:02 INFO - PROCESS | 1660 | Values: 146.0 113.0 171.0 178.0 125.0 149.0 129.0 112.0 177.0 141.0 05:47:02 INFO - PROCESS | 1660 | 05:47:02 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:204.70 Median:199.00 stddev:14.73 (7.4%) stddev-sans-first:15.28 05:47:02 INFO - PROCESS | 1660 | Values: 196.0 197.0 205.0 230.0 196.0 195.0 197.0 201.0 234.0 196.0 05:47:02 INFO - PROCESS | 1660 | 05:47:02 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:81.80 Median:64.50 stddev:31.01 (48.1%) stddev-sans-first:32.36 05:47:02 INFO - PROCESS | 1660 | Values: 66.0 81.0 76.0 141.0 60.0 59.0 62.0 63.0 137.0 73.0 05:47:02 INFO - PROCESS | 1660 | 05:47:02 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:85.90 Median:72.50 stddev:19.75 (27.2%) stddev-sans-first:19.98 05:47:02 INFO - PROCESS | 1660 | Values: 69.0 72.0 120.0 73.0 73.0 87.0 109.0 70.0 75.0 111.0 05:47:02 INFO - PROCESS | 1660 | 05:47:02 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:92.70 Median:88.00 stddev:14.65 (16.6%) stddev-sans-first:15.48 05:47:02 INFO - PROCESS | 1660 | Values: 89.0 85.0 88.0 85.0 89.0 86.0 98.0 133.0 88.0 86.0 05:47:02 INFO - PROCESS | 1660 | 05:47:02 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:103.00 Median:94.00 stddev:19.77 (21.0%) stddev-sans-first:9.61 05:47:02 INFO - PROCESS | 1660 | Values: 153.0 123.0 94.0 94.0 95.0 95.0 94.0 93.0 95.0 94.0 05:47:02 INFO - PROCESS | 1660 | 05:47:02 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:93.00 stddev:2.79 (3.0%) stddev-sans-first:1.80 05:47:02 INFO - PROCESS | 1660 | Values: 100.0 96.0 92.0 94.0 95.0 92.0 90.0 93.0 92.0 93.0 05:47:02 INFO - PROCESS | 1660 | 05:47:02 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:57.00 stddev:2.50 (4.4%) stddev-sans-first:2.65 05:47:02 INFO - PROCESS | 1660 | Values: 56.0 57.0 57.0 58.0 57.0 58.0 50.0 53.0 55.0 55.0 05:47:02 INFO - PROCESS | 1660 | 05:47:02 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:72.90 Median:71.50 stddev:5.69 (8.0%) stddev-sans-first:5.26 05:47:02 INFO - PROCESS | 1660 | Values: 65.0 71.0 76.0 71.0 87.0 72.0 71.0 71.0 71.0 74.0 05:47:02 INFO - PROCESS | 1660 | 05:47:02 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:89.80 Median:89.00 stddev:8.34 (9.4%) stddev-sans-first:8.76 05:47:02 INFO - PROCESS | 1660 | Values: 93.0 91.0 90.0 89.0 89.0 82.0 82.0 111.0 84.0 87.0 05:47:02 INFO - PROCESS | 1660 | 05:47:02 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:153.20 Median:154.00 stddev:15.85 (10.3%) stddev-sans-first:16.08 05:47:02 INFO - PROCESS | 1660 | Values: 140.0 141.0 139.0 155.0 141.0 153.0 161.0 149.0 191.0 162.0 05:47:02 INFO - PROCESS | 1660 | 05:47:02 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.50 Median:177.50 stddev:19.98 (11.3%) stddev-sans-first:14.09 05:47:02 INFO - PROCESS | 1660 | Values: 228.0 218.0 173.0 179.0 176.0 174.0 178.0 177.0 175.0 177.0 05:47:02 INFO - PROCESS | 1660 | 05:47:02 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:1.49 (2.2%) stddev-sans-first:1.58 05:47:02 INFO - PROCESS | 1660 | Values: 69.0 70.0 67.0 69.0 71.0 68.0 72.0 69.0 68.0 70.0 05:47:02 INFO - PROCESS | 1660 | -------- Summary: end -------- 05:47:02 INFO - PROCESS | 1660 | 05:47:03 INFO - TEST-INFO | 1660: exit 0 05:47:03 INFO - TEST-OK | kraken | took 59602ms 05:47:03 INFO - SUITE-END | took 1173s 05:47:03 INFO - Completed test suite (00:19:34) 05:47:03 INFO - javascript benchmark 05:47:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7426.2942324041505, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2808.508511010574, 2858.6426696662916, 3412.385770561298, 3444.259484210895, 3485.9825700871493, 4934.481879402665, 5396.64921780084, 5638.548916086714, 5833.824985250444, 5885.823425297237, 5750.137479378095, 5752.28096487939, 5769.3076830780265, 5802.39074897136, 5869.677167755783, 5155.9484405155845, 5178.145605975019, 5265.341832270966, 5352.0, 5359.598030147735, 5104.285400043997, 5157.638965272433, 5202.895942081156, 5313.3092697949405, 5319.255304257407, 5247.527722504955, 5259.684418934857, 5259.710715910662, 5263.26314315996, 5306.8407947761625, 5287.339082614673, 5292.576593872481, 5308.734563271821, 5323.733813309319, 5367.704776237305, 5163.251328557376, 5247.606429517801, 5270.288511051036, 5290.761915713802, 5316.0, 5688.914666280009, 5768.596198266123, 5773.740181691834, 5774.422557744234, 5840.678762668052, 6205.317415084337, 6249.218847644044, 6283.7800676976085, 6312.905306420407, 6314.62112273265, 6174.969125154345, 6184.6907654617535, 6245.18812554365, 6251.249850018027, 6257.780977665805, 5943.197668314765, 5955.225820643289, 5966.31387390447, 5972.402759723993, 6015.939840601582, 6352.587081839665, 6381.840453988594, 6391.105245265667, 6414.679266036773, 6422.261439934374, 6072.332043475214, 6096.677875983229, 6159.876802463926, 6161.507079433634, 6211.2857021442205, 6259.0924315973925, 6275.780347687809, 6278.6546739929745, 6281.3404592518045, 6299.937000630027, 6225.595336303126, 6240.906386404207, 6273.686315684197, 6309.558330916883, 6329.430351268408, 6091.994469032087, 6174.691265436711, 6176.598521096204, 6277.78027769035, 6287.46556542699, 4224.408582798411, 5012.1980483122525, 5037.420696619863, 5040.7731652075745, 5079.5428411443145, 4515.277555591156, 4515.390422292949, 4517.728936263835, 4530.546945305509, 4536.546345365503, 5157.174852023658, 5609.326880774333, 5766.250387449605, 5775.133729940459, 5906.852328691817, 6117.2184870185665, 6167.136600875881, 6197.349278325711, 6260.843478912972, 6265.96867015662, 5748.367679555246, 5748.770049198069, 5749.8562535936935, 5758.74085666146, 5763.193152958589, 5158.948410515922, 5181.015607034651, 5364.90019546, 5408.350997880201, 5446.91829622556, 6308.3060863305, 6331.651759153291, 6351.714172862232, 6428.035794630843, 6443.194600674916, 6208.410201030895, 6275.215598050244, 6279.560430769802, 6292.465140463112, 6299.275583307978, 5419.9431110934565, 5655.236543066633, 6195.566310358232, 6437.839054023687, 6452.032195170762, 6239.376062393724, 6241.625502469867, 6242.500599951902, 6303.558750887577, 6312.7159277833525, 6274.968625156845, 6276.686165691788, 6280.968595157177, 6281.654509001866, 6299.748010079546, 6059.212302400836, 6121.696863452088, 6160.722767475385, 6203.658798766111, 6248.12526246335, 6116.724747386289, 6129.664444256008, 6222.62664240147, 6223.37766223374, 6225.657588832658, 5953.345132035559, 5997.610155339889, 6075.68429974569, 6077.908831367445, 6133.539984501091, 6045.78839740607, 6092.360302168208, 6142.222533141996, 6232.407921247474, 6242.719077641426, 6050.878982420239, 6068.787592434243, 6098.9390106100145, 6114.847128821815, 6117.143599895929], "value": 5728.342608653817, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.6540692590946, 530.075019091685, 536.2787051415845, 537.100356902189, 571.345809048639, 37115.62884371156, 39452.0, 39492.60507394925, 39508.01229969252, 39510.80244598776, 40334.19331613366, 40928.0, 40950.79524602373, 41015.589844101625, 41059.58940410595, 9606.855897161531, 9828.017198280151, 9829.557669904836, 9835.11483966443, 9842.950785246063, 9707.805843883118, 9796.804063918717, 9812.901870981306, 9825.312228144032, 9828.312018158731, 9783.168430683365, 9831.852522212173, 9850.950745246264, 9856.359336643096, 9859.507024648774, 9764.316497845119, 9765.462899540522, 9809.068138526829, 9836.3606365586, 9873.506324683809, 8307.83384332316, 9695.466749328783, 9742.902570974271, 9765.414075155513, 9770.169535589412, 32394.6760532394, 38857.834264972094, 39089.21821563553, 39367.0, 39442.60557394418, 3269.6893795089427, 3303.6696330367013, 3404.2553191489314, 3462.290230502741, 3943.4873466449467, 23381.0, 30474.54288185679, 30946.226344341347, 30949.381012379625, 31211.687883121107, 3089.3049063960652, 3253.349330133959, 3307.470804671265, 3310.420676381648, 3319.286353434023, 472601.0, 478889.9999999965, 479406.0, 480032.0, 480446.0, 55385.44614553884, 55683.72158139183, 55704.0, 55710.0, 55817.72091139518, 56829.71585142048, 57425.42574574285, 57576.13635795467, 57598.71200644054, 57742.133867992015, 16048.277827497557, 16137.354505819636, 16225.0, 16293.837061629469, 16294.674106517803, 12722.918551923005, 12809.807852882213, 12850.357482125857, 12852.357382130856, 12872.678183045498, 9556.617735290649, 13041.804372934414, 15065.322060507304, 15344.616384590252, 15366.157260906544, 5525.972370138124, 6444.0, 6549.312322206195, 6552.213734351908, 6592.9340706593275, 699.909011828459, 796.8127490039836, 822.2805045585113, 924.2393240876141, 956.9377990430739, 23827.7617223829, 29234.0, 29370.853145734134, 30001.549976750368, 30151.396972060436, 1019.0980981831133, 1031.5925209542188, 1077.175960390302, 1094.6332978452149, 1103.9834402483968, 13471.797923031163, 14831.77752333716, 14866.702665946837, 15111.773323400157, 15168.0, 666181.0, 669835.0, 673809.0, 675054.624726883, 676794.0, 52757.47242527602, 52794.47205527896, 52988.470115299126, 53153.46846531562, 53252.0, 1343.7581235377727, 1363.2297751770218, 1389.6803735140975, 1400.7758758598575, 1402.6914078902626, 26257.606135907594, 28519.28701782472, 28775.0, 29874.0, 30194.9431769887, 46431.53568464407, 51847.22229166641, 53200.0, 53368.0, 56078.158827618434, 478843.0, 481601.0, 482020.0, 482118.0, 482813.0, 25271.851892589337, 25372.0, 25626.743732562434, 25665.893457046783, 25762.35594110162, 42025.579744202165, 42657.0, 45531.77234113808, 46235.53764462447, 47414.0, 38387.424188636636, 38412.0, 38783.0, 39316.0, 39873.60126398699, 37485.25029499449, 37512.43731344087, 37603.81198094101, 38880.0, 38933.415998759476, 32952.0, 37263.62736372602, 37342.62657373391, 37768.0, 38295.80852095722, 30201.546976795806, 33936.490952635235, 34061.31877362489, 34177.48733769045, 34278.82860585681, 24946.50106997886, 25326.0, 25679.409952088696, 25687.486250274516, 26100.608490873034], "value": 19272.749511254275, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.66015683532294, 368.88564544991056, 370.5479315235412, 382.8755654412317, 407.3279089502321, 17681.91159044203, 20252.69620955685, 20290.59418811623, 21015.47461313468, 21244.256451024215, 16574.337026518955, 19915.60168796623, 20365.490862728402, 20807.583848323025, 20962.580748385022, 5480.232767412565, 5618.325800903876, 5625.40933202014, 5638.718064096799, 5928.940710592904, 6038.577299589008, 6173.938260617404, 6185.876282474348, 6186.257649082117, 6194.0, 5954.047352423613, 6028.788992385267, 6054.576179667425, 6091.725872335755, 6094.3905609438925, 5946.732397042122, 6092.878142437171, 6144.815655530341, 6172.382761723837, 6172.814815555541, 5388.299521062276, 7228.241034691387, 7634.198409167013, 7699.499532530368, 7775.533467991939, 28232.576511352345, 28650.283742906384, 28847.71152288471, 29147.0, 29662.70337296621, 2394.1022116706235, 2702.594610808375, 2822.463731890934, 2832.745052945245, 2989.327401334704, 14498.565043048726, 14861.443381180266, 16263.430779922764, 17418.78068535203, 17754.733678994697, 1673.916304184786, 1778.5642517583276, 1803.431918945528, 2146.2380854796634, 2148.3769706785015, 105112.47443762809, 109429.90570094356, 109481.45259273732, 140161.0, 147456.2627186868, 15842.28709708066, 18668.0, 19305.227790888206, 20985.79014209869, 21126.788732112484, 34654.133646658534, 34852.78015269453, 35351.0, 35437.46843797345, 35525.644743552235, 10461.529231184615, 10468.469872944188, 11020.834687479693, 11037.448127593589, 11096.0, 8588.484690918565, 9017.954910225408, 9121.224695900923, 9171.81656366869, 9276.489793061312, 9529.761755956157, 9583.281253905845, 9601.32790704658, 9749.658761943298, 9846.409215446953, 2921.0214578116143, 3649.7810131392202, 3753.1930634913624, 3822.7334235453004, 3871.9806400967814, 861.8965724113147, 873.5021038008274, 876.8684697295457, 1013.4020927652721, 1036.7926414717087, 20435.0, 20804.0, 21006.684899726515, 21028.158873644883, 21074.47313817136, 933.4352716606492, 938.1424778937742, 950.6054987180243, 956.9473678947586, 967.8016006718606, 10400.27198096126, 11083.0, 11085.390303533382, 11089.500972456259, 11167.888321116685, 587226.0, 587280.0, 590696.0, 601100.0, 601955.0, 96764.0, 107345.70617175382, 126431.3678431602, 128512.0, 130534.0, 874.5452364770284, 959.1271942532262, 966.9129778319985, 968.9854652180223, 969.2004096620317, 18103.366382176562, 19119.426417207505, 19128.330508432136, 19142.904285478482, 19482.902585486983, 52534.73732631465, 52861.0, 53675.0, 54150.72924635352, 54172.749635022024, 76141.57362918793, 76179.61910190413, 76962.23037769551, 77980.83028754687, 78520.21479785358, 8043.356531477585, 8129.552874591955, 8289.585520723818, 8331.250187483156, 8515.74452766418, 11090.336449532311, 12894.871051289367, 13098.476060957455, 13128.737425251633, 13176.275304858325, 9456.716298511055, 11080.0, 11157.442127893735, 11339.036181924628, 11393.202475826612, 10335.793284134124, 10927.289726168092, 10938.726531836768, 11043.558257669603, 11402.429878506207, 11310.0, 11354.091672666333, 11565.421728913689, 11688.357140357022, 11740.236884602473, 8063.314618257514, 8229.423940324119, 8232.259096681328, 8334.416590838584, 8481.109483504144, 8243.451846189726, 10821.25796376627, 11110.0, 11437.0, 11645.301281923112], "value": 10725.998702721672, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1312.9015323850713, 1498.1610298232988, 1593.984060159398, 1661.9861884250604, 1854.3046357615895, 7818.218178182179, 8317.708880189195, 8413.957930210341, 8836.718675792014, 8854.0, 8463.19599638035, 8651.178138076888, 8653.048164701877, 8653.653853845839, 8704.43421177623, 2359.3865594945264, 2372.0986025310444, 2379.4646204603914, 2386.9283921482297, 2389.223502361731, 2335.8832058397097, 2362.3621622162004, 2391.3782416571644, 2394.1381102802975, 2396.8681722505257, 2357.35172827473, 2366.514864452783, 2379.762023797624, 2380.976190238093, 2388.0567175965484, 2336.2523992322463, 2351.5061837014246, 2352.0356653771955, 2362.102401087593, 2364.267077206063, 2304.2626359564947, 2319.3621754017613, 2321.1991862807304, 2322.5935461294375, 2323.0011095229047, 8674.089220631806, 8675.826483470295, 8723.956380218122, 8762.605682744292, 8766.780830479225, 5156.226566015091, 5316.760745766411, 5320.308359913187, 5320.866978325535, 5329.440408757064, 3553.822308884571, 3591.44332628443, 3609.0, 3655.323765103464, 3662.5788034375855, 1022.2588623248085, 1025.2157099818571, 1040.9583616655325, 1042.1194090993174, 1049.1344640671477, 11215.439228038647, 11268.492917818636, 11374.545018199262, 11381.430928453545, 11384.487698053608, 3788.8484460621817, 3985.8405663773706, 3989.0, 4512.5261847505535, 4791.880202994953, 9768.36505627132, 9813.0, 9827.803443931081, 9840.753981150385, 9850.655227067018, 5296.602754793406, 5307.230451584499, 5328.573714102862, 5328.813491527778, 5344.144936810092, 4360.389545463638, 4723.740194289278, 4843.539863712942, 4883.853484395474, 4888.926666100011, 3821.694264458892, 3880.3985382265796, 3932.7050471214775, 3970.7021973352116, 3982.880513584597, 1276.5659675710117, 1282.5767496726244, 1291.9870801291868, 1292.8901043411415, 1298.9870101299055, 816.2816721285232, 823.4812068396872, 873.9038705742363, 925.7824411263348, 938.7183844846655, 5926.111083337534, 5964.940350596526, 6014.609050411709, 6083.604565703304, 6252.280987686474, 885.4156256870434, 906.3474298505066, 910.6539514984264, 914.7895983923735, 928.972130836076, 3943.3099207638547, 3945.4279129526058, 3960.7029472789654, 4000.3599424092004, 4155.58444155588, 10316.535755891004, 10569.418681972566, 10665.41340226295, 10675.733106672395, 10678.786424271471, 10583.206259530412, 10607.787844243072, 10612.151027917902, 10612.522436490377, 10624.0, 8093.109757926623, 8187.795305117301, 8209.8358032839, 8216.507009579444, 8249.546274954815, 4953.504649535162, 5532.589189756586, 5610.7194640268635, 5949.2266005419015, 6017.338092809875, 9824.4105353679, 9844.803103937738, 9919.603215871284, 9972.401655900669, 10007.699769006942, 7839.176886426843, 9616.182624476998, 9744.635750994725, 10082.798344033225, 10146.79706405853, 5617.354004289396, 6443.355664433519, 6784.253732089367, 6882.896756548756, 7037.648117593997, 6417.26201486835, 7740.684083705671, 8378.748637540639, 8447.070822209429, 8473.110323416198, 6403.6798160090875, 7311.0, 7439.330460258603, 7475.327220550176, 7543.849123017619, 7106.147262328347, 7225.349718525358, 7366.300201480851, 7413.629318533944, 7468.066491688539, 6838.8290292741085, 6871.14110736158, 6931.306869313028, 6939.826504337432, 6986.6855991481525, 4266.65866730667, 4945.307656928105, 4972.577330926912, 5028.421731500778, 5031.245313202902, 4882.36529251195, 4886.755662216946, 4897.191963326011, 5004.574611158092, 5040.84877453677], "value": 4515.189624623331, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [250.8582650802297, 264.4050885507608, 301.76613124828253, 314.05939212059883, 315.9383920135572, 4691.648126390517, 5144.202648589465, 5483.8080667176655, 5567.276254086968, 5681.37504874464, 5591.888162236753, 5595.608307418483, 5599.972000139994, 5615.578831587627, 5674.602777805555, 3871.8838434847, 4254.0, 4266.381374700666, 4284.250256205167, 4295.656347492209, 3710.424884142962, 3724.9942515520793, 3731.8880433587037, 4196.748195108304, 4215.262329092412, 4157.729747566414, 4162.646175075107, 4162.875113746592, 4166.10428757817, 4167.187398457302, 3852.1109168123908, 4209.852655157055, 4241.787910604488, 4253.638440732557, 4262.424572682679, 3071.2014876132143, 3628.909277268063, 3639.344917914774, 3696.464012718141, 3720.3675375186285, 4894.241392584155, 5081.189108168874, 5372.328458942632, 5400.567954563626, 5412.404635490093, 4821.4696383397795, 4830.637702172351, 4882.731449770261, 4901.1177987962155, 4937.407511098655, 5508.9724551377385, 5873.735681894283, 5942.316633587149, 5963.717800672833, 6045.909311360333, 3868.6324799144036, 3970.940435893464, 4010.278149933011, 4014.2172276406113, 4017.9397309040387, 5080.120355468501, 5126.641135120543, 5819.0, 6244.908770158755, 6373.5857169283845, 4058.857939972087, 4065.308897487375, 4087.46862907826, 4125.071858831739, 4131.905045163035, 3462.601800792941, 3605.6214097519905, 4112.485939257593, 4122.6083522065355, 4124.587541245852, 4464.906098005944, 4481.932771008437, 4767.904641907143, 4790.125924445305, 4875.146849301358, 5164.302819119371, 5539.612227144142, 5913.7876735269165, 5984.132300816357, 6110.755569777248, 1109.4951796932376, 1202.5430336472084, 1252.2861968677948, 1407.8451370349253, 1430.885529157665, 749.9812504687427, 853.8804567360575, 880.6257340630207, 886.3175354976761, 886.7629656629096, 4109.2808758467145, 4357.302831546937, 4576.368588061878, 4693.436787585511, 4790.784414701347, 5079.492050794965, 5109.897802044013, 5160.741962901915, 5212.40057393397, 5220.190870415092, 4061.5126184858004, 4258.0, 4301.461957634725, 4376.803043863034, 4678.672492925531, 2272.704548408696, 2359.4809141988735, 2422.8909699063584, 2423.9272821815375, 2712.620233167358, 4616.4765627342895, 5082.339295891585, 5200.037992971313, 5284.5772338212855, 5366.302380690563, 4743.865260632729, 5117.108833509055, 5128.871388453041, 5170.0, 5233.83353071394, 4383.649308055348, 4937.358143441402, 5094.261332106824, 5254.97372513135, 5306.867328316823, 4577.496475387638, 5085.093090091215, 5137.557836249647, 5183.0, 5188.846628649068, 5016.297718319365, 5038.647294689336, 5047.570956468741, 5108.310378099058, 5756.712164391847, 6404.551681382259, 6423.9036414452885, 6463.450606698483, 6481.319461456479, 6518.608883467007, 3099.6900309968823, 3678.50340204069, 3991.6207960243732, 4024.215278020758, 4031.2945234583244, 5145.639805213599, 5315.3621565412395, 6111.816645500642, 6232.220972378453, 6274.403931626488, 4898.779554920108, 5173.896522069613, 5392.946070539245, 5929.733162007634, 5939.940600593939, 5430.83707488776, 5489.678744359765, 5717.7712891485535, 5941.613795103304, 5972.745723398135, 5477.75350109254, 5776.7111644418455, 5818.76724931015, 5820.388859169896, 5841.795537156179, 5525.723713814374, 5570.832875013756, 5951.345352011189, 5978.133170690313, 6018.1875446815875, 4784.712917224978, 4928.654994150375, 5601.0, 5925.288965324189, 5943.732532035982], "value": 4075.785223044574, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.928507864135, 657.4575974820774, 664.7540410048283, 739.6560599321315, 791.7980914866708, 15206.923965380185, 15497.5350739478, 16049.83950160498, 16065.357385704572, 16074.758878616816, 12250.754984900297, 14775.556733297992, 14867.405303787862, 14877.0, 14892.702145957075, 855.4311382930359, 867.9132086791302, 868.6004437958546, 869.2220462685924, 870.4646642314963, 659.7954634063432, 835.5028757889046, 847.4110493207223, 847.4576271186446, 857.5497863621617, 845.327964268405, 848.0755975986174, 879.5382424227267, 890.7773056735816, 900.1043961258557, 867.0332579174207, 879.1516186879628, 888.6534251641865, 892.2148509311796, 894.5080205886736, 649.9415052645237, 656.1273506236694, 658.9275179730225, 660.2506155513479, 662.8707402056601, 14958.925205373904, 15249.923750381287, 15252.237388130548, 15254.23728813566, 15370.538883833502, 13725.45098196071, 13944.790828137586, 14168.85831141696, 14497.42010319586, 14530.854691453056, 11632.651020469399, 11658.0, 11663.825042624367, 11721.765564688743, 11781.469833857496, 3528.072086345203, 3684.3184010958057, 3742.139307959185, 3742.8877133686033, 3801.8669346573015, 97352.51323743406, 109779.0, 110032.0, 111680.0, 112506.43746781295, 10340.948295258475, 10512.474376281156, 10605.893941060645, 10711.678649640524, 10807.729806754895, 21140.260090896743, 21229.363119106452, 21255.574888502142, 21286.019957206005, 21334.893325533274, 7760.844783104306, 7907.56508392044, 7925.524468531907, 7926.48477848938, 8091.474054186577, 3841.9807900960877, 4248.745075295492, 4312.54718254585, 4333.541772126748, 4386.0, 3531.911702207414, 3659.853605855736, 3662.3957047087465, 3664.8534058637356, 3670.4677821716236, 544.2516539757833, 582.4001278682963, 621.9253689557282, 646.9385408386196, 647.2556559956088, 498.28187238613276, 563.3183847544435, 625.5058503782052, 629.3989240275525, 660.3891400454656, 8734.432261903083, 9400.48297343639, 9542.666006689733, 9581.664641737505, 9695.70912872615, 583.9737211825478, 601.1703848688782, 606.233115109387, 611.2909025530363, 638.0493065332714, 4427.313766366218, 4436.46762388509, 4452.220861349251, 4539.795709193094, 4610.561996610317, 102153.0, 147630.0, 151896.2405187989, 162412.0, 170092.0, 137763.0, 139394.30302848623, 142424.28787856203, 143261.28369358086, 143848.28075859553, 123980.76019239872, 125791.74208257983, 128826.35586822193, 129361.99999999812, 130037.04944425842, 8988.595513201792, 9021.503817290111, 9048.683296084606, 9064.138906803842, 9187.402818817023, 44234.55765442304, 57511.71244143753, 58273.0863456834, 58991.41008589859, 62992.68503657453, 65143.0, 86886.13113869034, 87025.0, 87734.56132719296, 96091.0, 11771.999380052792, 11946.76106477883, 12516.812247816471, 12878.806817897927, 13075.476980920657, 14403.0, 14744.336504857522, 14777.778333325225, 14793.704125917206, 15309.617259568155, 11815.704607384883, 12289.0, 12965.962722982327, 13333.799993000306, 14277.714445711235, 10501.30292834397, 13154.276514791778, 13449.924446976951, 13474.124181928144, 13499.257540835348, 13269.933650331686, 13366.131201471873, 13404.195748255135, 13413.932930335286, 13577.456901723821, 10904.0, 10976.945115274373, 11367.715807104558, 11562.364069976233, 11789.469473873867, 7813.882791758015, 9587.376820506644, 11280.717982050515, 11541.480633371686, 11559.017483513995], "value": 7696.40859215836, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1549.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 115.0, 115.0, 118.0, 117.0, 113.0, 117.0, 117.0, 131.0], "value": 117.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 113.0, 171.0, 178.0, 125.0, 149.0, 129.0, 112.0, 177.0, 141.0], "value": 144.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 197.0, 205.0, 230.0, 196.0, 195.0, 197.0, 201.0, 234.0, 196.0], "value": 204.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 81.0, 76.0, 141.0, 60.0, 59.0, 62.0, 63.0, 137.0, 73.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 120.0, 73.0, 73.0, 87.0, 109.0, 70.0, 75.0, 111.0], "value": 85.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 88.0, 85.0, 89.0, 86.0, 98.0, 133.0, 88.0, 86.0], "value": 92.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 123.0, 94.0, 94.0, 95.0, 95.0, 94.0, 93.0, 95.0, 94.0], "value": 103.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 96.0, 92.0, 94.0, 95.0, 92.0, 90.0, 93.0, 92.0, 93.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 58.0, 57.0, 58.0, 50.0, 53.0, 55.0, 55.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 76.0, 71.0, 87.0, 72.0, 71.0, 71.0, 71.0, 74.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 90.0, 89.0, 89.0, 82.0, 82.0, 111.0, 84.0, 87.0], "value": 89.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 141.0, 139.0, 155.0, 141.0, 153.0, 161.0, 149.0, 191.0, 162.0], "value": 153.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [228.0, 218.0, 173.0, 179.0, 176.0, 174.0, 178.0, 177.0, 175.0, 177.0], "value": 185.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 67.0, 69.0, 71.0, 68.0, 72.0, 69.0, 68.0, 70.0], "value": 69.3, "unit": "score"}]}]} 05:47:03 INFO - Return code: 0 05:47:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:47:03 ERROR - # TBPL SUCCESS # 05:47:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:47:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:47:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:47:03 INFO - 2016-08-29 05:47:03.620 screenresolution[1665:11031] starting screenresolution argv=screenresolution get 05:47:03 INFO - 2016-08-29 05:47:03.623 screenresolution[1665:11031] Display 0: 1600x1200x32@60 05:47:03 INFO - 2016-08-29 05:47:03.629 screenresolution[1666:11035] starting screenresolution argv=screenresolution list 05:47:03 INFO - Available Modes on Display 0 05:47:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:47:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:47:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:47:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:47:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:47:03 INFO - Intel Iris: 05:47:03 INFO - Chipset Model: Intel Iris 05:47:03 INFO - Type: GPU 05:47:03 INFO - Bus: Built-In 05:47:03 INFO - VRAM (Dynamic, Max): 1536 MB 05:47:03 INFO - Vendor: Intel (0x8086) 05:47:03 INFO - Device ID: 0x0a2e 05:47:03 INFO - Revision ID: 0x0009 05:47:03 INFO - Displays: 05:47:03 INFO - Display: 05:47:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:47:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:47:03 INFO - Display Serial Number: 1600x1200 60 05:47:03 INFO - Main Display: Yes 05:47:03 INFO - Mirror: Off 05:47:03 INFO - Online: Yes 05:47:03 INFO - Rotation: Supported 05:47:03 INFO - Return code: 0 05:47:03 INFO - Running post-action listener: _resource_record_post_action 05:47:03 INFO - [mozharness: 2016-08-29 12:47:03.864526Z] Finished run-tests step (success) 05:47:03 INFO - Running post-run listener: _resource_record_post_run 05:47:03 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 37950464; Write bytes: 708411392; Read time: 393; Write time: 1937 05:47:03 INFO - TinderboxPrint: CPU usage
54.6% 05:47:03 INFO - TinderboxPrint: I/O read bytes / time
37,950,464 / 393 05:47:03 INFO - TinderboxPrint: I/O write bytes / time
708,411,392 / 1,937 05:47:03 INFO - TinderboxPrint: CPU idle
2,197.3 (45.4%) 05:47:03 INFO - TinderboxPrint: CPU system
974.2 (20.1%) 05:47:03 INFO - TinderboxPrint: CPU user
1,666.1 (34.4%) 05:47:03 INFO - TinderboxPrint: Swap in / out
443,916,288 / 0 05:47:03 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 408185344; Write bytes: 396629504; Read time: 29850; Write time: 746 05:47:03 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 30657536; Write bytes: 297028096; Read time: 305; Write time: 1153 05:47:04 INFO - Running post-run listener: _upload_blobber_files 05:47:04 INFO - Blob upload gear active. 05:47:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:47:04 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 05:47:04 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'] 05:47:04 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 05:47:04 INFO - Traceback (most recent call last): 05:47:04 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 05:47:04 INFO - main() 05:47:04 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 05:47:04 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 05:47:04 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 05:47:04 INFO - return set(response.json().get('whitelist', [])) 05:47:04 INFO - File "/builds/slave/test/build/venv/lib/python2.7/site-packages/requests/models.py", line 651, in json 05:47:04 INFO - return json.loads(self.text or self.content, **kwargs) 05:47:04 INFO - File "/tools/python27/lib/python2.7/json/__init__.py", line 326, in loads 05:47:04 INFO - return _default_decoder.decode(s) 05:47:04 INFO - File "/tools/python27/lib/python2.7/json/decoder.py", line 366, in decode 05:47:04 INFO - obj, end = self.raw_decode(s, idx=_w(s, 0).end()) 05:47:04 INFO - File "/tools/python27/lib/python2.7/json/decoder.py", line 384, in raw_decode 05:47:04 INFO - raise ValueError("No JSON object could be decoded") 05:47:04 INFO - ValueError: No JSON object could be decoded 05:47:04 ERROR - Return code: 1 05:47:04 INFO - Setting buildbot property blobber_files to {} 05:47:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:47:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:47:04 INFO - Contents: 05:47:04 INFO - blobber_files:{} 05:47:04 INFO - Running post-run listener: copy_logs_to_upload_dir 05:47:04 INFO - Copying logs to upload dir... 05:47:04 INFO - mkdir: /builds/slave/test/build/upload/logs 05:47:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.665843 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-08-29 05:47:04.819485) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 05:47:04.822928) ========= 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.rRmArETzdm/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.Zo0hpWi88s/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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/LTsN5JAOSeC6a7s-TA096w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011034 build_url: 'https://queue.taskcluster.net/v1/task/LTsN5JAOSeC6a7s-TA096w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 05:47:04.856129) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 05:47:04.856449) ========= 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.rRmArETzdm/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.Zo0hpWi88s/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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.004998 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 05:47:04.904974) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 05:47:04.905263) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 05:47:04.905585) ========= ========= Total master_lag: 7.29 =========