builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0202 starttime: 1467770592.21 results: success (0) buildid: 20160705170424 builduid: 15baf74a70c34fc59c421a8f7cb4e6de revision: a22de7d60df7690ea67b4b7573af8f0602c422b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 19:03:12.212878) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 19:03:12.213287) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 19:03:12.213588) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 19:03:12.237913) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 19:03:12.238267) ========= 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.v6IenCXnv0/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.Mdr3GC3Yx4/Listeners TMPDIR=/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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-07-05 19:03:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 39.8M=0s 2016-07-05 19:03:12 (39.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.645152 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 19:03:12.908968) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 19:03:12.909261) ========= 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.v6IenCXnv0/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.Mdr3GC3Yx4/Listeners TMPDIR=/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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.025946 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 19:03:12.957337) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 19:03:12.957678) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a22de7d60df7690ea67b4b7573af8f0602c422b1 --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 a22de7d60df7690ea67b4b7573af8f0602c422b1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.v6IenCXnv0/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.Mdr3GC3Yx4/Listeners TMPDIR=/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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-07-05 19:03:13,038 truncating revision to first 12 chars 2016-07-05 19:03:13,038 Setting DEBUG logging. 2016-07-05 19:03:13,038 attempt 1/10 2016-07-05 19:03:13,038 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a22de7d60df7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 19:03:14,115 unpacking tar archive at: mozilla-central-a22de7d60df7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.361589 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 19:03:14.340348) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 19:03:14.340673) ========= script_repo_revision: a22de7d60df7690ea67b4b7573af8f0602c422b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 19:03:14.341068) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 19:03:14.341331) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 19:03:14.359780) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 6 secs) (at 2016-07-05 19:03:14.360137) ========= /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.v6IenCXnv0/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.Mdr3GC3Yx4/Listeners TMPDIR=/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 19:03:14 INFO - MultiFileLogger online at 20160705 19:03:14 in /builds/slave/test 19:03:14 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 19:03:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:03:14 INFO - {'append_to_log': False, 19:03:14 INFO - 'base_work_dir': '/builds/slave/test', 19:03:14 INFO - 'blob_upload_branch': 'Firefox', 19:03:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:03:14 INFO - 'branch': 'Firefox', 19:03:14 INFO - 'buildbot_json_path': 'buildprops.json', 19:03:14 INFO - 'config_files': ('talos/mac_config.py',), 19:03:14 INFO - 'default_actions': ('clobber', 19:03:14 INFO - 'read-buildbot-config', 19:03:14 INFO - 'download-and-extract', 19:03:14 INFO - 'populate-webroot', 19:03:14 INFO - 'create-virtualenv', 19:03:14 INFO - 'install', 19:03:14 INFO - 'run-tests'), 19:03:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:03:14 INFO - 'download_minidump_stackwalk': True, 19:03:14 INFO - 'download_symbols': 'ondemand', 19:03:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:03:14 INFO - 'tooltool.py': '/tools/tooltool.py', 19:03:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:03:14 INFO - '/tools/misc-python/virtualenv.py')}, 19:03:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:03:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:03:14 INFO - 'installer_path': 'installer.exe', 19:03:14 INFO - 'log_level': 'info', 19:03:14 INFO - 'log_name': 'talos', 19:03:14 INFO - 'log_to_console': True, 19:03:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:03:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:03:14 INFO - 'opt_config_files': (), 19:03:14 INFO - 'pip_index': False, 19:03:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:03:14 INFO - 'cmd': ('bash', 19:03:14 INFO - '-c', 19:03:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:03:14 INFO - 'enabled': True, 19:03:14 INFO - 'halt_on_failure': False, 19:03:14 INFO - 'name': 'check_screen_resolution'},), 19:03:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:03:14 INFO - 'cmd': ('bash', 19:03:14 INFO - '-c', 19:03:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:03:14 INFO - 'enabled': True, 19:03:14 INFO - 'halt_on_failure': False, 19:03:14 INFO - 'name': 'check_screen_resolution'},), 19:03:14 INFO - 'run_cmd_checks_enabled': True, 19:03:14 INFO - 'sps_profile': False, 19:03:14 INFO - 'sps_profile_interval': 0, 19:03:14 INFO - 'suite': 'dromaeojs-e10s', 19:03:14 INFO - 'system_bits': '32', 19:03:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:03:14 INFO - 'title': 't-yosemite-r7-0202', 19:03:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:03:14 INFO - 'use_talos_json': True, 19:03:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:03:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:03:14 INFO - 'work_dir': 'build'} 19:03:14 INFO - ##### 19:03:14 INFO - ##### Running clobber step. 19:03:14 INFO - ##### 19:03:14 INFO - Running pre-action listener: _resource_record_pre_action 19:03:14 INFO - Running main action method: clobber 19:03:14 INFO - rmtree: /builds/slave/test/build 19:03:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:03:16 INFO - Running post-action listener: _resource_record_post_action 19:03:16 INFO - ##### 19:03:16 INFO - ##### Finished clobber step (success) 19:03:16 INFO - ##### 19:03:16 INFO - ##### 19:03:16 INFO - ##### Running read-buildbot-config step. 19:03:16 INFO - ##### 19:03:16 INFO - Running pre-action listener: _resource_record_pre_action 19:03:16 INFO - Running main action method: read_buildbot_config 19:03:16 INFO - Using buildbot properties: 19:03:16 INFO - { 19:03:16 INFO - "project": "", 19:03:16 INFO - "product": "firefox", 19:03:16 INFO - "script_repo_revision": "production", 19:03:16 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 19:03:16 INFO - "repository": "", 19:03:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 19:03:16 INFO - "buildid": "20160705170424", 19:03:16 INFO - "pgo_build": "False", 19:03:16 INFO - "basedir": "/builds/slave/test", 19:03:16 INFO - "buildnumber": 3, 19:03:16 INFO - "slavename": "t-yosemite-r7-0202", 19:03:16 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 19:03:16 INFO - "platform": "yosemite_r7", 19:03:16 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:03:16 INFO - "branch": "mozilla-central", 19:03:16 INFO - "repo_path": "mozilla-central", 19:03:16 INFO - "revision": "a22de7d60df7690ea67b4b7573af8f0602c422b1", 19:03:16 INFO - "stage_platform": "macosx64", 19:03:16 INFO - "builduid": "15baf74a70c34fc59c421a8f7cb4e6de", 19:03:16 INFO - "slavebuilddir": "test" 19:03:16 INFO - } 19:03:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 19:03:16 INFO - Running post-action listener: _resource_record_post_action 19:03:16 INFO - ##### 19:03:16 INFO - ##### Finished read-buildbot-config step (success) 19:03:16 INFO - ##### 19:03:16 INFO - ##### 19:03:16 INFO - ##### Running download-and-extract step. 19:03:16 INFO - ##### 19:03:16 INFO - Running pre-action listener: _resource_record_pre_action 19:03:16 INFO - Running main action method: download_and_extract 19:03:16 INFO - mkdir: /builds/slave/test/build/tests 19:03:16 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:16 INFO - https://queue.taskcluster.net/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 19:03:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 19:03:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 19:03:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 19:03:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 19:03:46 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json: timed out 19:03:46 INFO - retry: attempt #1 caught exception: timed out 19:03:46 INFO - retry: Failed, sleeping 30 seconds before retrying 19:04:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #2 19:04:18 INFO - Downloaded 1199 bytes. 19:04:18 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 19:04:18 INFO - Using the following test package requirements: 19:04:18 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 19:04:18 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:04:18 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 19:04:18 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:04:18 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 19:04:18 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:04:18 INFO - u'jsshell-mac.zip'], 19:04:18 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:04:18 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 19:04:18 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 19:04:18 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:04:18 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 19:04:18 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:04:18 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 19:04:18 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:04:18 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 19:04:18 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:04:18 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 19:04:18 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:04: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:18 INFO - https://queue.taskcluster.net/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:04:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:04:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:04:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:04:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:04:21 INFO - Downloaded 18802607 bytes. 19:04:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:04:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:04:24 INFO - Return code: 0 19:04:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:04:24 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:24 INFO - https://queue.taskcluster.net/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:04:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:04:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:04:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:04:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:04:25 INFO - Downloaded 18802607 bytes. 19:04:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:04:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:04:29 INFO - Return code: 0 19:04:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:29 INFO - https://queue.taskcluster.net/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:04:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 19:04:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 19:04:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 19:04:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:04:30 INFO - Downloaded 14403333 bytes. 19:04:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:04:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 19:04:30 INFO - Return code: 0 19:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:30 INFO - https://queue.taskcluster.net/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 19:04:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 19:04:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 19:04:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 19:04:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 19:04:34 INFO - Downloaded 112537743 bytes. 19:04:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 19:04:34 INFO - mkdir: /builds/slave/test/properties 19:04:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:04:34 INFO - Writing to file /builds/slave/test/properties/build_url 19:04:34 INFO - Contents: 19:04:34 INFO - build_url:https://queue.taskcluster.net/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 19:04:34 INFO - Running post-action listener: _resource_record_post_action 19:04:34 INFO - Running post-action listener: set_extra_try_arguments 19:04:34 INFO - ##### 19:04:34 INFO - ##### Finished download-and-extract step (success) 19:04:34 INFO - ##### 19:04:34 INFO - ##### 19:04:34 INFO - ##### Running populate-webroot step. 19:04:34 INFO - ##### 19:04:34 INFO - Running pre-action listener: _resource_record_pre_action 19:04:34 INFO - Running main action method: populate_webroot 19:04:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:04:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:04:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:04:34 INFO - '--tppagecycles', 19:04:34 INFO - '7'], 19:04:34 INFO - 'tests': ['tsvgm']}}, 19:04:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:04:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:04:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:04:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:04:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:04:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:04:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:34 INFO - 'talos_options': ['--disable-e10s'], 19:04:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:04:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:04:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:34 INFO - 'talos_options': ['--disable-e10s'], 19:04:34 INFO - 'tests': ['damp', 'tps']}, 19:04:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:34 INFO - 'tests': ['damp', 'tps']}, 19:04:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:04:34 INFO - 'tests': ['dromaeo_dom']}, 19:04:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:04:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:04:34 INFO - 'tests': ['basic_compositor_video']}, 19:04:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:04:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:04:34 INFO - 'tests': ['a11yr', 19:04:34 INFO - 'ts_paint', 19:04:34 INFO - 'tpaint', 19:04:34 INFO - 'sessionrestore', 19:04:34 INFO - 'sessionrestore_no_auto_restore', 19:04:34 INFO - 'tabpaint']}, 19:04:34 INFO - 'other-e10s': {'tests': ['a11yr', 19:04:34 INFO - 'ts_paint', 19:04:34 INFO - 'tpaint', 19:04:34 INFO - 'sessionrestore', 19:04:34 INFO - 'sessionrestore_no_auto_restore', 19:04:34 INFO - 'tabpaint']}, 19:04:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:04:34 INFO - 'ts_paint', 19:04:34 INFO - 'tpaint', 19:04:34 INFO - 'sessionrestore', 19:04:34 INFO - 'sessionrestore_no_auto_restore', 19:04:34 INFO - 'tabpaint']}, 19:04:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:04:34 INFO - 'ts_paint', 19:04:34 INFO - 'tpaint', 19:04:34 INFO - 'sessionrestore', 19:04:34 INFO - 'sessionrestore_no_auto_restore', 19:04:34 INFO - 'tabpaint']}, 19:04:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:04:34 INFO - 'tests': ['a11yr', 19:04:34 INFO - 'ts_paint', 19:04:34 INFO - 'tpaint', 19:04:34 INFO - 'sessionrestore', 19:04:34 INFO - 'sessionrestore_no_auto_restore', 19:04:34 INFO - 'tabpaint']}, 19:04:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:04:34 INFO - 'tests': ['a11yr', 19:04:34 INFO - 'ts_paint', 19:04:34 INFO - 'tpaint', 19:04:34 INFO - 'sessionrestore', 19:04:34 INFO - 'sessionrestore_no_auto_restore', 19:04:34 INFO - 'tabpaint']}, 19:04:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:04:34 INFO - 'tests': ['tsvgx', 19:04:34 INFO - 'tsvgr_opacity', 19:04:34 INFO - 'tart', 19:04:34 INFO - 'tscrollx', 19:04:34 INFO - 'cart']}, 19:04:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:04:34 INFO - 'tsvgr_opacity', 19:04:34 INFO - 'tart', 19:04:34 INFO - 'tscrollx', 19:04:34 INFO - 'cart']}, 19:04:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:34 INFO - 'talos_options': ['--disable-e10s'], 19:04:34 INFO - 'tests': ['tp5o']}, 19:04:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:34 INFO - 'tests': ['tp5o']}, 19:04:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:34 INFO - 'talos_options': ['--disable-e10s', 19:04:34 INFO - '--xperf_path', 19:04:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:04:34 INFO - 'tests': ['tp5n']}, 19:04:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:34 INFO - 'talos_options': ['--xperf_path', 19:04:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:04:34 INFO - 'tests': ['tp5n']}}, 19:04:34 INFO - 'talos.zip': {'path': '', 19:04:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:04:34 INFO - Running post-action listener: _resource_record_post_action 19:04:34 INFO - ##### 19:04:34 INFO - ##### Finished populate-webroot step (success) 19:04:34 INFO - ##### 19:04:34 INFO - ##### 19:04:34 INFO - ##### Running create-virtualenv step. 19:04:34 INFO - ##### 19:04:34 INFO - Running pre-action listener: _resource_record_pre_action 19:04:34 INFO - Running main action method: create_virtualenv 19:04:34 INFO - Creating virtualenv /builds/slave/test/build/venv 19:04:34 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 19:04:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:04:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:04:35 INFO - Using real prefix '/tools/python27' 19:04:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:04:35 INFO - Installing distribute.............................................................................................................................................................................................done. 19:04:38 INFO - Installing pip.................done. 19:04:38 INFO - Return code: 0 19:04:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:04: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1027aba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102840618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe17ae9d2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10270fd30>, '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 0x102474db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102707b20>, '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.v6IenCXnv0/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.Mdr3GC3Yx4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 19:04: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', 'pip>=1.5'] in /builds/slave/test/build 19:04: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 pip>=1.5 19:04:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6IenCXnv0/Render', 19:04:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:04:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:04:38 INFO - 'HOME': '/Users/cltbld', 19:04:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:04:38 INFO - 'LOGNAME': 'cltbld', 19:04:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:38 INFO - 'MOZ_NO_REMOTE': '1', 19:04:38 INFO - 'NO_EM_RESTART': '1', 19:04:38 INFO - 'PAGER': '/bin/cat', 19:04:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:04:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:38 INFO - 'PWD': '/builds/slave/test', 19:04:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:04:38 INFO - 'SHELL': '/bin/bash', 19:04:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mdr3GC3Yx4/Listeners', 19:04:38 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 19:04:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:04:38 INFO - 'USER': 'cltbld', 19:04:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:04:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:04:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:38 INFO - 'XPC_FLAGS': '0x0', 19:04:38 INFO - 'XPC_SERVICE_NAME': '0', 19:04:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:04:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:38 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 19:04:38 INFO - Cleaning up... 19:04:38 INFO - Return code: 0 19:04:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:04: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04: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', '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 0x1027aba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102840618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe17ae9d2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10270fd30>, '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 0x102474db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102707b20>, '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.v6IenCXnv0/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.Mdr3GC3Yx4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 19:04: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', 'psutil>=3.1.1'] in /builds/slave/test/build 19:04: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 psutil>=3.1.1 19:04:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6IenCXnv0/Render', 19:04:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:04:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:04:38 INFO - 'HOME': '/Users/cltbld', 19:04:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:04:38 INFO - 'LOGNAME': 'cltbld', 19:04:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:38 INFO - 'MOZ_NO_REMOTE': '1', 19:04:38 INFO - 'NO_EM_RESTART': '1', 19:04:38 INFO - 'PAGER': '/bin/cat', 19:04:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:04:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:38 INFO - 'PWD': '/builds/slave/test', 19:04:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:04:38 INFO - 'SHELL': '/bin/bash', 19:04:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mdr3GC3Yx4/Listeners', 19:04:38 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 19:04:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:04:38 INFO - 'USER': 'cltbld', 19:04:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:04:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:04:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:38 INFO - 'XPC_FLAGS': '0x0', 19:04:38 INFO - 'XPC_SERVICE_NAME': '0', 19:04:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:04:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:39 INFO - Downloading/unpacking psutil>=3.1.1 19:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:04:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:04:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:04:41 INFO - Installing collected packages: psutil 19:04:41 INFO - Running setup.py install for psutil 19:04:41 INFO - building 'psutil._psutil_osx' extension 19:04:41 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 19:04:42 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 19:04:42 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 19:04:42 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 19:04:42 INFO - building 'psutil._psutil_posix' extension 19:04:42 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 19:04:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:04:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:04:42 INFO - ^ 19:04:42 INFO - 1 warning generated. 19:04:42 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 19:04:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:04:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:04:42 INFO - Successfully installed psutil 19:04:42 INFO - Cleaning up... 19:04:42 INFO - Return code: 0 19:04:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:42 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 0x1027aba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102840618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe17ae9d2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10270fd30>, '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 0x102474db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102707b20>, '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.v6IenCXnv0/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.Mdr3GC3Yx4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 19:04:42 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 19:04:42 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 19:04:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6IenCXnv0/Render', 19:04:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:04:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:04:42 INFO - 'HOME': '/Users/cltbld', 19:04:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:04:42 INFO - 'LOGNAME': 'cltbld', 19:04:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:42 INFO - 'MOZ_NO_REMOTE': '1', 19:04:42 INFO - 'NO_EM_RESTART': '1', 19:04:42 INFO - 'PAGER': '/bin/cat', 19:04:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:04:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:42 INFO - 'PWD': '/builds/slave/test', 19:04:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:04:42 INFO - 'SHELL': '/bin/bash', 19:04:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mdr3GC3Yx4/Listeners', 19:04:42 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 19:04:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:04:42 INFO - 'USER': 'cltbld', 19:04:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:04:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:04:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:42 INFO - 'XPC_FLAGS': '0x0', 19:04:42 INFO - 'XPC_SERVICE_NAME': '0', 19:04:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:04:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:04:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:04:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:04:45 INFO - Installing collected packages: mozsystemmonitor 19:04:45 INFO - Running setup.py install for mozsystemmonitor 19:04:45 INFO - Successfully installed mozsystemmonitor 19:04:45 INFO - Cleaning up... 19:04:45 INFO - Return code: 0 19:04:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:04:45 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:45 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:45 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 0x1027aba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102840618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe17ae9d2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10270fd30>, '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 0x102474db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102707b20>, '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.v6IenCXnv0/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.Mdr3GC3Yx4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 19:04:45 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 19:04:45 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 19:04:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6IenCXnv0/Render', 19:04:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:04:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:04:45 INFO - 'HOME': '/Users/cltbld', 19:04:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:04:45 INFO - 'LOGNAME': 'cltbld', 19:04:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:45 INFO - 'MOZ_NO_REMOTE': '1', 19:04:45 INFO - 'NO_EM_RESTART': '1', 19:04:45 INFO - 'PAGER': '/bin/cat', 19:04:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:04:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:45 INFO - 'PWD': '/builds/slave/test', 19:04:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:04:45 INFO - 'SHELL': '/bin/bash', 19:04:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mdr3GC3Yx4/Listeners', 19:04:45 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 19:04:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:04:45 INFO - 'USER': 'cltbld', 19:04:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:04:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:04:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:45 INFO - 'XPC_FLAGS': '0x0', 19:04:45 INFO - 'XPC_SERVICE_NAME': '0', 19:04:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:04:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:46 INFO - Downloading/unpacking jsonschema==2.5.1 19:04:46 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 19:04:46 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 19:04:46 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 19:04:46 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 19:04:46 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 19:04:46 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 19:04:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:04:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:04:48 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 19:04:48 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 19:04:48 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 19:04:48 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 19:04:48 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 19:04:48 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 19:04:49 INFO - Downloading functools32-3.2.3-2.tar.gz 19:04:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:04:49 INFO - warning: no files found matching '*.txt' 19:04:49 INFO - no previously-included directories found matching 'build' 19:04:49 INFO - no previously-included directories found matching 'dist' 19:04:49 INFO - no previously-included directories found matching '.git*' 19:04:49 INFO - Installing collected packages: jsonschema, functools32 19:04:49 INFO - Running setup.py install for functools32 19:04:49 INFO - warning: no files found matching '*.txt' 19:04:49 INFO - no previously-included directories found matching 'build' 19:04:49 INFO - no previously-included directories found matching 'dist' 19:04:49 INFO - no previously-included directories found matching '.git*' 19:04:49 INFO - Successfully installed jsonschema functools32 19:04:49 INFO - Cleaning up... 19:04:49 INFO - Return code: 0 19:04:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:49 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 0x1027aba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102840618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe17ae9d2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10270fd30>, '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 0x102474db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102707b20>, '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.v6IenCXnv0/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.Mdr3GC3Yx4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 19:04:49 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 19:04:49 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 19:04:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6IenCXnv0/Render', 19:04:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:04:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:04:49 INFO - 'HOME': '/Users/cltbld', 19:04:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:04:49 INFO - 'LOGNAME': 'cltbld', 19:04:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:49 INFO - 'MOZ_NO_REMOTE': '1', 19:04:49 INFO - 'NO_EM_RESTART': '1', 19:04:49 INFO - 'PAGER': '/bin/cat', 19:04:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:04:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:49 INFO - 'PWD': '/builds/slave/test', 19:04:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:04:49 INFO - 'SHELL': '/bin/bash', 19:04:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mdr3GC3Yx4/Listeners', 19:04:49 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 19:04:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:04:49 INFO - 'USER': 'cltbld', 19:04:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:04:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:04:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:49 INFO - 'XPC_FLAGS': '0x0', 19:04:49 INFO - 'XPC_SERVICE_NAME': '0', 19:04:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:49 INFO - Downloading/unpacking blobuploader==1.2.4 19:04:49 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 19:04:49 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 19:04:49 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 19:04:49 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 19:04:49 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 19:04:49 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 19:04:52 INFO - Downloading blobuploader-1.2.4.tar.gz 19:04:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:04:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:04:52 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 19:04:52 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 19:04:52 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 19:04:52 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 19:04:52 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 19:04:52 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 19:04:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:04:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:04:53 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 19:04:53 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 19:04:53 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 19:04:53 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 19:04:53 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 19:04:53 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 19:04:53 INFO - Downloading docopt-0.6.1.tar.gz 19:04:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:04:53 INFO - Installing collected packages: blobuploader, requests, docopt 19:04:53 INFO - Running setup.py install for blobuploader 19:04:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:04:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:04:53 INFO - Running setup.py install for requests 19:04:54 INFO - Running setup.py install for docopt 19:04:54 INFO - Successfully installed blobuploader requests docopt 19:04:54 INFO - Cleaning up... 19:04:54 INFO - Return code: 0 19:04:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:04: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:54 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 0x1027aba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102840618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe17ae9d2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10270fd30>, '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 0x102474db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102707b20>, '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.v6IenCXnv0/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.Mdr3GC3Yx4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 19:04:54 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 19:04:54 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 19:04:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6IenCXnv0/Render', 19:04:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:04:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:04:54 INFO - 'HOME': '/Users/cltbld', 19:04:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:04:54 INFO - 'LOGNAME': 'cltbld', 19:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:54 INFO - 'MOZ_NO_REMOTE': '1', 19:04:54 INFO - 'NO_EM_RESTART': '1', 19:04:54 INFO - 'PAGER': '/bin/cat', 19:04:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:54 INFO - 'PWD': '/builds/slave/test', 19:04:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:04:54 INFO - 'SHELL': '/bin/bash', 19:04:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mdr3GC3Yx4/Listeners', 19:04:54 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 19:04:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:04:54 INFO - 'USER': 'cltbld', 19:04:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:04:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:54 INFO - 'XPC_FLAGS': '0x0', 19:04:54 INFO - 'XPC_SERVICE_NAME': '0', 19:04:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:04:54 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-fPXbgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:04:54 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-EE6dY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:04:54 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-Col1dP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:04:55 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-5StwuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:04:55 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-p33I1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:04:55 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-Tsvcah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:04:55 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-ueViS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:04:55 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-mdROQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:04:55 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-2p1_GV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:04:55 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-kpya8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:04:55 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-BhrQZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:04:55 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-7VQL74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:04:55 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-7YCQiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:04:56 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-DeHnMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:04:56 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-RyeS4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:04:56 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-9QaDYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:04:56 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-mQ7aVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:04:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:04:56 INFO - Running setup.py install for manifestparser 19:04:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:04:56 INFO - Running setup.py install for mozcrash 19:04:56 INFO - Running setup.py install for mozdebug 19:04:56 INFO - Running setup.py install for mozdevice 19:04:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:04:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:04:57 INFO - Running setup.py install for mozfile 19:04:57 INFO - Running setup.py install for mozhttpd 19:04:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:04:57 INFO - Running setup.py install for mozinfo 19:04:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:04:57 INFO - Running setup.py install for mozInstall 19:04:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:04:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:04:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:04:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:04:57 INFO - Running setup.py install for mozleak 19:04:57 INFO - Running setup.py install for mozlog 19:04:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:04:57 INFO - Running setup.py install for moznetwork 19:04:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:04:58 INFO - Running setup.py install for mozprocess 19:04:58 INFO - Running setup.py install for mozprofile 19:04:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:04:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:04:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:04:58 INFO - Running setup.py install for mozrunner 19:04:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:04:58 INFO - Running setup.py install for mozscreenshot 19:04:58 INFO - Running setup.py install for moztest 19:04:58 INFO - Running setup.py install for mozversion 19:04:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:04:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:04:59 INFO - Cleaning up... 19:04:59 INFO - Return code: 0 19:04:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:04:59 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:59 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:59 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 0x1027aba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102840618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe17ae9d2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10270fd30>, '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 0x102474db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102707b20>, '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.v6IenCXnv0/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.Mdr3GC3Yx4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 19:04:59 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 19:04:59 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 19:04:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6IenCXnv0/Render', 19:04:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:04:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:04:59 INFO - 'HOME': '/Users/cltbld', 19:04:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:04:59 INFO - 'LOGNAME': 'cltbld', 19:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:59 INFO - 'MOZ_NO_REMOTE': '1', 19:04:59 INFO - 'NO_EM_RESTART': '1', 19:04:59 INFO - 'PAGER': '/bin/cat', 19:04:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:59 INFO - 'PWD': '/builds/slave/test', 19:04:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:04:59 INFO - 'SHELL': '/bin/bash', 19:04:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mdr3GC3Yx4/Listeners', 19:04:59 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 19:04:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:04:59 INFO - 'USER': 'cltbld', 19:04:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:04:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:59 INFO - 'XPC_FLAGS': '0x0', 19:04:59 INFO - 'XPC_SERVICE_NAME': '0', 19:04:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:04:59 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-Fh1YT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:04:59 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)) 19:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:04:59 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-RFORbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:04:59 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)) 19:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:04:59 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-PWvy19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:04:59 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)) 19:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:04:59 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-EaNz_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:04:59 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)) 19:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:04:59 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-z43Qbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:04:59 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)) 19:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:04:59 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-Ac0mST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:04:59 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)) 19:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:04:59 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-eoTKWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:05:00 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)) 19:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:05:00 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-hbeKkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:05:00 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)) 19:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:05:00 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-bvutrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:05:00 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)) 19:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:05:00 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-m1Er5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 19:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:05:00 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-rgfQT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:05:00 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)) 19:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:05:00 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-nq5Cfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 19:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:05:00 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-ZAAWCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:05:00 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)) 19:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:05:00 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-SfAZbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 19:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:00 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-pQpQwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:00 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)) 19:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:05:00 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-TbepGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:05:01 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)) 19:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:05:01 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-54Fx5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:05:01 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)) 19:05:01 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)) 19:05:01 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)) 19:05:01 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)) 19:05:01 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)) 19:05:01 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)) 19:05:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:05:01 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 19:05:01 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 19:05:01 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 19:05:01 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 19:05:01 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 19:05:01 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 19:05:03 INFO - Downloading blessings-1.6.tar.gz 19:05:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:05:03 INFO - Installing collected packages: blessings 19:05:03 INFO - Running setup.py install for blessings 19:05:04 INFO - Successfully installed blessings 19:05:04 INFO - Cleaning up... 19:05:04 INFO - Return code: 0 19:05:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:05:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:05:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:05:04 INFO - Reading from file tmpfile_stdout 19:05:04 INFO - Current package versions: 19:05:04 INFO - blessings == 1.6 19:05:04 INFO - blobuploader == 1.2.4 19:05:04 INFO - docopt == 0.6.1 19:05:04 INFO - functools32 == 3.2.3-2 19:05:04 INFO - jsonschema == 2.5.1 19:05:04 INFO - manifestparser == 1.1 19:05:04 INFO - mozInstall == 1.12 19:05:04 INFO - mozcrash == 0.17 19:05:04 INFO - mozdebug == 0.1 19:05:04 INFO - mozdevice == 0.48 19:05:04 INFO - mozfile == 1.2 19:05:04 INFO - mozhttpd == 0.7 19:05:04 INFO - mozinfo == 0.9 19:05:04 INFO - mozleak == 0.1 19:05:04 INFO - mozlog == 3.2 19:05:04 INFO - moznetwork == 0.27 19:05:04 INFO - mozprocess == 0.22 19:05:04 INFO - mozprofile == 0.28 19:05:04 INFO - mozrunner == 6.11 19:05:04 INFO - mozscreenshot == 0.1 19:05:04 INFO - mozsystemmonitor == 0.3 19:05:04 INFO - moztest == 0.7 19:05:04 INFO - mozversion == 1.4 19:05:04 INFO - psutil == 3.1.1 19:05:04 INFO - requests == 1.2.3 19:05:04 INFO - wsgiref == 0.1.2 19:05:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:04 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 0x1027aba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102840618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe17ae9d2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10270fd30>, '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 0x102474db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102707b20>, '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.v6IenCXnv0/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.Mdr3GC3Yx4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 19:05:04 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 19:05:04 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 19:05:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6IenCXnv0/Render', 19:05:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:05:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:05:04 INFO - 'HOME': '/Users/cltbld', 19:05:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:05:04 INFO - 'LOGNAME': 'cltbld', 19:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:04 INFO - 'MOZ_NO_REMOTE': '1', 19:05:04 INFO - 'NO_EM_RESTART': '1', 19:05:04 INFO - 'PAGER': '/bin/cat', 19:05:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:05:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:04 INFO - 'PWD': '/builds/slave/test', 19:05:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:05:04 INFO - 'SHELL': '/bin/bash', 19:05:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mdr3GC3Yx4/Listeners', 19:05:04 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 19:05:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:05:04 INFO - 'USER': 'cltbld', 19:05:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:05:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:04 INFO - 'XPC_FLAGS': '0x0', 19:05:04 INFO - 'XPC_SERVICE_NAME': '0', 19:05:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:05:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:04 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)) 19:05:04 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)) 19:05:04 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)) 19:05:04 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)) 19:05:04 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)) 19:05:04 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)) 19:05:04 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)) 19:05:04 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)) 19:05:04 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)) 19:05:04 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)) 19:05:04 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)) 19:05:04 INFO - Cleaning up... 19:05:04 INFO - Return code: 0 19:05:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1027aba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102840618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe17ae9d2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10270fd30>, '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 0x102474db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102707b20>, '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.v6IenCXnv0/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.Mdr3GC3Yx4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 19:05:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:05:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:05:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6IenCXnv0/Render', 19:05:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:05:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:05:04 INFO - 'HOME': '/Users/cltbld', 19:05:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:05:04 INFO - 'LOGNAME': 'cltbld', 19:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:04 INFO - 'MOZ_NO_REMOTE': '1', 19:05:04 INFO - 'NO_EM_RESTART': '1', 19:05:04 INFO - 'PAGER': '/bin/cat', 19:05:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:05:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:04 INFO - 'PWD': '/builds/slave/test', 19:05:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:05:04 INFO - 'SHELL': '/bin/bash', 19:05:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mdr3GC3Yx4/Listeners', 19:05:04 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 19:05:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:05:04 INFO - 'USER': 'cltbld', 19:05:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:05:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:04 INFO - 'XPC_FLAGS': '0x0', 19:05:04 INFO - 'XPC_SERVICE_NAME': '0', 19:05:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:05:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:05:04 INFO - Cleaning up... 19:05:04 INFO - Return code: 0 19:05:04 INFO - Running post-action listener: _resource_record_post_action 19:05:04 INFO - Running post-action listener: _start_resource_monitoring 19:05:04 INFO - Starting resource monitoring. 19:05:04 INFO - ##### 19:05:04 INFO - ##### Finished create-virtualenv step (success) 19:05:04 INFO - ##### 19:05:04 INFO - ##### 19:05:04 INFO - ##### Running install step. 19:05:04 INFO - ##### 19:05:04 INFO - Running pre-action listener: _resource_record_pre_action 19:05:04 INFO - Running main action method: install 19:05:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:05:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:05:05 INFO - Reading from file tmpfile_stdout 19:05:05 INFO - Detecting whether we're running mozinstall >=1.0... 19:05:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:05:05 INFO - Reading from file tmpfile_stdout 19:05:05 INFO - Output received: 19:05:05 INFO - Usage: mozinstall [options] installer 19:05:05 INFO - Options: 19:05:05 INFO - -h, --help show this help message and exit 19:05:05 INFO - -d DEST, --destination=DEST 19:05:05 INFO - Directory to install application into. [default: 19:05:05 INFO - "/builds/slave/test"] 19:05:05 INFO - --app=APP Application being installed. [default: firefox] 19:05:05 INFO - mkdir: /builds/slave/test/build/application 19:05:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:05:39 INFO - Reading from file tmpfile_stdout 19:05:39 INFO - Output received: 19:05:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:05:39 INFO - Running post-action listener: _resource_record_post_action 19:05:39 INFO - ##### 19:05:39 INFO - ##### Finished install step (success) 19:05:39 INFO - ##### 19:05:39 INFO - ##### 19:05:39 INFO - ##### Running run-tests step. 19:05:39 INFO - ##### 19:05:39 INFO - Running pre-action listener: _resource_record_pre_action 19:05:39 INFO - Running main action method: run_tests 19:05:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:05:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:05:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:05:39 INFO - 2016-07-05 19:05:39.718 screenresolution[1639:7881] starting screenresolution argv=screenresolution get 19:05:39 INFO - 2016-07-05 19:05:39.721 screenresolution[1639:7881] Display 0: 1600x1200x32@60 19:05:39 INFO - 2016-07-05 19:05:39.727 screenresolution[1640:7883] starting screenresolution argv=screenresolution list 19:05:39 INFO - Available Modes on Display 0 19:05:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:05:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:05:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:05:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:05:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:05:39 INFO - Intel Iris: 19:05:39 INFO - Chipset Model: Intel Iris 19:05:39 INFO - Type: GPU 19:05:39 INFO - Bus: Built-In 19:05:39 INFO - VRAM (Dynamic, Max): 1536 MB 19:05:39 INFO - Vendor: Intel (0x8086) 19:05:39 INFO - Device ID: 0x0a2e 19:05:39 INFO - Revision ID: 0x0009 19:05:39 INFO - Displays: 19:05:39 INFO - Display: 19:05:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:05:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:05:39 INFO - Display Serial Number: 1600x1200 60 19:05:39 INFO - Main Display: Yes 19:05:39 INFO - Mirror: Off 19:05:39 INFO - Online: Yes 19:05:39 INFO - Rotation: Supported 19:05:39 INFO - Return code: 0 19:05:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:05:39 INFO - Python 2.7.3 19:05:39 INFO - Return code: 0 19:05:39 INFO - grabbing minidump binary from tooltool 19:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:39 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 0x10270fd30>, '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 0x102474db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102707b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:05:39 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 19:05:39 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 19:05:39 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 19:05:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:05:40 INFO - Return code: 0 19:05:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:05:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:05:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:05:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:05:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:05:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0202', '--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 19:05:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0202 --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 19:05:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v6IenCXnv0/Render', 19:05:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:05:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:05:40 INFO - 'HOME': '/Users/cltbld', 19:05:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:05:40 INFO - 'LOGNAME': 'cltbld', 19:05:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:05:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:40 INFO - 'MOZ_NO_REMOTE': '1', 19:05:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:05:40 INFO - 'NO_EM_RESTART': '1', 19:05:40 INFO - 'PAGER': '/bin/cat', 19:05:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:40 INFO - 'PWD': '/builds/slave/test', 19:05:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:05:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:05:40 INFO - 'SHELL': '/bin/bash', 19:05:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mdr3GC3Yx4/Listeners', 19:05:40 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 19:05:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:05:40 INFO - 'USER': 'cltbld', 19:05:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:05:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:40 INFO - 'XPC_FLAGS': '0x0', 19:05:40 INFO - 'XPC_SERVICE_NAME': '0', 19:05:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:05:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0202', '--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 19:05:40 INFO - mozversion application_buildid: 20160705170424 19:05:40 INFO - mozversion application_changeset: a22de7d60df7690ea67b4b7573af8f0602c422b1 19:05:40 INFO - mozversion application_display_name: Nightly 19:05:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:05:40 INFO - mozversion application_name: Firefox 19:05:40 INFO - mozversion application_remotingname: firefox 19:05:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:05:40 INFO - mozversion application_vendor: Mozilla 19:05:40 INFO - mozversion application_version: 50.0a1 19:05:40 INFO - mozversion platform_buildid: 20160705170424 19:05:40 INFO - mozversion platform_changeset: a22de7d60df7690ea67b4b7573af8f0602c422b1 19:05:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:05:40 INFO - mozversion platform_version: 50.0a1 19:05:40 INFO - using testdate: 1467770740 19:05:40 INFO - actual date: 1467770740 19:05:40 INFO - starting webserver on 'localhost:49275' 19:05:40 INFO - SUITE-START | Running 2 tests 19:05:40 INFO - TEST-START | dromaeo_css 19:05:40 INFO - operating with platform_type : mac_ 19:05:40 INFO - Initialising browser for dromaeo_css test... 19:05:40 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/tmplNnNzp/profile http://localhost:49275/getInfo.html) 19:05:43 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 19:05:43 INFO - PROCESS | 1650 | colorDepth:24 19:05:43 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 19:05:43 INFO - PROCESS | 1650 | __metrics 19:05:43 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 19:05:44 INFO - TEST-INFO | 1650: exit 0 19:05:44 INFO - Browser initialized. 19:05:44 INFO - Running cycle 1/1 for dromaeo_css test... 19:05:44 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/tmplNnNzp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:05:56 INFO - PROCESS | 1654 | RSS: Main: 255754240 19:05:56 INFO - PROCESS | 1654 | 19:06:45 INFO - PROCESS | 1654 | 1467770805823 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] 19:08:57 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 19:08:58 INFO - PROCESS | 1654 | RSS: Main: 268042240 19:08:58 INFO - PROCESS | 1654 | 19:12:00 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 19:12:01 INFO - PROCESS | 1654 | RSS: Main: 276893696 19:12:01 INFO - PROCESS | 1654 | 19:15:03 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 19:15:03 INFO - PROCESS | 1654 | RSS: Main: 281497600 19:15:03 INFO - PROCESS | 1654 | 19:18:05 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 19:18:06 INFO - PROCESS | 1654 | RSS: Main: 280776704 19:18:06 INFO - PROCESS | 1654 | 19:21:08 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 19:21:09 INFO - PROCESS | 1654 | RSS: Main: 284041216 19:21:09 INFO - PROCESS | 1654 | 19:24:12 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 19:24:12 INFO - PROCESS | 1654 | RSS: Main: 284172288 19:24:12 INFO - PROCESS | 1654 | 19:24:12 INFO - PROCESS | 1654 | __start_tp_report 19:24:12 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 19:24:12 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 19:24:12 INFO - PROCESS | 1654 | |i|pagename|runs| 19:24:12 INFO - PROCESS | 1654 | |0;dojo.html;3416.5558477397944;3417.8632854685816;3444.4316687746523;3449.5688038995127;3455.533502977098;5838.153467747179;5912.231409916711;5918.319393269775;5940;5940.762369505225;5746.367899531048;5835.328937172216;5910.172575839375;5925;6042.879142417149;5362.115250983593;5397.136458166694;5435.157550579666;5435.864103397407;5478.58910581706;153.4135040308541;5448.536874365684;5451;5456.48163424474;5506.91739623906;5375.543078838304;5382.59630527708;5398.352197736258;5406.54044406224;5425.13197888336;4428.468583769936;5311.840644780663;5425.104857698475;5435.130379139358;5439.075357189287;5183.833637431586;5193.221016847503;5290.867728306823;5327.254184414185;5429.158480435539;4991.425986011619;5516.172574113875;5947.613405128653;5988.8502787430225;6046.697665116727;5609.27079479665;6102.216595924226;6269.811905642838;6350.110984462179;6370.140031095835;6260.280067792171;6322.683865806691;6327.3988971047675;6333.334999825044;6356.427921487042;5106.565941894906;5824.893270278633;5899.705014749288;5961.642301461926;5970.850728731816;6214.906776398358;6232.968835155886;6288.937110628926;6388.8083357499345;6409.359064093646;6230.532710046765;6299.055141728686;6301.779437719658;6310.495160387158;6312.210973628296;6315.778947736807;6333.809985700344;6353.714082866282;6357.078223657544;6358.078078678565;6165.075238714228;6214.161088253119;6254.312025677172;6298.937010629835;6333.334999825044;6185.381461853779;6269.0909818076125;6291.433770960635;6301.842453938688;6323.588966717149;5049;5093.592512598983;5105.183170692671;5121.359830021247;5128.999845030184;4428.468583769968;4439.067795762861;4440.888977775517;4498.302763071729;4590.472095708969;5750.137479378043;5763.971180144156;5788.797392091256;5794.362620111784;5813.59304848665;6153.261608606996;6298.716557754912;6300.779472718433;6307.842303942438;6312.4634406076;5800.767969281266;5888.676122813201;5926.1999630049395;5937.139114828412;6010.519158467312;4987.900241995139;5289.656172348785;5557.305336832896;5561.833145005657;5590.608657394025;6194.473469754941;6440.32376600469;6445.258795238514;6454.32229615893;6455.289918109004;6262.405071518198;6292.653904035322;6313.6843157841;6319.304876463493;6333.714982825692;5707.743151558107;6134.325224225242;6411.775587854403;6413.0701048348665;6419.582727122722;6169.136320915165;6250.49996000328;6314.526410519137;6320.683965801783;6330.335314792064;6235.438810506895;6254.468370188585;6312.43188113072;6313.589616675085;6313.621182729051;4967.559407771851;6268.749250029948;6282.874342513215;6283.465905397909;6286.811395658137;6127.14220009208;6178.567500275118;6184;6194.5973511721595;6247.687615619292;5827.708614569339;5868.589198756046;6064.696765161812;6082;6115.510759139169;6229.096780966644;6238.719257633326;6268.498520118471;6289.874202516015;6293.118963345044;5972.910406343995;6041.154238406539;6113.633182008915;6147.846303842261;6163.414475624809 19:24:12 INFO - PROCESS | 1654 | |1;ext.html;454.5477250136115;479.46060681733053;544.0370544136879;546.978120875165;566.6656672563187;39887.80056099719;42280.99999999996;42326.57673423265;42416;42557.93605159873;43207.56792432075;43395.91510212246;43705.7814710926;43868.34197487032;43872.90317742058;9610.183134433564;9772.120509154174;9781.021897810233;9794.971527989564;9817.6072957082;9679.564419601134;9735.610575576968;9780.266480013992;9805.705828825112;9813.460259685715;9772.120509154174;9786.90213097867;9804.509774511282;9838.311318207729;9851.965543617924;9774.120329170373;9824.803503929917;9825.164860986824;9830.115289623896;9859.161971232383;9663.178629816473;9755.073268039525;9771.462569558671;9778.364406313567;9779.608815647365;40549.79725101356;40740.38889416661;40921.59078409208;41239;41265.58734412648;3121.82829944353;3369.029117965993;3411.4371128763723;3419.247765491588;3591.174029973121;30500.69499305001;30718.38563228723;31639.36721265562;31761.205969850707;32607.184820379443;3222.4038552867796;3237;3237.4172648923186;3242.789218700777;3356.3790698720813;451793;455929;457420;459164.9999999967;461327.69336153107;35247.11882202965;35658.82170589182;35715;35723.82138089345;35747.92756217318;35886.46170307448;36039.4594081089;36280.81859590738;36537;36720.449193262124;16588.75116873248;17040.89234199773;17078.743818842726;17163.31346746116;17233.310667573158;12565.371731413576;12977.35113244334;13073.607791766262;13102.951763858868;13111.934440327737;17665.470035898943;17958.461246162635;19911.800881991283;20271;20551.58896822085;8107.027156741229;8482;8573.27127194183;8621.956890215508;8627.921509811273;880.7401816464159;880.766596851822;892.3931726425963;913.9314551408671;982.189693502863;28086.578701319497;31110.066697999097;31432.37135257282;31591.431176842885;32353.676463235537;1015.6035451254525;1076.61529711689;1082.9620963266404;1106.3251416635846;1188.9227200231958;13601.795973060413;15707.136107513968;16359.83640163607;16523.33906643745;16579.50261492157;682272;692896;693067;704981;706588;60855.69572152111;61178;61816.381836181965;61838.69080654568;62090;1257.264500267354;1402.5161319345013;1412.971740565183;1449.6665766873678;1449.746294398476;30157.849210753804;31001;31178.064658060295;31213.531797023516;31540;54506.45493545172;54760.452395475535;54873.725631371584;54934;54958.45041549533;588470;589517;589633;589702;590409;27435.45129097367;27586;27663.72336276692;27835.44329113366;28847.278818029718;51033.74483127561;51307.48692513027;52079;53054.73472632612;54470.63823404288;41558.79220603878;41736.165276694905;42451.787741061096;42652.78673606736;43131.137377252904;42203.788981054895;42356.788216058725;42438;42840.92897677583;43398.78300608477;34632.82683586566;39177;39422.01444963899;40543.3918491217;41165.382519261635;29165.56251656269;35498.46752298666;35882.10294742652;36322.09194770152;36750.26499470049;25849.224523264333;26605.86697066502;26803.463930721668;27185.72814271832;27390.904363826023 19:24:12 INFO - PROCESS | 1654 | |2;jquery.html;383.183818466666;387.2931899283808;389.7120018339387;390.6132928400883;414.4736185044993;15027.248637568133;20759.273425430096;21302.46743831401;22068.88965555172;22103.33689989301;21142.26002089927;21506.032228549713;21609;21862.672059919114;21939.451513712163;5902.616329938562;6020.759169633209;6054.878902421949;6165;6228.781992630259;6034.577579569432;6051.273847138327;6061.151438798572;6153.692315384235;6158.538109641772;4809.278608208761;5447.937652157831;6094.512439004891;6102.969485152568;6120.081987701858;4797.808087676489;6105.450509454148;6129.632222066691;6140.6929653517145;6159.692015399234;5154.5103215194495;5253.185756207794;5284.524392804666;5313.946860531384;5457.099578569531;25253;26123.73876261251;26460.470790584273;26488.73511264882;26656.200313990612;2410.4937963027787;2756.9172924812287;2782.0680072175846;2937.397833444139;3024.002079313821;15862.762058569131;15889.920550397173;15993.440229591908;16006.919965400099;16300.673986520203;1850.8519318454626;1852.832715389296;1924.316867512027;1945.9027048647652;1963.901804909763;64878.675606622135;92645.53677231638;128847;129419;130564;10692.89307106919;11003.504842281956;11096.223264371578;11304.930225118951;11375.488103035217;13814.723705525834;13854.238016909167;13858.65353366174;13863.514776982756;13874.722505549833;6830.091127768522;8465.40742148056;8547.188017138362;8742.519161446182;8870.467771933705;8841.911580884238;8894.599743011451;8897.866532002025;8957.820843583091;8983.236424903826;5882.647041177543;6519.348065193442;6709.966450167718;6845.110135682429;6867.862642747217;1836.7061270196705;1862.3574866670976;1868.5795695968297;1869.2522990803516;1870.9812901870807;872.9781755456164;898.6180873128894;932.7248461703814;966.0291407135784;976.2190247801731;22349.32952011442;22532.887335563544;22693.88653056757;22765.772342276698;22777.202797901995;890.9198172164407;954.9379290346244;984.7636567223815;1025.1747343388645;1049.5172220778375;10887.673369798918;11521.53913843437;11910.585745235385;11975.341356225492;12080.818787718192;628941;635204;643219;649941;654780;135652.3217383907;141670.29164854315;144479.55520444873;146327.26836365962;146751;945.4091193004373;996.7707427291908;999.7400675824338;1000.1448761309122;1002.674130907458;19468.707969380754;19672.11475483635;19712.704309435656;19750.901245493682;19897.403077907686;54707.452925470236;56178.43821561732;57153.85692286214;57361.852762945346;58531;83992.58003709943;84151.5792421034;84235.5788221055;84288;84636;7824.92175078242;8061.234182752629;8160.8775868360835;8185.959070204611;8281.461704989157;9107.453552786854;11265.7746845061;12709.4280757368;12979.091463597457;13666.794998074838;11563.710907227387;11605.30368177912;11707.531698732297;11817.468213930222;11895.929366356724;11397.886021139682;11417.257878237888;11422.714432139262;11653.6503904883;11808.940955295513;9995.350302230332;11880.702982425162;12005.75988480208;12019.21875078117;12091.637250882488;8133.186681331819;8221.54781487024;8340.958295208486;8460.280876125353;8473.279771219515;8939.374243802871;11744.412779361168;11804.291742495478;11902.464389102684;11948.940255298668 19:24:12 INFO - PROCESS | 1654 | |3;mootools.html;1555.2301610702698;1595.9680806383872;1832.477743843005;1922.3848368522079;1923.0673123535091;7998.840023199533;8485.363597730171;8574.44266122703;8946.015938246795;8959.372843900921;7489.28851759082;8603.741887743363;8612.827743445127;8727.86908196376;8762.561871906411;2176.9564608707815;2197.923072692456;2200.8569442986154;2206.6028114939304;2211.5355775287208;2336.380859072347;2352.0826877517784;2359.044586942291;2365.420471984366;2378.4291769975252;2345.741968383485;2367.9408014799596;2368.502614450959;2388.128333158393;2388.9044438222536;2325.8837058147196;2339.1345202275097;2342.437814924423;2346.6597343385197;2349.424391024193;2332.300309907021;2335.859848409101;2337;2339.812814974798;2345.3667509772436;8767.561621918878;8848.557572121368;8867.645294188225;8900.688475903313;8922.330825188072;5232.3459567554055;5250.9474905250845;5255.605829562798;5310;5313.946860531384;3512.5609298837644;3624.9456258156147;3642.690371318441;3674.1365779041903;3680.7791532508136;990.2078337330107;1003.7892042671048;1067.8238090715022;1094.2996482251365;1107.595727559443;11424.657260282205;11494.252873563191;11592.420378981018;11615.535378584846;11623.709407264885;4600.217962946307;4614.76926153691;4772.594329482033;4809.567138957511;4818.807247710122;9882.950585247172;9896.55465504054;9916.950415247878;9948.552315145836;9963.053509916546;5328.866778330495;5336.012837625051;5344.518993290545;5350.143976963667;5357.1696387060065;4366.388705581221;4695.107929493385;4882.804687812448;4886.975565122151;4915.631327650441;3332.8000319980392;4037.9798101009305;4039;4078.4290199372113;4121.175764847043;1094.5457635081352;1328.3291937571464;1334.5062326939094;1339.7588434081958;1341.47011930287;814.7963009247688;924.5700749151677;931.2363861633531;936.5972631768406;942.2273735536794;5312.495312945264;5868.882622347529;6049.089154420905;6089.2997305310455;6193.876122477615;848.5714714069355;959.8704174936433;1011.544804837826;1021.2493817044466;1036.549101141006;3966.2860685076384;4044.3529035354204;4075.97962010194;4156.958430415718;4167.6457501112745;10481.947590262;10584.629537966135;10637.414942178255;10802.567897284178;10956.397398143019;10636.149108071335;10778.622748203932;10803.297785643908;10807.297525660806;10858.67423977282;8130.227628375294;8390.958045209734;8408.873866892001;8410.411271210956;8420.621072051772;5730.426957304237;5923.170756094237;6007.609505382136;6037.396260373927;6085.9695701521205;9747.415155090717;10018.949905250718;10030.949845250727;10103.191744660557;10146.340487868265;9564.856527152237;10039.29724919278;10046.095851373411;10280.742981425525;10381.221408394249;6577.473802095917;6889.276625954202;7047.7180912762915;7083.327083927019;7102.680379382837;8417.28453081495;8434.283085937519;8485.618147183515;8502.44734092282;8521.190486903733;7363.410927125924;7527.924720752722;7565.167831538416;7568.051754167704;7582.886256706043;7337.26627337262;7348.559086454829;7399.630018499161;7519.323260906326;7579.772606821804;6925.238223795479;6959.478039147186;6978.755743548952;6991.056207412138;7055.400290975324;4853.272009198648;4964.950350496449;5012.624053195952;5014.696178993415;5102.387713474258;5056.62075344358;5128.358955130609;5143.459936706592;5147.202183661539;5259.289995850511 19:24:12 INFO - PROCESS | 1654 | |4;prototype.html;309.40439653666687;310.90051183621244;317.83949105701623;324.3011310625603;326.9231730543323;4593.3923126905565;5557.805476808313;5562.749676264568;5654.123610840316;5734.856628584287;4958.876028099299;5753.942460575393;5791.725820319523;5799.3620701722775;5815.244018277628;4330.696851220416;4336.501302350239;4352.194843953863;4371.213181627306;4387.5173730889655;4047.615476529725;4321.956780432187;4328.7402755834755;4339.414179085815;4351.8685141863025;4258.9148217035645;4298.978505107486;4309.418228539138;4330.415393921828;4348.7825608719595;3673.989652845462;3790.90522736931;4320.589543993316;4323.805428755713;4346.739195648272;3145.716885480295;3579.6957258633047;3711.183539621279;3712.1647629283466;3717.5724791649036;4709.740964246965;4832.685875418087;5096.566791822699;5320.574354051667;5583.8604034899045;4688.671792974493;4730.739809310487;4931.876703082416;4983.177775667011;4991.5258050485145;5340.62615616907;5610.4670056344585;5906.055031195031;6122.47958923492;6132.570720049598;3632.909177270563;3869;4046.352583586612;4049.036217434542;4125.278076336629;5597.356304025048;6156.261248650146;6380.617162970237;6426.710798014101;6462.418382345564;3507.3511400391008;3990.940135897964;4073.572274911092;4086.8569600063856;4112.753234805921;3466.6879980801345;4138.979305103455;4153.626173644387;4163.687723420756;4168.791560421967;4124.443200167939;4941.505849415102;4945.2582112683385;4953.801847926043;4965.751712414365;5490.572451162647;5902.026165682701;6176.320604733476;6196.504279657616;6198.411150940653;1387.937542810576;1405.5291477354997;1406.725688490755;1412.6256542016374;1418.3830033935271;708.8263375473042;841.4488510025943;848.5121055393174;856.6444925356033;862.5644049754834;4322.978385108117;4719.433667959798;4765.070811191854;4818.325434439182;4825;4614.254518561451;5152.9742351288005;5225.126180600654;5260.473952604709;5284.339457567804;4124.896877578025;4215.97892010538;4502.459704835375;4609.423822022247;4802.615790736732;2306.5156317173582;2640.524705553019;2778.235985104072;2778.4021939486643;2830.433913217365;4723.858284251478;5045.268436076748;5376.301080859542;5491.807786727445;5515.145152501369;4139.8965025873995;4787.946651736613;5042.722650254272;5201.609879259071;5500.862478438071;4799.952000480021;5369.919451208235;5371.892562148735;5481.629592601849;5500.22996780459;4693.530646935279;4881.290883559516;4908.705477671351;5277.627816767745;5328.520433161034;4281.636060934856;5180.798160781728;5216.191490319006;5242.427271818516;5258.686178081632;5206.349206349207;5436.662235238885;5446.945530544644;5463.781448742165;5492.917606235989;3360.8655653773576;3412.0105169500566;3473.965260347465;3574.2136729919375;3608.927821443609;4348.956510434855;4697.389339385858;5309.557603502432;5316.627836051439;5327.387350454747;4535.886602834956;4782.976085119552;4907.484714104968;4947.6536642434685;5134.897302053863;4327.545607711145;4470.441194850644;5012.749362531932;5045.84862454127;5087.542121209109;4570.337301091389;4690.437147542317;4744.6003428989225;4982.875428114181;5042.411640333284;4428.844990425319;4676.508966558598;5125.795438072125;5144.511271429208;5204.947950520446;4409.082049308561;4881.243407271879;5003.6975596106395;5061.746912654279;5103.540681338697 19:24:12 INFO - PROCESS | 1654 | |5;yui.html;719.4963525532129;746.7983644416008;769.0271806165206;785.2226295966991;861.7587075618827;13153.934230328847;13615.659608509792;13774.242416667092;13785.448582056706;13792.310384480787;14529.055611385253;14640.26798660068;15010;16383.7712171587;16411.753823692656;905.2576886952702;919.7700574856286;930.502181332987;932.4125800745554;933.10421994885;911.1162172692477;925.2228128372166;927.4342650982895;930.0467021303151;931.1898648176096;958.3339578992603;973.7760315127525;977.5552123783662;977.7408986618552;977.911987921087;868.9695860644847;930.6226784359186;952.4095061062151;973.1922504321396;975.6243846119224;721.4228617106346;722.2091809468624;723.3092396761081;726.4478995963053;728.3299364584595;14030.228337441436;14653.487127950471;15325.540233793005;15328.463503777315;16222.51332460028;12298.262104273683;14578.416863325454;14669.636672596742;14791.112533248039;15058.171800550965;9954;11842.763144737142;12027.639170824888;12046.277223366626;12266.448009839578;3840.1935593525395;3871.728978971473;3887.8639247626197;3961.16815468749;4005.5794141615;118999;121079.39460302642;121743;122700.99999999911;122847.3857630715;10295.794084118426;11323.094152467782;11340.94329528347;11384.430778461045;11553.711157220969;17288.827111728722;20294;21981.890090549445;22940.655890161663;23026.769732302797;6592.406683398517;8012.158723333966;8019.117897031322;8039.67841286342;8056.09947617965;3517.314123745845;4367.5632436756705;4485.573870482299;4497.910041799146;4613.169629466661;3288.6546912574313;3338.814720774139;3531.629868518978;3635.7273204509765;3670.541182352206;533.2001997004493;611.1321922869447;612.1980205930246;613.3437222172322;648.3969907985525;551.3494076989111;657.3328072006917;665.8634979829123;700.2332445971653;702.0978043214445;9359.408900486933;9359.625614975324;9672.274579406572;9682.854757178648;9981.301308908307;652.3248437866785;660.2901880478505;672.3411057163909;699.4963626189136;700.4046560423599;4509.346144808985;4674.813007479731;4693.413323334583;4727.9299374156235;4751.3348131261655;90964;131994.02008969872;134566;137259;149115.25442372935;107583;117334;118444;120359;121696;90133.54933225423;90446.54776726074;112218.43890780494;118998.40500797614;120466.99999999825;9249.630014799333;9872.555734991798;10260.435676037889;10399.896001039893;10443.425611591436;58106.4189358101;58307.4169258302;64942;67382;67655.66172169108;93180;98913.51629725416;100658.99341006496;102804;102922.73695367452;14349.067310624776;14372.568822935329;14377;14561.199134047729;14898.32957516936;15117.54647360581;15370.769438458208;15476.845231547992;15756.290966906288;16313.59216019609;12174.513019479122;14126.293685315488;14131.858681413054;14367.497137600134;14550;14235.928820355832;14334;14348.856511434751;14533.418663253775;15002.399904003718;13684.247366394944;14002.229877356844;14041.648958775704;14076.155430674193;14480.85519144795;10349.586016559253;11455.541778328774;11480.598179063692;11577.826332604849;11746.353950532803;10817.296875703054;10958.506867191156;11542;11953.282803031845;12218.327991960528 19:24:12 INFO - PROCESS | 1654 | __end_tp_report 19:24:12 INFO - PROCESS | 1654 | __start_cc_report 19:24:12 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,436 19:24:12 INFO - PROCESS | 1654 | __end_cc_report 19:24:12 INFO - PROCESS | 1654 | __startTimestamp1467771852344__endTimestamp 19:24:12 INFO - PROCESS | 1654 | 19:24:12 INFO - PROCESS | 1654 | ------- Summary: start ------- 19:24:12 INFO - PROCESS | 1654 | Number of tests: 6 19:24:12 INFO - PROCESS | 1654 | 19:24:12 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5797.28 Median:6064.70 stddev:781.35 (12.9%) stddev-sans-first:761.10 19:24:12 INFO - PROCESS | 1654 | Values: 3416.6 3417.9 3444.4 3449.6 3455.5 5838.2 5912.2 5918.3 5940.0 5940.8 5746.4 5835.3 5910.2 5925.0 6042.9 5362.1 5397.1 5435.2 5435.9 5478.6 153.4 5448.5 5451.0 5456.5 5506.9 5375.5 5382.6 5398.4 5406.5 5425.1 4428.5 5311.8 5425.1 5435.1 5439.1 5183.8 5193.2 5290.9 5327.3 5429.2 4991.4 5516.2 5947.6 5988.9 6046.7 5609.3 6102.2 6269.8 6350.1 6370.1 6260.3 6322.7 6327.4 6333.3 6356.4 5106.6 5824.9 5899.7 5961.6 5970.9 6214.9 6233.0 6288.9 6388.8 6409.4 6230.5 6299.1 6301.8 6310.5 6312.2 6315.8 6333.8 6353.7 6357.1 6358.1 6165.1 6214.2 6254.3 6298.9 6333.3 6185.4 6269.1 6291.4 6301.8 6323.6 5049.0 5093.6 5105.2 5121.4 5129.0 4428.5 4439.1 4440.9 4498.3 4590.5 5750.1 5764.0 5788.8 5794.4 5813.6 6153.3 6298.7 6300.8 6307.8 6312.5 5800.8 5888.7 5926.2 5937.1 6010.5 4987.9 5289.7 5557.3 5561.8 5590.6 6194.5 6440.3 6445.3 6454.3 6455.3 6262.4 6292.7 6313.7 6319.3 6333.7 5707.7 6134.3 6411.8 6413.1 6419.6 6169.1 6250.5 6314.5 6320.7 6330.3 6235.4 6254.5 6312.4 6313.6 6313.6 4967.6 6268.7 6282.9 6283.5 6286.8 6127.1 6178.6 6184.0 6194.6 6247.7 5827.7 5868.6 6064.7 6082.0 6115.5 6229.1 6238.7 6268.5 6289.9 6293.1 5972.9 6041.2 6113.6 6147.8 6163.4 19:24:12 INFO - PROCESS | 1654 | 19:24:12 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:70816.22 Median:41412.19 stddev:157699.28 (380.8%) stddev-sans-first:158053.18 19:24:12 INFO - PROCESS | 1654 | Values: 454.5 479.5 544.0 547.0 566.7 39887.8 42281.0 42326.6 42416.0 42557.9 43207.6 43395.9 43705.8 43868.3 43872.9 9610.2 9772.1 9781.0 9795.0 9817.6 9679.6 9735.6 9780.3 9805.7 9813.5 9772.1 9786.9 9804.5 9838.3 9852.0 9774.1 9824.8 9825.2 9830.1 9859.2 9663.2 9755.1 9771.5 9778.4 9779.6 40549.8 40740.4 40921.6 41239.0 41265.6 3121.8 3369.0 3411.4 3419.2 3591.2 30500.7 30718.4 31639.4 31761.2 32607.2 3222.4 3237.0 3237.4 3242.8 3356.4 451793.0 455929.0 457420.0 459165.0 461327.7 35247.1 35658.8 35715.0 35723.8 35747.9 35886.5 36039.5 36280.8 36537.0 36720.4 16588.8 17040.9 17078.7 17163.3 17233.3 12565.4 12977.4 13073.6 13103.0 13111.9 17665.5 17958.5 19911.8 20271.0 20551.6 8107.0 8482.0 8573.3 8622.0 8627.9 880.7 880.8 892.4 913.9 982.2 28086.6 31110.1 31432.4 31591.4 32353.7 1015.6 1076.6 1083.0 1106.3 1188.9 13601.8 15707.1 16359.8 16523.3 16579.5 682272.0 692896.0 693067.0 704981.0 706588.0 60855.7 61178.0 61816.4 61838.7 62090.0 1257.3 1402.5 1413.0 1449.7 1449.7 30157.8 31001.0 31178.1 31213.5 31540.0 54506.5 54760.5 54873.7 54934.0 54958.5 588470.0 589517.0 589633.0 589702.0 590409.0 27435.5 27586.0 27663.7 27835.4 28847.3 51033.7 51307.5 52079.0 53054.7 54470.6 41558.8 41736.2 42451.8 42652.8 43131.1 42203.8 42356.8 42438.0 42840.9 43398.8 34632.8 39177.0 39422.0 40543.4 41165.4 29165.6 35498.5 35882.1 36322.1 36750.3 25849.2 26605.9 26803.5 27185.7 27390.9 19:24:12 INFO - PROCESS | 1654 | 19:24:12 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:37107.89 Median:2769.49 stddev:107148.45 (3868.9%) stddev-sans-first:107413.55 19:24:12 INFO - PROCESS | 1654 | Values: 383.2 387.3 389.7 390.6 414.5 15027.2 20759.3 21302.5 22068.9 22103.3 21142.3 21506.0 21609.0 21862.7 21939.5 5902.6 6020.8 6054.9 6165.0 6228.8 6034.6 6051.3 6061.2 6153.7 6158.5 4809.3 5447.9 6094.5 6103.0 6120.1 4797.8 6105.5 6129.6 6140.7 6159.7 5154.5 5253.2 5284.5 5313.9 5457.1 25253.0 26123.7 26460.5 26488.7 26656.2 2410.5 2756.9 2782.1 2937.4 3024.0 15862.8 15889.9 15993.4 16006.9 16300.7 1850.9 1852.8 1924.3 1945.9 1963.9 64878.7 92645.5 128847.0 129419.0 130564.0 10692.9 11003.5 11096.2 11304.9 11375.5 13814.7 13854.2 13858.7 13863.5 13874.7 6830.1 8465.4 8547.2 8742.5 8870.5 8841.9 8894.6 8897.9 8957.8 8983.2 5882.6 6519.3 6710.0 6845.1 6867.9 1836.7 1862.4 1868.6 1869.3 1871.0 873.0 898.6 932.7 966.0 976.2 22349.3 22532.9 22693.9 22765.8 22777.2 890.9 954.9 984.8 1025.2 1049.5 10887.7 11521.5 11910.6 11975.3 12080.8 628941.0 635204.0 643219.0 649941.0 654780.0 135652.3 141670.3 144479.6 146327.3 146751.0 945.4 996.8 999.7 1000.1 1002.7 19468.7 19672.1 19712.7 19750.9 19897.4 54707.5 56178.4 57153.9 57361.9 58531.0 83992.6 84151.6 84235.6 84288.0 84636.0 7824.9 8061.2 8160.9 8186.0 8281.5 9107.5 11265.8 12709.4 12979.1 13666.8 11563.7 11605.3 11707.5 11817.5 11895.9 11397.9 11417.3 11422.7 11653.7 11808.9 9995.4 11880.7 12005.8 12019.2 12091.6 8133.2 8221.5 8341.0 8460.3 8473.3 8939.4 11744.4 11804.3 11902.5 11948.9 19:24:12 INFO - PROCESS | 1654 | 19:24:12 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5720.18 Median:4940.29 stddev:3185.95 (64.5%) stddev-sans-first:3179.51 19:24:12 INFO - PROCESS | 1654 | Values: 1555.2 1596.0 1832.5 1922.4 1923.1 7998.8 8485.4 8574.4 8946.0 8959.4 7489.3 8603.7 8612.8 8727.9 8762.6 2177.0 2197.9 2200.9 2206.6 2211.5 2336.4 2352.1 2359.0 2365.4 2378.4 2345.7 2367.9 2368.5 2388.1 2388.9 2325.9 2339.1 2342.4 2346.7 2349.4 2332.3 2335.9 2337.0 2339.8 2345.4 8767.6 8848.6 8867.6 8900.7 8922.3 5232.3 5250.9 5255.6 5310.0 5313.9 3512.6 3624.9 3642.7 3674.1 3680.8 990.2 1003.8 1067.8 1094.3 1107.6 11424.7 11494.3 11592.4 11615.5 11623.7 4600.2 4614.8 4772.6 4809.6 4818.8 9883.0 9896.6 9917.0 9948.6 9963.1 5328.9 5336.0 5344.5 5350.1 5357.2 4366.4 4695.1 4882.8 4887.0 4915.6 3332.8 4038.0 4039.0 4078.4 4121.2 1094.5 1328.3 1334.5 1339.8 1341.5 814.8 924.6 931.2 936.6 942.2 5312.5 5868.9 6049.1 6089.3 6193.9 848.6 959.9 1011.5 1021.2 1036.5 3966.3 4044.4 4076.0 4157.0 4167.6 10481.9 10584.6 10637.4 10802.6 10956.4 10636.1 10778.6 10803.3 10807.3 10858.7 8130.2 8391.0 8408.9 8410.4 8420.6 5730.4 5923.2 6007.6 6037.4 6086.0 9747.4 10018.9 10030.9 10103.2 10146.3 9564.9 10039.3 10046.1 10280.7 10381.2 6577.5 6889.3 7047.7 7083.3 7102.7 8417.3 8434.3 8485.6 8502.4 8521.2 7363.4 7527.9 7565.2 7568.1 7582.9 7337.3 7348.6 7399.6 7519.3 7579.8 6925.2 6959.5 6978.8 6991.1 7055.4 4853.3 4965.0 5012.6 5014.7 5102.4 5056.6 5128.4 5143.5 5147.2 5259.3 19:24:12 INFO - PROCESS | 1654 | 19:24:12 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4430.44 Median:4801.28 stddev:1324.19 (27.6%) stddev-sans-first:1291.27 19:24:12 INFO - PROCESS | 1654 | Values: 309.4 310.9 317.8 324.3 326.9 4593.4 5557.8 5562.7 5654.1 5734.9 4958.9 5753.9 5791.7 5799.4 5815.2 4330.7 4336.5 4352.2 4371.2 4387.5 4047.6 4322.0 4328.7 4339.4 4351.9 4258.9 4299.0 4309.4 4330.4 4348.8 3674.0 3790.9 4320.6 4323.8 4346.7 3145.7 3579.7 3711.2 3712.2 3717.6 4709.7 4832.7 5096.6 5320.6 5583.9 4688.7 4730.7 4931.9 4983.2 4991.5 5340.6 5610.5 5906.1 6122.5 6132.6 3632.9 3869.0 4046.4 4049.0 4125.3 5597.4 6156.3 6380.6 6426.7 6462.4 3507.4 3990.9 4073.6 4086.9 4112.8 3466.7 4139.0 4153.6 4163.7 4168.8 4124.4 4941.5 4945.3 4953.8 4965.8 5490.6 5902.0 6176.3 6196.5 6198.4 1387.9 1405.5 1406.7 1412.6 1418.4 708.8 841.4 848.5 856.6 862.6 4323.0 4719.4 4765.1 4818.3 4825.0 4614.3 5153.0 5225.1 5260.5 5284.3 4124.9 4216.0 4502.5 4609.4 4802.6 2306.5 2640.5 2778.2 2778.4 2830.4 4723.9 5045.3 5376.3 5491.8 5515.1 4139.9 4787.9 5042.7 5201.6 5500.9 4800.0 5369.9 5371.9 5481.6 5500.2 4693.5 4881.3 4908.7 5277.6 5328.5 4281.6 5180.8 5216.2 5242.4 5258.7 5206.3 5436.7 5446.9 5463.8 5492.9 3360.9 3412.0 3474.0 3574.2 3608.9 4349.0 4697.4 5309.6 5316.6 5327.4 4535.9 4783.0 4907.5 4947.7 5134.9 4327.5 4470.4 5012.7 5045.8 5087.5 4570.3 4690.4 4744.6 4982.9 5042.4 4428.8 4676.5 5125.8 5144.5 5204.9 4409.1 4881.2 5003.7 5061.7 5103.5 19:24:12 INFO - PROCESS | 1654 | 19:24:12 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:24594.94 Median:22983.71 stddev:38254.93 (166.4%) stddev-sans-first:38320.24 19:24:12 INFO - PROCESS | 1654 | Values: 719.5 746.8 769.0 785.2 861.8 13153.9 13615.7 13774.2 13785.4 13792.3 14529.1 14640.3 15010.0 16383.8 16411.8 905.3 919.8 930.5 932.4 933.1 911.1 925.2 927.4 930.0 931.2 958.3 973.8 977.6 977.7 977.9 869.0 930.6 952.4 973.2 975.6 721.4 722.2 723.3 726.4 728.3 14030.2 14653.5 15325.5 15328.5 16222.5 12298.3 14578.4 14669.6 14791.1 15058.2 9954.0 11842.8 12027.6 12046.3 12266.4 3840.2 3871.7 3887.9 3961.2 4005.6 118999.0 121079.4 121743.0 122701.0 122847.4 10295.8 11323.1 11340.9 11384.4 11553.7 17288.8 20294.0 21981.9 22940.7 23026.8 6592.4 8012.2 8019.1 8039.7 8056.1 3517.3 4367.6 4485.6 4497.9 4613.2 3288.7 3338.8 3531.6 3635.7 3670.5 533.2 611.1 612.2 613.3 648.4 551.3 657.3 665.9 700.2 702.1 9359.4 9359.6 9672.3 9682.9 9981.3 652.3 660.3 672.3 699.5 700.4 4509.3 4674.8 4693.4 4727.9 4751.3 90964.0 131994.0 134566.0 137259.0 149115.3 107583.0 117334.0 118444.0 120359.0 121696.0 90133.5 90446.5 112218.4 118998.4 120467.0 9249.6 9872.6 10260.4 10399.9 10443.4 58106.4 58307.4 64942.0 67382.0 67655.7 93180.0 98913.5 100659.0 102804.0 102922.7 14349.1 14372.6 14377.0 14561.2 14898.3 15117.5 15370.8 15476.8 15756.3 16313.6 12174.5 14126.3 14131.9 14367.5 14550.0 14235.9 14334.0 14348.9 14533.4 15002.4 13684.2 14002.2 14041.6 14076.2 14480.9 10349.6 11455.5 11480.6 11577.8 11746.4 10817.3 10958.5 11542.0 11953.3 12218.3 19:24:12 INFO - PROCESS | 1654 | -------- Summary: end -------- 19:24:12 INFO - PROCESS | 1654 | 19:24:12 INFO - TEST-INFO | 1654: exit 0 19:24:12 INFO - TEST-OK | dromaeo_css | took 1112675ms 19:24:12 INFO - TEST-START | kraken 19:24:12 INFO - operating with platform_type : mac_ 19:24:12 INFO - Initialising browser for kraken test... 19:24:13 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/tmpTDFJ9g/profile http://localhost:49275/getInfo.html) 19:24:15 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 19:24:15 INFO - PROCESS | 1661 | colorDepth:24 19:24:15 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 19:24:15 INFO - PROCESS | 1661 | __metrics 19:24:16 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 19:24:16 INFO - TEST-INFO | 1661: exit 0 19:24:16 INFO - Browser initialized. 19:24:16 INFO - Running cycle 1/1 for kraken test... 19:24:16 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/tmpTDFJ9g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:24:28 INFO - PROCESS | 1663 | RSS: Main: 256339968 19:24:28 INFO - PROCESS | 1663 | 19:24:31 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 19:24:32 INFO - PROCESS | 1663 | RSS: Main: 269185024 19:24:32 INFO - PROCESS | 1663 | 19:24:34 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 19:24:35 INFO - PROCESS | 1663 | RSS: Main: 273596416 19:24:35 INFO - PROCESS | 1663 | 19:24:38 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 19:24:39 INFO - PROCESS | 1663 | RSS: Main: 273387520 19:24:39 INFO - PROCESS | 1663 | 19:24:41 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 19:24:42 INFO - PROCESS | 1663 | RSS: Main: 274345984 19:24:42 INFO - PROCESS | 1663 | 19:24:44 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:24:44 INFO - PROCESS | 1663 | RSS: Main: 274952192 19:24:44 INFO - PROCESS | 1663 | 19:24:47 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 19:24:48 INFO - PROCESS | 1663 | RSS: Main: 274219008 19:24:48 INFO - PROCESS | 1663 | 19:24:51 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 19:24:52 INFO - PROCESS | 1663 | RSS: Main: 275222528 19:24:52 INFO - PROCESS | 1663 | 19:24:55 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 19:24:55 INFO - PROCESS | 1663 | RSS: Main: 275578880 19:24:55 INFO - PROCESS | 1663 | 19:24:57 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:24:58 INFO - PROCESS | 1663 | RSS: Main: 275050496 19:24:58 INFO - PROCESS | 1663 | 19:24:59 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:25:00 INFO - PROCESS | 1663 | RSS: Main: 275234816 19:25:00 INFO - PROCESS | 1663 | 19:25:02 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:25:03 INFO - PROCESS | 1663 | RSS: Main: 275562496 19:25:03 INFO - PROCESS | 1663 | 19:25:06 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:25:06 INFO - PROCESS | 1663 | RSS: Main: 275800064 19:25:06 INFO - PROCESS | 1663 | 19:25:09 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:25:10 INFO - PROCESS | 1663 | RSS: Main: 275730432 19:25:10 INFO - PROCESS | 1663 | 19:25:12 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 19:25:12 INFO - PROCESS | 1663 | RSS: Main: 276844544 19:25:12 INFO - PROCESS | 1663 | 19:25:12 INFO - PROCESS | 1663 | __start_tp_report 19:25:12 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 19:25:12 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 19:25:12 INFO - PROCESS | 1663 | |i|pagename|runs| 19:25:12 INFO - PROCESS | 1663 | |0;ai-astar;103;116;105;114;116;116;108;114;113;115 19:25:12 INFO - PROCESS | 1663 | |1;audio-beat-detection;145;109;141;152;108;132;127;109;153;109 19:25:12 INFO - PROCESS | 1663 | |2;audio-dft;187;198;195;206;219;200;190;197;200;192 19:25:12 INFO - PROCESS | 1663 | |3;audio-fft;65;69;68;102;76;79;51;82;153;84 19:25:12 INFO - PROCESS | 1663 | |4;audio-oscillator;70;71;113;78;79;65;115;57;75;146 19:25:12 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;89;111;77;86;116;83;136;132;115;87 19:25:12 INFO - PROCESS | 1663 | |6;imaging-darkroom;91;111;111;156;147;98;148;153;95;93 19:25:12 INFO - PROCESS | 1663 | |7;imaging-desaturate;92;95;95;99;89;88;90;91;91;91 19:25:12 INFO - PROCESS | 1663 | |8;json-parse-financial;55;81;57;57;58;60;58;56;57;57 19:25:12 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;65;70;68;73;72;75;75;70;72;72 19:25:12 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;83;82;87;83;87;85;85;84;87;98 19:25:12 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;137;136;138;142;135;136;134;135;221;154 19:25:12 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;166;170;165;165;165;174;163;165;181;228 19:25:12 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;57;83;87;84;86;81;86;81;66;67 19:25:12 INFO - PROCESS | 1663 | __end_tp_report 19:25:12 INFO - PROCESS | 1663 | __start_cc_report 19:25:12 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1135 19:25:12 INFO - PROCESS | 1663 | __end_cc_report 19:25:12 INFO - PROCESS | 1663 | __startTimestamp1467771912460__endTimestamp 19:25:12 INFO - PROCESS | 1663 | 19:25:12 INFO - PROCESS | 1663 | ------- Summary: start ------- 19:25:12 INFO - PROCESS | 1663 | Number of tests: 14 19:25:12 INFO - PROCESS | 1663 | 19:25:12 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:112.00 Median:114.50 stddev:4.85 (4.2%) stddev-sans-first:3.91 19:25:12 INFO - PROCESS | 1663 | Values: 103.0 116.0 105.0 114.0 116.0 116.0 108.0 114.0 113.0 115.0 19:25:12 INFO - PROCESS | 1663 | 19:25:12 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:128.50 Median:136.50 stddev:18.73 (13.7%) stddev-sans-first:18.89 19:25:12 INFO - PROCESS | 1663 | Values: 145.0 109.0 141.0 152.0 108.0 132.0 127.0 109.0 153.0 109.0 19:25:12 INFO - PROCESS | 1663 | 19:25:12 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:198.40 Median:199.00 stddev:9.08 (4.6%) stddev-sans-first:8.65 19:25:12 INFO - PROCESS | 1663 | Values: 187.0 198.0 195.0 206.0 219.0 200.0 190.0 197.0 200.0 192.0 19:25:12 INFO - PROCESS | 1663 | 19:25:12 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:82.90 Median:72.50 stddev:28.08 (38.7%) stddev-sans-first:29.03 19:25:12 INFO - PROCESS | 1663 | Values: 65.0 69.0 68.0 102.0 76.0 79.0 51.0 82.0 153.0 84.0 19:25:12 INFO - PROCESS | 1663 | 19:25:12 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:86.90 Median:70.50 stddev:28.20 (40.0%) stddev-sans-first:29.24 19:25:12 INFO - PROCESS | 1663 | Values: 70.0 71.0 113.0 78.0 79.0 65.0 115.0 57.0 75.0 146.0 19:25:12 INFO - PROCESS | 1663 | 19:25:12 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:103.20 Median:80.00 stddev:21.41 (26.8%) stddev-sans-first:22.08 19:25:12 INFO - PROCESS | 1663 | Values: 89.0 111.0 77.0 86.0 116.0 83.0 136.0 132.0 115.0 87.0 19:25:12 INFO - PROCESS | 1663 | 19:25:12 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:120.30 Median:123.50 stddev:27.36 (22.2%) stddev-sans-first:26.89 19:25:12 INFO - PROCESS | 1663 | Values: 91.0 111.0 111.0 156.0 147.0 98.0 148.0 153.0 95.0 93.0 19:25:12 INFO - PROCESS | 1663 | 19:25:12 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:92.10 Median:91.50 stddev:3.31 (3.6%) stddev-sans-first:3.52 19:25:12 INFO - PROCESS | 1663 | Values: 92.0 95.0 95.0 99.0 89.0 88.0 90.0 91.0 91.0 91.0 19:25:12 INFO - PROCESS | 1663 | 19:25:12 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:59.60 Median:57.50 stddev:7.63 (13.3%) stddev-sans-first:7.91 19:25:12 INFO - PROCESS | 1663 | Values: 55.0 81.0 57.0 57.0 58.0 60.0 58.0 56.0 57.0 57.0 19:25:12 INFO - PROCESS | 1663 | 19:25:12 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:72.00 stddev:3.08 (4.3%) stddev-sans-first:2.32 19:25:12 INFO - PROCESS | 1663 | Values: 65.0 70.0 68.0 73.0 72.0 75.0 75.0 70.0 72.0 72.0 19:25:12 INFO - PROCESS | 1663 | 19:25:12 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.00 stddev:4.56 (5.3%) stddev-sans-first:4.69 19:25:12 INFO - PROCESS | 1663 | Values: 83.0 82.0 87.0 83.0 87.0 85.0 85.0 84.0 87.0 98.0 19:25:12 INFO - PROCESS | 1663 | 19:25:12 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:146.80 Median:137.50 stddev:26.73 (19.4%) stddev-sans-first:28.11 19:25:12 INFO - PROCESS | 1663 | Values: 137.0 136.0 138.0 142.0 135.0 136.0 134.0 135.0 221.0 154.0 19:25:12 INFO - PROCESS | 1663 | 19:25:12 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:168.00 stddev:19.69 (11.7%) stddev-sans-first:20.66 19:25:12 INFO - PROCESS | 1663 | Values: 166.0 170.0 165.0 165.0 165.0 174.0 163.0 165.0 181.0 228.0 19:25:12 INFO - PROCESS | 1663 | 19:25:12 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.80 Median:83.50 stddev:10.51 (12.6%) stddev-sans-first:8.01 19:25:12 INFO - PROCESS | 1663 | Values: 57.0 83.0 87.0 84.0 86.0 81.0 86.0 81.0 66.0 67.0 19:25:12 INFO - PROCESS | 1663 | -------- Summary: end -------- 19:25:12 INFO - PROCESS | 1663 | 19:25:13 INFO - TEST-INFO | 1663: exit 0 19:25:13 INFO - TEST-OK | kraken | took 60275ms 19:25:13 INFO - SUITE-END | took 1172s 19:25:13 INFO - Completed test suite (00:19:33) 19:25:13 INFO - javascript benchmark 19:25:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7448.843405174115, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3416.5558477397944, 3417.8632854685816, 3444.4316687746523, 3449.5688038995127, 3455.533502977098, 5838.153467747179, 5912.231409916711, 5918.319393269775, 5940.0, 5940.762369505225, 5746.367899531048, 5835.328937172216, 5910.172575839375, 5925.0, 6042.879142417149, 5362.115250983593, 5397.136458166694, 5435.157550579666, 5435.864103397407, 5478.58910581706, 153.4135040308541, 5448.536874365684, 5451.0, 5456.48163424474, 5506.91739623906, 5375.543078838304, 5382.59630527708, 5398.352197736258, 5406.54044406224, 5425.13197888336, 4428.468583769936, 5311.840644780663, 5425.104857698475, 5435.130379139358, 5439.075357189287, 5183.833637431586, 5193.221016847503, 5290.867728306823, 5327.254184414185, 5429.158480435539, 4991.425986011619, 5516.172574113875, 5947.613405128653, 5988.8502787430225, 6046.697665116727, 5609.27079479665, 6102.216595924226, 6269.811905642838, 6350.110984462179, 6370.140031095835, 6260.280067792171, 6322.683865806691, 6327.3988971047675, 6333.334999825044, 6356.427921487042, 5106.565941894906, 5824.893270278633, 5899.705014749288, 5961.642301461926, 5970.850728731816, 6214.906776398358, 6232.968835155886, 6288.937110628926, 6388.8083357499345, 6409.359064093646, 6230.532710046765, 6299.055141728686, 6301.779437719658, 6310.495160387158, 6312.210973628296, 6315.778947736807, 6333.809985700344, 6353.714082866282, 6357.078223657544, 6358.078078678565, 6165.075238714228, 6214.161088253119, 6254.312025677172, 6298.937010629835, 6333.334999825044, 6185.381461853779, 6269.0909818076125, 6291.433770960635, 6301.842453938688, 6323.588966717149, 5049.0, 5093.592512598983, 5105.183170692671, 5121.359830021247, 5128.999845030184, 4428.468583769968, 4439.067795762861, 4440.888977775517, 4498.302763071729, 4590.472095708969, 5750.137479378043, 5763.971180144156, 5788.797392091256, 5794.362620111784, 5813.59304848665, 6153.261608606996, 6298.716557754912, 6300.779472718433, 6307.842303942438, 6312.4634406076, 5800.767969281266, 5888.676122813201, 5926.1999630049395, 5937.139114828412, 6010.519158467312, 4987.900241995139, 5289.656172348785, 5557.305336832896, 5561.833145005657, 5590.608657394025, 6194.473469754941, 6440.32376600469, 6445.258795238514, 6454.32229615893, 6455.289918109004, 6262.405071518198, 6292.653904035322, 6313.6843157841, 6319.304876463493, 6333.714982825692, 5707.743151558107, 6134.325224225242, 6411.775587854403, 6413.0701048348665, 6419.582727122722, 6169.136320915165, 6250.49996000328, 6314.526410519137, 6320.683965801783, 6330.335314792064, 6235.438810506895, 6254.468370188585, 6312.43188113072, 6313.589616675085, 6313.621182729051, 4967.559407771851, 6268.749250029948, 6282.874342513215, 6283.465905397909, 6286.811395658137, 6127.14220009208, 6178.567500275118, 6184.0, 6194.5973511721595, 6247.687615619292, 5827.708614569339, 5868.589198756046, 6064.696765161812, 6082.0, 6115.510759139169, 6229.096780966644, 6238.719257633326, 6268.498520118471, 6289.874202516015, 6293.118963345044, 5972.910406343995, 6041.154238406539, 6113.633182008915, 6147.846303842261, 6163.414475624809], "value": 5752.166366915626, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [454.5477250136115, 479.46060681733053, 544.0370544136879, 546.978120875165, 566.6656672563187, 39887.80056099719, 42280.99999999996, 42326.57673423265, 42416.0, 42557.93605159873, 43207.56792432075, 43395.91510212246, 43705.7814710926, 43868.34197487032, 43872.90317742058, 9610.183134433564, 9772.120509154174, 9781.021897810233, 9794.971527989564, 9817.6072957082, 9679.564419601134, 9735.610575576968, 9780.266480013992, 9805.705828825112, 9813.460259685715, 9772.120509154174, 9786.90213097867, 9804.509774511282, 9838.311318207729, 9851.965543617924, 9774.120329170373, 9824.803503929917, 9825.164860986824, 9830.115289623896, 9859.161971232383, 9663.178629816473, 9755.073268039525, 9771.462569558671, 9778.364406313567, 9779.608815647365, 40549.79725101356, 40740.38889416661, 40921.59078409208, 41239.0, 41265.58734412648, 3121.82829944353, 3369.029117965993, 3411.4371128763723, 3419.247765491588, 3591.174029973121, 30500.69499305001, 30718.38563228723, 31639.36721265562, 31761.205969850707, 32607.184820379443, 3222.4038552867796, 3237.0, 3237.4172648923186, 3242.789218700777, 3356.3790698720813, 451793.0, 455929.0, 457420.0, 459164.9999999967, 461327.69336153107, 35247.11882202965, 35658.82170589182, 35715.0, 35723.82138089345, 35747.92756217318, 35886.46170307448, 36039.4594081089, 36280.81859590738, 36537.0, 36720.449193262124, 16588.75116873248, 17040.89234199773, 17078.743818842726, 17163.31346746116, 17233.310667573158, 12565.371731413576, 12977.35113244334, 13073.607791766262, 13102.951763858868, 13111.934440327737, 17665.470035898943, 17958.461246162635, 19911.800881991283, 20271.0, 20551.58896822085, 8107.027156741229, 8482.0, 8573.27127194183, 8621.956890215508, 8627.921509811273, 880.7401816464159, 880.766596851822, 892.3931726425963, 913.9314551408671, 982.189693502863, 28086.578701319497, 31110.066697999097, 31432.37135257282, 31591.431176842885, 32353.676463235537, 1015.6035451254525, 1076.61529711689, 1082.9620963266404, 1106.3251416635846, 1188.9227200231958, 13601.795973060413, 15707.136107513968, 16359.83640163607, 16523.33906643745, 16579.50261492157, 682272.0, 692896.0, 693067.0, 704981.0, 706588.0, 60855.69572152111, 61178.0, 61816.381836181965, 61838.69080654568, 62090.0, 1257.264500267354, 1402.5161319345013, 1412.971740565183, 1449.6665766873678, 1449.746294398476, 30157.849210753804, 31001.0, 31178.064658060295, 31213.531797023516, 31540.0, 54506.45493545172, 54760.452395475535, 54873.725631371584, 54934.0, 54958.45041549533, 588470.0, 589517.0, 589633.0, 589702.0, 590409.0, 27435.45129097367, 27586.0, 27663.72336276692, 27835.44329113366, 28847.278818029718, 51033.74483127561, 51307.48692513027, 52079.0, 53054.73472632612, 54470.63823404288, 41558.79220603878, 41736.165276694905, 42451.787741061096, 42652.78673606736, 43131.137377252904, 42203.788981054895, 42356.788216058725, 42438.0, 42840.92897677583, 43398.78300608477, 34632.82683586566, 39177.0, 39422.01444963899, 40543.3918491217, 41165.382519261635, 29165.56251656269, 35498.46752298666, 35882.10294742652, 36322.09194770152, 36750.26499470049, 25849.224523264333, 26605.86697066502, 26803.463930721668, 27185.72814271832, 27390.904363826023], "value": 20021.401482933597, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.183818466666, 387.2931899283808, 389.7120018339387, 390.6132928400883, 414.4736185044993, 15027.248637568133, 20759.273425430096, 21302.46743831401, 22068.88965555172, 22103.33689989301, 21142.26002089927, 21506.032228549713, 21609.0, 21862.672059919114, 21939.451513712163, 5902.616329938562, 6020.759169633209, 6054.878902421949, 6165.0, 6228.781992630259, 6034.577579569432, 6051.273847138327, 6061.151438798572, 6153.692315384235, 6158.538109641772, 4809.278608208761, 5447.937652157831, 6094.512439004891, 6102.969485152568, 6120.081987701858, 4797.808087676489, 6105.450509454148, 6129.632222066691, 6140.6929653517145, 6159.692015399234, 5154.5103215194495, 5253.185756207794, 5284.524392804666, 5313.946860531384, 5457.099578569531, 25253.0, 26123.73876261251, 26460.470790584273, 26488.73511264882, 26656.200313990612, 2410.4937963027787, 2756.9172924812287, 2782.0680072175846, 2937.397833444139, 3024.002079313821, 15862.762058569131, 15889.920550397173, 15993.440229591908, 16006.919965400099, 16300.673986520203, 1850.8519318454626, 1852.832715389296, 1924.316867512027, 1945.9027048647652, 1963.901804909763, 64878.675606622135, 92645.53677231638, 128847.0, 129419.0, 130564.0, 10692.89307106919, 11003.504842281956, 11096.223264371578, 11304.930225118951, 11375.488103035217, 13814.723705525834, 13854.238016909167, 13858.65353366174, 13863.514776982756, 13874.722505549833, 6830.091127768522, 8465.40742148056, 8547.188017138362, 8742.519161446182, 8870.467771933705, 8841.911580884238, 8894.599743011451, 8897.866532002025, 8957.820843583091, 8983.236424903826, 5882.647041177543, 6519.348065193442, 6709.966450167718, 6845.110135682429, 6867.862642747217, 1836.7061270196705, 1862.3574866670976, 1868.5795695968297, 1869.2522990803516, 1870.9812901870807, 872.9781755456164, 898.6180873128894, 932.7248461703814, 966.0291407135784, 976.2190247801731, 22349.32952011442, 22532.887335563544, 22693.88653056757, 22765.772342276698, 22777.202797901995, 890.9198172164407, 954.9379290346244, 984.7636567223815, 1025.1747343388645, 1049.5172220778375, 10887.673369798918, 11521.53913843437, 11910.585745235385, 11975.341356225492, 12080.818787718192, 628941.0, 635204.0, 643219.0, 649941.0, 654780.0, 135652.3217383907, 141670.29164854315, 144479.55520444873, 146327.26836365962, 146751.0, 945.4091193004373, 996.7707427291908, 999.7400675824338, 1000.1448761309122, 1002.674130907458, 19468.707969380754, 19672.11475483635, 19712.704309435656, 19750.901245493682, 19897.403077907686, 54707.452925470236, 56178.43821561732, 57153.85692286214, 57361.852762945346, 58531.0, 83992.58003709943, 84151.5792421034, 84235.5788221055, 84288.0, 84636.0, 7824.92175078242, 8061.234182752629, 8160.8775868360835, 8185.959070204611, 8281.461704989157, 9107.453552786854, 11265.7746845061, 12709.4280757368, 12979.091463597457, 13666.794998074838, 11563.710907227387, 11605.30368177912, 11707.531698732297, 11817.468213930222, 11895.929366356724, 11397.886021139682, 11417.257878237888, 11422.714432139262, 11653.6503904883, 11808.940955295513, 9995.350302230332, 11880.702982425162, 12005.75988480208, 12019.21875078117, 12091.637250882488, 8133.186681331819, 8221.54781487024, 8340.958295208486, 8460.280876125353, 8473.279771219515, 8939.374243802871, 11744.412779361168, 11804.291742495478, 11902.464389102684, 11948.940255298668], "value": 10033.290421952655, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1555.2301610702698, 1595.9680806383872, 1832.477743843005, 1922.3848368522079, 1923.0673123535091, 7998.840023199533, 8485.363597730171, 8574.44266122703, 8946.015938246795, 8959.372843900921, 7489.28851759082, 8603.741887743363, 8612.827743445127, 8727.86908196376, 8762.561871906411, 2176.9564608707815, 2197.923072692456, 2200.8569442986154, 2206.6028114939304, 2211.5355775287208, 2336.380859072347, 2352.0826877517784, 2359.044586942291, 2365.420471984366, 2378.4291769975252, 2345.741968383485, 2367.9408014799596, 2368.502614450959, 2388.128333158393, 2388.9044438222536, 2325.8837058147196, 2339.1345202275097, 2342.437814924423, 2346.6597343385197, 2349.424391024193, 2332.300309907021, 2335.859848409101, 2337.0, 2339.812814974798, 2345.3667509772436, 8767.561621918878, 8848.557572121368, 8867.645294188225, 8900.688475903313, 8922.330825188072, 5232.3459567554055, 5250.9474905250845, 5255.605829562798, 5310.0, 5313.946860531384, 3512.5609298837644, 3624.9456258156147, 3642.690371318441, 3674.1365779041903, 3680.7791532508136, 990.2078337330107, 1003.7892042671048, 1067.8238090715022, 1094.2996482251365, 1107.595727559443, 11424.657260282205, 11494.252873563191, 11592.420378981018, 11615.535378584846, 11623.709407264885, 4600.217962946307, 4614.76926153691, 4772.594329482033, 4809.567138957511, 4818.807247710122, 9882.950585247172, 9896.55465504054, 9916.950415247878, 9948.552315145836, 9963.053509916546, 5328.866778330495, 5336.012837625051, 5344.518993290545, 5350.143976963667, 5357.1696387060065, 4366.388705581221, 4695.107929493385, 4882.804687812448, 4886.975565122151, 4915.631327650441, 3332.8000319980392, 4037.9798101009305, 4039.0, 4078.4290199372113, 4121.175764847043, 1094.5457635081352, 1328.3291937571464, 1334.5062326939094, 1339.7588434081958, 1341.47011930287, 814.7963009247688, 924.5700749151677, 931.2363861633531, 936.5972631768406, 942.2273735536794, 5312.495312945264, 5868.882622347529, 6049.089154420905, 6089.2997305310455, 6193.876122477615, 848.5714714069355, 959.8704174936433, 1011.544804837826, 1021.2493817044466, 1036.549101141006, 3966.2860685076384, 4044.3529035354204, 4075.97962010194, 4156.958430415718, 4167.6457501112745, 10481.947590262, 10584.629537966135, 10637.414942178255, 10802.567897284178, 10956.397398143019, 10636.149108071335, 10778.622748203932, 10803.297785643908, 10807.297525660806, 10858.67423977282, 8130.227628375294, 8390.958045209734, 8408.873866892001, 8410.411271210956, 8420.621072051772, 5730.426957304237, 5923.170756094237, 6007.609505382136, 6037.396260373927, 6085.9695701521205, 9747.415155090717, 10018.949905250718, 10030.949845250727, 10103.191744660557, 10146.340487868265, 9564.856527152237, 10039.29724919278, 10046.095851373411, 10280.742981425525, 10381.221408394249, 6577.473802095917, 6889.276625954202, 7047.7180912762915, 7083.327083927019, 7102.680379382837, 8417.28453081495, 8434.283085937519, 8485.618147183515, 8502.44734092282, 8521.190486903733, 7363.410927125924, 7527.924720752722, 7565.167831538416, 7568.051754167704, 7582.886256706043, 7337.26627337262, 7348.559086454829, 7399.630018499161, 7519.323260906326, 7579.772606821804, 6925.238223795479, 6959.478039147186, 6978.755743548952, 6991.056207412138, 7055.400290975324, 4853.272009198648, 4964.950350496449, 5012.624053195952, 5014.696178993415, 5102.387713474258, 5056.62075344358, 5128.358955130609, 5143.459936706592, 5147.202183661539, 5259.289995850511], "value": 4609.51118135502, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.40439653666687, 310.90051183621244, 317.83949105701623, 324.3011310625603, 326.9231730543323, 4593.3923126905565, 5557.805476808313, 5562.749676264568, 5654.123610840316, 5734.856628584287, 4958.876028099299, 5753.942460575393, 5791.725820319523, 5799.3620701722775, 5815.244018277628, 4330.696851220416, 4336.501302350239, 4352.194843953863, 4371.213181627306, 4387.5173730889655, 4047.615476529725, 4321.956780432187, 4328.7402755834755, 4339.414179085815, 4351.8685141863025, 4258.9148217035645, 4298.978505107486, 4309.418228539138, 4330.415393921828, 4348.7825608719595, 3673.989652845462, 3790.90522736931, 4320.589543993316, 4323.805428755713, 4346.739195648272, 3145.716885480295, 3579.6957258633047, 3711.183539621279, 3712.1647629283466, 3717.5724791649036, 4709.740964246965, 4832.685875418087, 5096.566791822699, 5320.574354051667, 5583.8604034899045, 4688.671792974493, 4730.739809310487, 4931.876703082416, 4983.177775667011, 4991.5258050485145, 5340.62615616907, 5610.4670056344585, 5906.055031195031, 6122.47958923492, 6132.570720049598, 3632.909177270563, 3869.0, 4046.352583586612, 4049.036217434542, 4125.278076336629, 5597.356304025048, 6156.261248650146, 6380.617162970237, 6426.710798014101, 6462.418382345564, 3507.3511400391008, 3990.940135897964, 4073.572274911092, 4086.8569600063856, 4112.753234805921, 3466.6879980801345, 4138.979305103455, 4153.626173644387, 4163.687723420756, 4168.791560421967, 4124.443200167939, 4941.505849415102, 4945.2582112683385, 4953.801847926043, 4965.751712414365, 5490.572451162647, 5902.026165682701, 6176.320604733476, 6196.504279657616, 6198.411150940653, 1387.937542810576, 1405.5291477354997, 1406.725688490755, 1412.6256542016374, 1418.3830033935271, 708.8263375473042, 841.4488510025943, 848.5121055393174, 856.6444925356033, 862.5644049754834, 4322.978385108117, 4719.433667959798, 4765.070811191854, 4818.325434439182, 4825.0, 4614.254518561451, 5152.9742351288005, 5225.126180600654, 5260.473952604709, 5284.339457567804, 4124.896877578025, 4215.97892010538, 4502.459704835375, 4609.423822022247, 4802.615790736732, 2306.5156317173582, 2640.524705553019, 2778.235985104072, 2778.4021939486643, 2830.433913217365, 4723.858284251478, 5045.268436076748, 5376.301080859542, 5491.807786727445, 5515.145152501369, 4139.8965025873995, 4787.946651736613, 5042.722650254272, 5201.609879259071, 5500.862478438071, 4799.952000480021, 5369.919451208235, 5371.892562148735, 5481.629592601849, 5500.22996780459, 4693.530646935279, 4881.290883559516, 4908.705477671351, 5277.627816767745, 5328.520433161034, 4281.636060934856, 5180.798160781728, 5216.191490319006, 5242.427271818516, 5258.686178081632, 5206.349206349207, 5436.662235238885, 5446.945530544644, 5463.781448742165, 5492.917606235989, 3360.8655653773576, 3412.0105169500566, 3473.965260347465, 3574.2136729919375, 3608.927821443609, 4348.956510434855, 4697.389339385858, 5309.557603502432, 5316.627836051439, 5327.387350454747, 4535.886602834956, 4782.976085119552, 4907.484714104968, 4947.6536642434685, 5134.897302053863, 4327.545607711145, 4470.441194850644, 5012.749362531932, 5045.84862454127, 5087.542121209109, 4570.337301091389, 4690.437147542317, 4744.6003428989225, 4982.875428114181, 5042.411640333284, 4428.844990425319, 4676.508966558598, 5125.795438072125, 5144.511271429208, 5204.947950520446, 4409.082049308561, 4881.243407271879, 5003.6975596106395, 5061.746912654279, 5103.540681338697], "value": 4013.3739386368475, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.4963525532129, 746.7983644416008, 769.0271806165206, 785.2226295966991, 861.7587075618827, 13153.934230328847, 13615.659608509792, 13774.242416667092, 13785.448582056706, 13792.310384480787, 14529.055611385253, 14640.26798660068, 15010.0, 16383.7712171587, 16411.753823692656, 905.2576886952702, 919.7700574856286, 930.502181332987, 932.4125800745554, 933.10421994885, 911.1162172692477, 925.2228128372166, 927.4342650982895, 930.0467021303151, 931.1898648176096, 958.3339578992603, 973.7760315127525, 977.5552123783662, 977.7408986618552, 977.911987921087, 868.9695860644847, 930.6226784359186, 952.4095061062151, 973.1922504321396, 975.6243846119224, 721.4228617106346, 722.2091809468624, 723.3092396761081, 726.4478995963053, 728.3299364584595, 14030.228337441436, 14653.487127950471, 15325.540233793005, 15328.463503777315, 16222.51332460028, 12298.262104273683, 14578.416863325454, 14669.636672596742, 14791.112533248039, 15058.171800550965, 9954.0, 11842.763144737142, 12027.639170824888, 12046.277223366626, 12266.448009839578, 3840.1935593525395, 3871.728978971473, 3887.8639247626197, 3961.16815468749, 4005.5794141615, 118999.0, 121079.39460302642, 121743.0, 122700.99999999911, 122847.3857630715, 10295.794084118426, 11323.094152467782, 11340.94329528347, 11384.430778461045, 11553.711157220969, 17288.827111728722, 20294.0, 21981.890090549445, 22940.655890161663, 23026.769732302797, 6592.406683398517, 8012.158723333966, 8019.117897031322, 8039.67841286342, 8056.09947617965, 3517.314123745845, 4367.5632436756705, 4485.573870482299, 4497.910041799146, 4613.169629466661, 3288.6546912574313, 3338.814720774139, 3531.629868518978, 3635.7273204509765, 3670.541182352206, 533.2001997004493, 611.1321922869447, 612.1980205930246, 613.3437222172322, 648.3969907985525, 551.3494076989111, 657.3328072006917, 665.8634979829123, 700.2332445971653, 702.0978043214445, 9359.408900486933, 9359.625614975324, 9672.274579406572, 9682.854757178648, 9981.301308908307, 652.3248437866785, 660.2901880478505, 672.3411057163909, 699.4963626189136, 700.4046560423599, 4509.346144808985, 4674.813007479731, 4693.413323334583, 4727.9299374156235, 4751.3348131261655, 90964.0, 131994.02008969872, 134566.0, 137259.0, 149115.25442372935, 107583.0, 117334.0, 118444.0, 120359.0, 121696.0, 90133.54933225423, 90446.54776726074, 112218.43890780494, 118998.40500797614, 120466.99999999825, 9249.630014799333, 9872.555734991798, 10260.435676037889, 10399.896001039893, 10443.425611591436, 58106.4189358101, 58307.4169258302, 64942.0, 67382.0, 67655.66172169108, 93180.0, 98913.51629725416, 100658.99341006496, 102804.0, 102922.73695367452, 14349.067310624776, 14372.568822935329, 14377.0, 14561.199134047729, 14898.32957516936, 15117.54647360581, 15370.769438458208, 15476.845231547992, 15756.290966906288, 16313.59216019609, 12174.513019479122, 14126.293685315488, 14131.858681413054, 14367.497137600134, 14550.0, 14235.928820355832, 14334.0, 14348.856511434751, 14533.418663253775, 15002.399904003718, 13684.247366394944, 14002.229877356844, 14041.648958775704, 14076.155430674193, 14480.85519144795, 10349.586016559253, 11455.541778328774, 11480.598179063692, 11577.826332604849, 11746.353950532803, 10817.296875703054, 10958.506867191156, 11542.0, 11953.282803031845, 12218.327991960528], "value": 7990.09318438296, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 116.0, 105.0, 114.0, 116.0, 116.0, 108.0, 114.0, 113.0, 115.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 109.0, 141.0, 152.0, 108.0, 132.0, 127.0, 109.0, 153.0, 109.0], "value": 128.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 198.0, 195.0, 206.0, 219.0, 200.0, 190.0, 197.0, 200.0, 192.0], "value": 198.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 68.0, 102.0, 76.0, 79.0, 51.0, 82.0, 153.0, 84.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 113.0, 78.0, 79.0, 65.0, 115.0, 57.0, 75.0, 146.0], "value": 86.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 111.0, 77.0, 86.0, 116.0, 83.0, 136.0, 132.0, 115.0, 87.0], "value": 103.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 111.0, 111.0, 156.0, 147.0, 98.0, 148.0, 153.0, 95.0, 93.0], "value": 120.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 95.0, 95.0, 99.0, 89.0, 88.0, 90.0, 91.0, 91.0, 91.0], "value": 92.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 81.0, 57.0, 57.0, 58.0, 60.0, 58.0, 56.0, 57.0, 57.0], "value": 59.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 68.0, 73.0, 72.0, 75.0, 75.0, 70.0, 72.0, 72.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 87.0, 83.0, 87.0, 85.0, 85.0, 84.0, 87.0, 98.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 138.0, 142.0, 135.0, 136.0, 134.0, 135.0, 221.0, 154.0], "value": 146.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 170.0, 165.0, 165.0, 165.0, 174.0, 163.0, 165.0, 181.0, 228.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 83.0, 87.0, 84.0, 86.0, 81.0, 86.0, 81.0, 66.0, 67.0], "value": 77.8, "unit": "score"}]}]} 19:25:13 INFO - Return code: 0 19:25:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:25:13 ERROR - # TBPL SUCCESS # 19:25:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:25:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:25:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:25:13 INFO - 2016-07-05 19:25:13.783 screenresolution[1668:10562] starting screenresolution argv=screenresolution get 19:25:13 INFO - 2016-07-05 19:25:13.786 screenresolution[1668:10562] Display 0: 1600x1200x32@60 19:25:13 INFO - 2016-07-05 19:25:13.792 screenresolution[1669:10565] starting screenresolution argv=screenresolution list 19:25:13 INFO - Available Modes on Display 0 19:25:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:25:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:25:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:25:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:25:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:25:14 INFO - Intel Iris: 19:25:14 INFO - Chipset Model: Intel Iris 19:25:14 INFO - Type: GPU 19:25:14 INFO - Bus: Built-In 19:25:14 INFO - VRAM (Dynamic, Max): 1536 MB 19:25:14 INFO - Vendor: Intel (0x8086) 19:25:14 INFO - Device ID: 0x0a2e 19:25:14 INFO - Revision ID: 0x0009 19:25:14 INFO - Displays: 19:25:14 INFO - Display: 19:25:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:25:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:25:14 INFO - Display Serial Number: 1600x1200 60 19:25:14 INFO - Main Display: Yes 19:25:14 INFO - Mirror: Off 19:25:14 INFO - Online: Yes 19:25:14 INFO - Rotation: Supported 19:25:14 INFO - Return code: 0 19:25:14 INFO - Running post-action listener: _resource_record_post_action 19:25:14 INFO - ##### 19:25:14 INFO - ##### Finished run-tests step (success) 19:25:14 INFO - ##### 19:25:14 INFO - Running post-run listener: _resource_record_post_run 19:25:14 INFO - Total resource usage - Wall time: 1208s; CPU: 55.0%; Read bytes: 31612416; Write bytes: 708952576; Read time: 191; Write time: 1927 19:25:14 INFO - TinderboxPrint: CPU usage
54.6% 19:25:14 INFO - TinderboxPrint: I/O read bytes / time
31,612,416 / 191 19:25:14 INFO - TinderboxPrint: I/O write bytes / time
708,952,576 / 1,927 19:25:14 INFO - TinderboxPrint: CPU idle
2,194.5 (45.4%) 19:25:14 INFO - TinderboxPrint: CPU system
974.9 (20.2%) 19:25:14 INFO - TinderboxPrint: CPU user
1,664.3 (34.4%) 19:25:14 INFO - TinderboxPrint: Swap in / out
434,851,840 / 0 19:25:14 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 392354304; Write bytes: 387421696; Read time: 29170; Write time: 764 19:25:14 INFO - run-tests - Wall time: 1174s; CPU: 55.0%; Read bytes: 30690816; Write bytes: 298306560; Read time: 180; Write time: 1109 19:25:14 INFO - Running post-run listener: _upload_blobber_files 19:25:14 INFO - Blob upload gear active. 19:25:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:25:14 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 19:25:14 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'] 19:25:14 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 19:25:14 INFO - (blobuploader) - INFO - Open directory for files ... 19:25:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:25:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:25:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:25:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:16 INFO - (blobuploader) - INFO - Done attempting. 19:25:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:25:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:25:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:25:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:16 INFO - (blobuploader) - INFO - Done attempting. 19:25:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:25:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:25:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:25:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:19 INFO - (blobuploader) - INFO - Done attempting. 19:25:19 INFO - (blobuploader) - INFO - Iteration through files over. 19:25:19 INFO - Return code: 0 19:25:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:25:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:25:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6483f4d6831cddc2976394c64cb8c4f366e228aaf378f0e060a74c8df00f0c62d1adc165290d7554cee508a2e81694f1a273b26c3c3f340ff6151dafb6760b9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/982d57a08ba6516c5661aec3948a404323966b295bfb4d1ff6a942162805bd8964c6884015009c42dd5f9bd1d0618ffdacba88128937670feb3dc067d39e6d0a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15bdc01542eabdb6ce002755267a1826803d8080d9725a76fb79acf164fe3b86fa1ea96c650499463a10ef53f0685341d92bf702c32e46dbdc53a21383a90055"} 19:25:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:25:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:25:19 INFO - Contents: 19:25:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6483f4d6831cddc2976394c64cb8c4f366e228aaf378f0e060a74c8df00f0c62d1adc165290d7554cee508a2e81694f1a273b26c3c3f340ff6151dafb6760b9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/982d57a08ba6516c5661aec3948a404323966b295bfb4d1ff6a942162805bd8964c6884015009c42dd5f9bd1d0618ffdacba88128937670feb3dc067d39e6d0a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15bdc01542eabdb6ce002755267a1826803d8080d9725a76fb79acf164fe3b86fa1ea96c650499463a10ef53f0685341d92bf702c32e46dbdc53a21383a90055"} 19:25:19 INFO - Running post-run listener: copy_logs_to_upload_dir 19:25:19 INFO - Copying logs to upload dir... 19:25:19 INFO - mkdir: /builds/slave/test/build/upload/logs 19:25:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1325.464010 ========= master_lag: 1.46 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 6 secs) (at 2016-07-05 19:25:21.287117) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 19:25:21.290079) ========= 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.v6IenCXnv0/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.Mdr3GC3Yx4/Listeners TMPDIR=/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6483f4d6831cddc2976394c64cb8c4f366e228aaf378f0e060a74c8df00f0c62d1adc165290d7554cee508a2e81694f1a273b26c3c3f340ff6151dafb6760b9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/982d57a08ba6516c5661aec3948a404323966b295bfb4d1ff6a942162805bd8964c6884015009c42dd5f9bd1d0618ffdacba88128937670feb3dc067d39e6d0a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15bdc01542eabdb6ce002755267a1826803d8080d9725a76fb79acf164fe3b86fa1ea96c650499463a10ef53f0685341d92bf702c32e46dbdc53a21383a90055"} build_url:https://queue.taskcluster.net/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011147 build_url: 'https://queue.taskcluster.net/v1/task/WGOvZ_t9QwW0Mj-3sg7bfw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6483f4d6831cddc2976394c64cb8c4f366e228aaf378f0e060a74c8df00f0c62d1adc165290d7554cee508a2e81694f1a273b26c3c3f340ff6151dafb6760b9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/982d57a08ba6516c5661aec3948a404323966b295bfb4d1ff6a942162805bd8964c6884015009c42dd5f9bd1d0618ffdacba88128937670feb3dc067d39e6d0a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15bdc01542eabdb6ce002755267a1826803d8080d9725a76fb79acf164fe3b86fa1ea96c650499463a10ef53f0685341d92bf702c32e46dbdc53a21383a90055"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 19:25:21.328208) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 19:25:21.328535) ========= 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.v6IenCXnv0/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.Mdr3GC3Yx4/Listeners TMPDIR=/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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.005232 ========= master_lag: 0.46 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 19:25:21.793068) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 19:25:21.793427) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 19:25:21.794630) ========= ========= Total master_lag: 2.02 =========