builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0311 starttime: 1474661694.88 results: success (0) buildid: 20160923101223 builduid: 0d68c3f7956543978445e623efb0f45e revision: 5a9ce5f4d4d6b16aba8456635f664c2f87574e86 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 13:14:54.880009) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 13:14:54.880358) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 13:14:54.880624) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 13:14:54.904336) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 13:14:54.904595) ========= 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.kq9e6qX7TC/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.0npSKYXThG/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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-09-23 13:14:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 173M=0s 2016-09-23 13:14:55 (173 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.445822 ========= master_lag: 0.41 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 13:14:55.760523) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 13:14:55.760851) ========= 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.kq9e6qX7TC/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.0npSKYXThG/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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.021152 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 13:14:55.809908) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 13:14:55.810225) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5a9ce5f4d4d6b16aba8456635f664c2f87574e86 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 5a9ce5f4d4d6b16aba8456635f664c2f87574e86 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kq9e6qX7TC/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.0npSKYXThG/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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-09-23 13:14:55,890 truncating revision to first 12 chars 2016-09-23 13:14:55,890 Setting DEBUG logging. 2016-09-23 13:14:55,890 attempt 1/10 2016-09-23 13:14:55,890 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5a9ce5f4d4d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 13:14:57,206 unpacking tar archive at: fx-team-5a9ce5f4d4d6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.590471 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 13:14:57.422947) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 13:14:57.423231) ========= script_repo_revision: 5a9ce5f4d4d6b16aba8456635f664c2f87574e86 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 13:14:57.423605) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 13:14:57.423873) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 13:14:57.442419) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-23 13:14:57.442688) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kq9e6qX7TC/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.0npSKYXThG/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 13:14:57 INFO - MultiFileLogger online at 20160923 13:14:57 in /builds/slave/test 13:14:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:14:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:14:57 INFO - {'append_to_log': False, 13:14:57 INFO - 'base_work_dir': '/builds/slave/test', 13:14:57 INFO - 'blob_upload_branch': 'Fx-Team', 13:14:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:14:57 INFO - 'branch': 'Fx-Team', 13:14:57 INFO - 'buildbot_json_path': 'buildprops.json', 13:14:57 INFO - 'config_files': ('talos/mac_config.py',), 13:14:57 INFO - 'default_actions': ('clobber', 13:14:57 INFO - 'read-buildbot-config', 13:14:57 INFO - 'download-and-extract', 13:14:57 INFO - 'populate-webroot', 13:14:57 INFO - 'create-virtualenv', 13:14:57 INFO - 'install', 13:14:57 INFO - 'run-tests'), 13:14:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:14:57 INFO - 'download_minidump_stackwalk': True, 13:14:57 INFO - 'download_symbols': 'ondemand', 13:14:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:14:57 INFO - 'tooltool.py': '/tools/tooltool.py', 13:14:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:14:57 INFO - '/tools/misc-python/virtualenv.py')}, 13:14:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:14:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:14:57 INFO - 'installer_path': 'installer.exe', 13:14:57 INFO - 'log_level': 'info', 13:14:57 INFO - 'log_name': 'talos', 13:14:57 INFO - 'log_to_console': True, 13:14:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:14:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:14:57 INFO - 'opt_config_files': (), 13:14:57 INFO - 'pip_index': False, 13:14:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:14:57 INFO - 'cmd': ('bash', 13:14:57 INFO - '-c', 13:14:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:14:57 INFO - 'enabled': True, 13:14:57 INFO - 'halt_on_failure': False, 13:14:57 INFO - 'name': 'check_screen_resolution'},), 13:14:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:14:57 INFO - 'cmd': ('bash', 13:14:57 INFO - '-c', 13:14:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:14:57 INFO - 'enabled': True, 13:14:57 INFO - 'halt_on_failure': False, 13:14:57 INFO - 'name': 'check_screen_resolution'},), 13:14:57 INFO - 'run_cmd_checks_enabled': True, 13:14:57 INFO - 'sps_profile': False, 13:14:57 INFO - 'sps_profile_interval': 0, 13:14:57 INFO - 'suite': 'dromaeojs-e10s', 13:14:57 INFO - 'system_bits': '32', 13:14:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:14:57 INFO - 'title': 't-yosemite-r7-0311', 13:14:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:14:57 INFO - 'use_talos_json': True, 13:14:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:14:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:14:57 INFO - 'work_dir': 'build'} 13:14:57 INFO - [mozharness: 2016-09-23 20:14:57.645147Z] Running clobber step. 13:14:57 INFO - Running pre-action listener: _resource_record_pre_action 13:14:57 INFO - Running main action method: clobber 13:14:57 INFO - rmtree: /builds/slave/test/build 13:14:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:14:58 INFO - Running post-action listener: _resource_record_post_action 13:14:58 INFO - [mozharness: 2016-09-23 20:14:58.744232Z] Finished clobber step (success) 13:14:58 INFO - [mozharness: 2016-09-23 20:14:58.744442Z] Running read-buildbot-config step. 13:14:58 INFO - Running pre-action listener: _resource_record_pre_action 13:14:58 INFO - Running main action method: read_buildbot_config 13:14:58 INFO - Using buildbot properties: 13:14:58 INFO - { 13:14:58 INFO - "project": "", 13:14:58 INFO - "product": "firefox", 13:14:58 INFO - "script_repo_revision": "production", 13:14:58 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 13:14:58 INFO - "repository": "", 13:14:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 13:14:58 INFO - "buildid": "20160923101223", 13:14:58 INFO - "pgo_build": "False", 13:14:58 INFO - "basedir": "/builds/slave/test", 13:14:58 INFO - "buildnumber": 27, 13:14:58 INFO - "slavename": "t-yosemite-r7-0311", 13:14:58 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 13:14:58 INFO - "platform": "yosemite_r7", 13:14:58 INFO - "scheduler": "tests-fx-team-macosx64-talos-8-3600", 13:14:58 INFO - "branch": "fx-team", 13:14:58 INFO - "repo_path": "integration/fx-team", 13:14:58 INFO - "revision": "5a9ce5f4d4d6b16aba8456635f664c2f87574e86", 13:14:58 INFO - "stage_platform": "macosx64", 13:14:58 INFO - "builduid": "0d68c3f7956543978445e623efb0f45e", 13:14:58 INFO - "slavebuilddir": "test" 13:14:58 INFO - } 13:14:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/YeL4aS1pTvWVBl8XjliyFw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 13:14:58 INFO - Running post-action listener: _resource_record_post_action 13:14:58 INFO - [mozharness: 2016-09-23 20:14:58.750119Z] Finished read-buildbot-config step (success) 13:14:58 INFO - [mozharness: 2016-09-23 20:14:58.750381Z] Running download-and-extract step. 13:14:58 INFO - Running pre-action listener: _resource_record_pre_action 13:14:58 INFO - Running main action method: download_and_extract 13:14:58 INFO - mkdir: /builds/slave/test/build/tests 13:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:58 INFO - trying https://queue.taskcluster.net/v1/task/YeL4aS1pTvWVBl8XjliyFw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 13:14:58 INFO - Downloading https://queue.taskcluster.net/v1/task/YeL4aS1pTvWVBl8XjliyFw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 13:14:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YeL4aS1pTvWVBl8XjliyFw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 13:15:00 INFO - Downloaded 1199 bytes. 13:15:00 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 13:15:00 INFO - Using the following test package requirements: 13:15:00 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:15:00 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:15:00 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 13:15:00 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:15:00 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 13:15:00 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:15:00 INFO - u'jsshell-mac.zip'], 13:15:00 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:15:00 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 13:15:00 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:15:00 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:15:00 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 13:15:00 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:15:00 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 13:15:00 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:15:00 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 13:15:00 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:15:00 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 13:15:00 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:15:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YeL4aS1pTvWVBl8XjliyFw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:15:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YeL4aS1pTvWVBl8XjliyFw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:15:00 INFO - Fetch https://queue.taskcluster.net/v1/task/YeL4aS1pTvWVBl8XjliyFw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:15:00 INFO - Expected file size: 16438921 13:15:07 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:15:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YeL4aS1pTvWVBl8XjliyFw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:15:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YeL4aS1pTvWVBl8XjliyFw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:15:07 INFO - Fetch https://queue.taskcluster.net/v1/task/YeL4aS1pTvWVBl8XjliyFw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:15:08 INFO - Expected file size: 16438921 13:15:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YeL4aS1pTvWVBl8XjliyFw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 13:15:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YeL4aS1pTvWVBl8XjliyFw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:15:14 INFO - Fetch https://queue.taskcluster.net/v1/task/YeL4aS1pTvWVBl8XjliyFw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 13:15:15 INFO - Expected file size: 14414059 13:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:16 INFO - trying https://queue.taskcluster.net/v1/task/YeL4aS1pTvWVBl8XjliyFw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:15:16 INFO - Downloading https://queue.taskcluster.net/v1/task/YeL4aS1pTvWVBl8XjliyFw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 13:15:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YeL4aS1pTvWVBl8XjliyFw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 13:15:19 INFO - Downloaded 111569633 bytes. 13:15:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YeL4aS1pTvWVBl8XjliyFw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:15:19 INFO - mkdir: /builds/slave/test/properties 13:15:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:15:19 INFO - Writing to file /builds/slave/test/properties/build_url 13:15:19 INFO - Contents: 13:15:19 INFO - build_url:https://queue.taskcluster.net/v1/task/YeL4aS1pTvWVBl8XjliyFw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:15:19 INFO - Running post-action listener: _resource_record_post_action 13:15:19 INFO - Running post-action listener: set_extra_try_arguments 13:15:19 INFO - [mozharness: 2016-09-23 20:15:19.750042Z] Finished download-and-extract step (success) 13:15:19 INFO - [mozharness: 2016-09-23 20:15:19.750159Z] Running populate-webroot step. 13:15:19 INFO - Running pre-action listener: _resource_record_pre_action 13:15:19 INFO - Running main action method: populate_webroot 13:15:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:15:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:15:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:15:19 INFO - '--tppagecycles', 13:15:19 INFO - '7'], 13:15:19 INFO - 'tests': ['tsvgm']}}, 13:15:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:15:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:15:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:15:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:15:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:15:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:15:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:19 INFO - 'talos_options': ['--disable-e10s'], 13:15:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:15:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:15:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:19 INFO - 'talos_options': ['--disable-e10s'], 13:15:19 INFO - 'tests': ['damp', 'tps']}, 13:15:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:19 INFO - 'tests': ['damp', 'tps']}, 13:15:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:15:19 INFO - 'tests': ['dromaeo_dom']}, 13:15:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:15:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:15:19 INFO - 'tests': ['basic_compositor_video']}, 13:15:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:15:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:15:19 INFO - 'tests': ['a11yr', 13:15:19 INFO - 'ts_paint', 13:15:19 INFO - 'tpaint', 13:15:19 INFO - 'sessionrestore', 13:15:19 INFO - 'sessionrestore_no_auto_restore', 13:15:19 INFO - 'tabpaint']}, 13:15:19 INFO - 'other-e10s': {'tests': ['a11yr', 13:15:19 INFO - 'ts_paint', 13:15:19 INFO - 'tpaint', 13:15:19 INFO - 'sessionrestore', 13:15:19 INFO - 'sessionrestore_no_auto_restore', 13:15:19 INFO - 'tabpaint']}, 13:15:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:15:19 INFO - 'ts_paint', 13:15:19 INFO - 'tpaint', 13:15:19 INFO - 'sessionrestore', 13:15:19 INFO - 'sessionrestore_no_auto_restore', 13:15:19 INFO - 'tabpaint']}, 13:15:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:15:19 INFO - 'ts_paint', 13:15:19 INFO - 'tpaint', 13:15:19 INFO - 'sessionrestore', 13:15:19 INFO - 'sessionrestore_no_auto_restore', 13:15:19 INFO - 'tabpaint']}, 13:15:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:15:19 INFO - 'tests': ['a11yr', 13:15:19 INFO - 'ts_paint', 13:15:19 INFO - 'tpaint', 13:15:19 INFO - 'sessionrestore', 13:15:19 INFO - 'sessionrestore_no_auto_restore', 13:15:19 INFO - 'tabpaint']}, 13:15:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:15:19 INFO - 'tests': ['a11yr', 13:15:19 INFO - 'ts_paint', 13:15:19 INFO - 'tpaint', 13:15:19 INFO - 'sessionrestore', 13:15:19 INFO - 'sessionrestore_no_auto_restore', 13:15:19 INFO - 'tabpaint']}, 13:15:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:15:19 INFO - 'tests': ['tsvgx', 13:15:19 INFO - 'tsvgr_opacity', 13:15:19 INFO - 'tart', 13:15:19 INFO - 'tscrollx', 13:15:19 INFO - 'cart']}, 13:15:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:15:19 INFO - 'tsvgr_opacity', 13:15:19 INFO - 'tart', 13:15:19 INFO - 'tscrollx', 13:15:19 INFO - 'cart']}, 13:15:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:19 INFO - 'talos_options': ['--disable-e10s'], 13:15:19 INFO - 'tests': ['tp5o']}, 13:15:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:19 INFO - 'tests': ['tp5o']}, 13:15:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:19 INFO - 'talos_options': ['--disable-e10s', 13:15:19 INFO - '--xperf_path', 13:15:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:15:19 INFO - 'tests': ['tp5n']}, 13:15:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:19 INFO - 'talos_options': ['--xperf_path', 13:15:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:15:19 INFO - 'tests': ['tp5n']}}, 13:15:19 INFO - 'talos.zip': {'path': '', 13:15:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:15:19 INFO - Running post-action listener: _resource_record_post_action 13:15:19 INFO - [mozharness: 2016-09-23 20:15:19.768816Z] Finished populate-webroot step (success) 13:15:19 INFO - [mozharness: 2016-09-23 20:15:19.768931Z] Running create-virtualenv step. 13:15:19 INFO - Running pre-action listener: _resource_record_pre_action 13:15:19 INFO - Running main action method: create_virtualenv 13:15:19 INFO - Creating virtualenv /builds/slave/test/build/venv 13:15:19 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 13:15:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:15:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:15:19 INFO - Using real prefix '/tools/python27' 13:15:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:15:20 INFO - Installing distribute.............................................................................................................................................................................................done. 13:15:23 INFO - Installing pip.................done. 13:15:23 INFO - Return code: 0 13:15:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:23 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 0x106bb2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b28570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b24ae550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069c6d30>, '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 0x1067ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1069beb20>, '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.kq9e6qX7TC/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.0npSKYXThG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 13:15:23 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 13:15:23 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 13:15:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kq9e6qX7TC/Render', 13:15:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:23 INFO - 'HOME': '/Users/cltbld', 13:15:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:23 INFO - 'LOGNAME': 'cltbld', 13:15:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:23 INFO - 'MOZ_NO_REMOTE': '1', 13:15:23 INFO - 'NO_EM_RESTART': '1', 13:15:23 INFO - 'PAGER': '/bin/cat', 13:15:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:23 INFO - 'PWD': '/builds/slave/test', 13:15:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:23 INFO - 'SHELL': '/bin/bash', 13:15:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0npSKYXThG/Listeners', 13:15:23 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 13:15:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:23 INFO - 'USER': 'cltbld', 13:15:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:23 INFO - 'XPC_FLAGS': '0x0', 13:15:23 INFO - 'XPC_SERVICE_NAME': '0', 13:15:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:23 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 13:15:23 INFO - Cleaning up... 13:15:23 INFO - Return code: 0 13:15:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:23 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 0x106bb2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b28570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b24ae550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069c6d30>, '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 0x1067ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1069beb20>, '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.kq9e6qX7TC/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.0npSKYXThG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 13:15:23 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 13:15:23 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 13:15:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kq9e6qX7TC/Render', 13:15:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:23 INFO - 'HOME': '/Users/cltbld', 13:15:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:23 INFO - 'LOGNAME': 'cltbld', 13:15:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:23 INFO - 'MOZ_NO_REMOTE': '1', 13:15:23 INFO - 'NO_EM_RESTART': '1', 13:15:23 INFO - 'PAGER': '/bin/cat', 13:15:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:23 INFO - 'PWD': '/builds/slave/test', 13:15:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:23 INFO - 'SHELL': '/bin/bash', 13:15:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0npSKYXThG/Listeners', 13:15:23 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 13:15:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:23 INFO - 'USER': 'cltbld', 13:15:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:23 INFO - 'XPC_FLAGS': '0x0', 13:15:23 INFO - 'XPC_SERVICE_NAME': '0', 13:15:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:23 INFO - Downloading/unpacking psutil>=3.1.1 13:15:23 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 13:15:23 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 13:15:23 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 13:15:23 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 13:15:23 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 13:15:23 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 13:15:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:15:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:15:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:15:27 INFO - Installing collected packages: psutil 13:15:27 INFO - Running setup.py install for psutil 13:15:27 INFO - building 'psutil._psutil_osx' extension 13:15:27 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 13:15:27 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 13:15:27 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 13:15:28 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 13:15:28 INFO - building 'psutil._psutil_posix' extension 13:15:28 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 13:15:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:15:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:15:28 INFO - ^ 13:15:28 INFO - 1 warning generated. 13:15:28 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 13:15:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:15:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:15:28 INFO - Successfully installed psutil 13:15:28 INFO - Cleaning up... 13:15:28 INFO - Return code: 0 13:15:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106bb2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b28570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b24ae550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069c6d30>, '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 0x1067ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1069beb20>, '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.kq9e6qX7TC/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.0npSKYXThG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 13:15:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:15:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:15:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kq9e6qX7TC/Render', 13:15:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:28 INFO - 'HOME': '/Users/cltbld', 13:15:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:28 INFO - 'LOGNAME': 'cltbld', 13:15:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:28 INFO - 'MOZ_NO_REMOTE': '1', 13:15:28 INFO - 'NO_EM_RESTART': '1', 13:15:28 INFO - 'PAGER': '/bin/cat', 13:15:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:28 INFO - 'PWD': '/builds/slave/test', 13:15:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:28 INFO - 'SHELL': '/bin/bash', 13:15:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0npSKYXThG/Listeners', 13:15:28 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 13:15:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:28 INFO - 'USER': 'cltbld', 13:15:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:28 INFO - 'XPC_FLAGS': '0x0', 13:15:28 INFO - 'XPC_SERVICE_NAME': '0', 13:15:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:15:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:15:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:15:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:15:31 INFO - Installing collected packages: mozsystemmonitor 13:15:31 INFO - Running setup.py install for mozsystemmonitor 13:15:31 INFO - Successfully installed mozsystemmonitor 13:15:31 INFO - Cleaning up... 13:15:31 INFO - Return code: 0 13:15:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106bb2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b28570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b24ae550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069c6d30>, '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 0x1067ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1069beb20>, '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.kq9e6qX7TC/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.0npSKYXThG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 13:15:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:15:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kq9e6qX7TC/Render', 13:15:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:31 INFO - 'HOME': '/Users/cltbld', 13:15:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:31 INFO - 'LOGNAME': 'cltbld', 13:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:31 INFO - 'MOZ_NO_REMOTE': '1', 13:15:31 INFO - 'NO_EM_RESTART': '1', 13:15:31 INFO - 'PAGER': '/bin/cat', 13:15:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:31 INFO - 'PWD': '/builds/slave/test', 13:15:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:31 INFO - 'SHELL': '/bin/bash', 13:15:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0npSKYXThG/Listeners', 13:15:31 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 13:15:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:31 INFO - 'USER': 'cltbld', 13:15:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:31 INFO - 'XPC_FLAGS': '0x0', 13:15:31 INFO - 'XPC_SERVICE_NAME': '0', 13:15:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:31 INFO - Downloading/unpacking jsonschema==2.5.1 13:15:31 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 13:15:31 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 13:15:31 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 13:15:31 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 13:15:31 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 13:15:31 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 13:15:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:15:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:15:34 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 13:15:34 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 13:15:34 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 13:15:34 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 13:15:34 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 13:15:34 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 13:15:34 INFO - Downloading functools32-3.2.3-2.tar.gz 13:15:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:15:34 INFO - warning: no files found matching '*.txt' 13:15:34 INFO - no previously-included directories found matching 'build' 13:15:34 INFO - no previously-included directories found matching 'dist' 13:15:34 INFO - no previously-included directories found matching '.git*' 13:15:34 INFO - Installing collected packages: jsonschema, functools32 13:15:34 INFO - Running setup.py install for functools32 13:15:34 INFO - warning: no files found matching '*.txt' 13:15:34 INFO - no previously-included directories found matching 'build' 13:15:34 INFO - no previously-included directories found matching 'dist' 13:15:34 INFO - no previously-included directories found matching '.git*' 13:15:34 INFO - Successfully installed jsonschema functools32 13:15:34 INFO - Cleaning up... 13:15:34 INFO - Return code: 0 13:15:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106bb2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b28570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b24ae550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069c6d30>, '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 0x1067ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1069beb20>, '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.kq9e6qX7TC/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.0npSKYXThG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 13:15:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:15:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kq9e6qX7TC/Render', 13:15:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:34 INFO - 'HOME': '/Users/cltbld', 13:15:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:34 INFO - 'LOGNAME': 'cltbld', 13:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:34 INFO - 'MOZ_NO_REMOTE': '1', 13:15:34 INFO - 'NO_EM_RESTART': '1', 13:15:34 INFO - 'PAGER': '/bin/cat', 13:15:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:34 INFO - 'PWD': '/builds/slave/test', 13:15:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:34 INFO - 'SHELL': '/bin/bash', 13:15:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0npSKYXThG/Listeners', 13:15:34 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 13:15:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:34 INFO - 'USER': 'cltbld', 13:15:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:34 INFO - 'XPC_FLAGS': '0x0', 13:15:34 INFO - 'XPC_SERVICE_NAME': '0', 13:15:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:15:35 INFO - Cleaning up... 13:15:35 INFO - Return code: 0 13:15:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106bb2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b28570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b24ae550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069c6d30>, '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 0x1067ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1069beb20>, '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.kq9e6qX7TC/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.0npSKYXThG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 13:15:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:15:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:15:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kq9e6qX7TC/Render', 13:15:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:35 INFO - 'HOME': '/Users/cltbld', 13:15:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:35 INFO - 'LOGNAME': 'cltbld', 13:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:35 INFO - 'MOZ_NO_REMOTE': '1', 13:15:35 INFO - 'NO_EM_RESTART': '1', 13:15:35 INFO - 'PAGER': '/bin/cat', 13:15:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:35 INFO - 'PWD': '/builds/slave/test', 13:15:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:35 INFO - 'SHELL': '/bin/bash', 13:15:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0npSKYXThG/Listeners', 13:15:35 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 13:15:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:35 INFO - 'USER': 'cltbld', 13:15:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:35 INFO - 'XPC_FLAGS': '0x0', 13:15:35 INFO - 'XPC_SERVICE_NAME': '0', 13:15:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:35 INFO - Downloading/unpacking blobuploader==1.2.4 13:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:37 INFO - Downloading blobuploader-1.2.4.tar.gz 13:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:15:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:15:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:38 INFO - Downloading docopt-0.6.1.tar.gz 13:15:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:15:39 INFO - Installing collected packages: blobuploader, requests, docopt 13:15:39 INFO - Running setup.py install for blobuploader 13:15:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:15:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:15:39 INFO - Running setup.py install for requests 13:15:39 INFO - Running setup.py install for docopt 13:15:39 INFO - Successfully installed blobuploader requests docopt 13:15:39 INFO - Cleaning up... 13:15:39 INFO - Return code: 0 13:15:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:39 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 0x106bb2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b28570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b24ae550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069c6d30>, '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 0x1067ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1069beb20>, '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.kq9e6qX7TC/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.0npSKYXThG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 13:15:39 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 13:15:39 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 13:15:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kq9e6qX7TC/Render', 13:15:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:39 INFO - 'HOME': '/Users/cltbld', 13:15:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:39 INFO - 'LOGNAME': 'cltbld', 13:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:39 INFO - 'MOZ_NO_REMOTE': '1', 13:15:39 INFO - 'NO_EM_RESTART': '1', 13:15:39 INFO - 'PAGER': '/bin/cat', 13:15:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:39 INFO - 'PWD': '/builds/slave/test', 13:15:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:39 INFO - 'SHELL': '/bin/bash', 13:15:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0npSKYXThG/Listeners', 13:15:39 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 13:15:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:39 INFO - 'USER': 'cltbld', 13:15:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:39 INFO - 'XPC_FLAGS': '0x0', 13:15:39 INFO - 'XPC_SERVICE_NAME': '0', 13:15:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:15:40 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-9au0PH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:15:40 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-WTx7Gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:15:40 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-UPImck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:15:40 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-kn68LB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:15:40 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-m51U_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:15:40 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-ESIVl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:15:40 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-P7dFo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:15:40 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-FeQ6We-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:15:41 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-dRK07Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:15:41 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-dW9sJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:15:41 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-bplDKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:15:41 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-D7lvTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:15:41 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-sxPvKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:15:41 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-2_Gha0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:41 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-vEdCBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:15:41 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-Evjxys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:15:41 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-98R44M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:15:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:15:41 INFO - Running setup.py install for manifestparser 13:15:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:15:42 INFO - Running setup.py install for mozcrash 13:15:42 INFO - Running setup.py install for mozdebug 13:15:42 INFO - Running setup.py install for mozdevice 13:15:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:15:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:15:42 INFO - Running setup.py install for mozfile 13:15:42 INFO - Running setup.py install for mozhttpd 13:15:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:15:42 INFO - Running setup.py install for mozinfo 13:15:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:15:43 INFO - Running setup.py install for mozInstall 13:15:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:15:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:15:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:15:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:15:43 INFO - Running setup.py install for mozleak 13:15:43 INFO - Running setup.py install for mozlog 13:15:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:15:43 INFO - Running setup.py install for moznetwork 13:15:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:15:43 INFO - Running setup.py install for mozprocess 13:15:43 INFO - Running setup.py install for mozprofile 13:15:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:15:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:15:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:15:43 INFO - Running setup.py install for mozrunner 13:15:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:15:44 INFO - Running setup.py install for mozscreenshot 13:15:44 INFO - Running setup.py install for moztest 13:15:44 INFO - Running setup.py install for mozversion 13:15:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:15:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:15:44 INFO - Cleaning up... 13:15:44 INFO - Return code: 0 13:15:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:44 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 0x106bb2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b28570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b24ae550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069c6d30>, '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 0x1067ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1069beb20>, '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.kq9e6qX7TC/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.0npSKYXThG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 13:15:44 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 13:15:44 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 13:15:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kq9e6qX7TC/Render', 13:15:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:44 INFO - 'HOME': '/Users/cltbld', 13:15:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:44 INFO - 'LOGNAME': 'cltbld', 13:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:44 INFO - 'MOZ_NO_REMOTE': '1', 13:15:44 INFO - 'NO_EM_RESTART': '1', 13:15:44 INFO - 'PAGER': '/bin/cat', 13:15:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:44 INFO - 'PWD': '/builds/slave/test', 13:15:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:44 INFO - 'SHELL': '/bin/bash', 13:15:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0npSKYXThG/Listeners', 13:15:44 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 13:15:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:44 INFO - 'USER': 'cltbld', 13:15:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:44 INFO - 'XPC_FLAGS': '0x0', 13:15:44 INFO - 'XPC_SERVICE_NAME': '0', 13:15:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:15:44 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-eEqSgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:15:44 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)) 13:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:15:44 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-eNLK1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:15:45 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)) 13:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:15:45 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-NXsGgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:15:45 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)) 13:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:15:45 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-uBFqy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:15:45 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)) 13:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:15:45 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-l2HTEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:15:45 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)) 13:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:15:45 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-SRBUP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:15:45 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)) 13:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:15:45 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-LB66vN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:15:45 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)) 13:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:15:45 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-FumgAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:15:45 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)) 13:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:15:45 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-Fiyhpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:15:45 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)) 13:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:15:45 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-wwwrYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:15:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 13:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:15:45 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-2pmO97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:15:46 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)) 13:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:15:46 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-mEewOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:15:46 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-XSeTSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:15:46 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)) 13:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:15:46 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-q3MmAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:46 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-rUR1QM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:46 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)) 13:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:15:46 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-YUgwvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:15:46 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)) 13:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:15:46 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-FTKg71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:15:46 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)) 13:15:46 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)) 13:15:46 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)) 13:15:46 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)) 13:15:46 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)) 13:15:46 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)) 13:15:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:15: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 13:15: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 13:15: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 13:15: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 13:15: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 13:15: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 13:15:49 INFO - Downloading blessings-1.6.tar.gz 13:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:15:49 INFO - Installing collected packages: blessings 13:15:49 INFO - Running setup.py install for blessings 13:15:49 INFO - Successfully installed blessings 13:15:49 INFO - Cleaning up... 13:15:49 INFO - Return code: 0 13:15:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:15:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:15:49 INFO - Reading from file tmpfile_stdout 13:15:49 INFO - Current package versions: 13:15:49 INFO - blessings == 1.6 13:15:49 INFO - blobuploader == 1.2.4 13:15:49 INFO - docopt == 0.6.1 13:15:49 INFO - functools32 == 3.2.3-2 13:15:49 INFO - jsonschema == 2.5.1 13:15:49 INFO - manifestparser == 1.1 13:15:49 INFO - mozInstall == 1.12 13:15:49 INFO - mozcrash == 0.17 13:15:49 INFO - mozdebug == 0.1 13:15:49 INFO - mozdevice == 0.48 13:15:49 INFO - mozfile == 1.2 13:15:49 INFO - mozhttpd == 0.7 13:15:49 INFO - mozinfo == 0.9 13:15:49 INFO - mozleak == 0.1 13:15:49 INFO - mozlog == 3.4 13:15:49 INFO - moznetwork == 0.27 13:15:49 INFO - mozprocess == 0.23 13:15:49 INFO - mozprofile == 0.28 13:15:49 INFO - mozrunner == 6.12 13:15:49 INFO - mozscreenshot == 0.1 13:15:49 INFO - mozsystemmonitor == 0.3 13:15:49 INFO - moztest == 0.7 13:15:49 INFO - mozversion == 1.4 13:15:49 INFO - psutil == 3.1.1 13:15:49 INFO - requests == 1.2.3 13:15:49 INFO - wsgiref == 0.1.2 13:15:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:49 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 0x106bb2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b28570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b24ae550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069c6d30>, '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 0x1067ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1069beb20>, '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.kq9e6qX7TC/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.0npSKYXThG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 13:15:49 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 13:15:49 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 13:15:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kq9e6qX7TC/Render', 13:15:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:49 INFO - 'HOME': '/Users/cltbld', 13:15:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:49 INFO - 'LOGNAME': 'cltbld', 13:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:49 INFO - 'MOZ_NO_REMOTE': '1', 13:15:49 INFO - 'NO_EM_RESTART': '1', 13:15:49 INFO - 'PAGER': '/bin/cat', 13:15:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:49 INFO - 'PWD': '/builds/slave/test', 13:15:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:49 INFO - 'SHELL': '/bin/bash', 13:15:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0npSKYXThG/Listeners', 13:15:49 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 13:15:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:49 INFO - 'USER': 'cltbld', 13:15:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:49 INFO - 'XPC_FLAGS': '0x0', 13:15:49 INFO - 'XPC_SERVICE_NAME': '0', 13:15:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:49 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)) 13:15:49 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)) 13:15:49 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)) 13:15:49 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)) 13:15:49 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)) 13:15:49 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)) 13:15:49 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)) 13:15:49 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)) 13:15:49 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)) 13:15:49 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)) 13:15:49 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)) 13:15:49 INFO - Cleaning up... 13:15:49 INFO - Return code: 0 13:15:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:50 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 0x106bb2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b28570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b24ae550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069c6d30>, '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 0x1067ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1069beb20>, '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.kq9e6qX7TC/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.0npSKYXThG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 13:15:50 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 13:15:50 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 13:15:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kq9e6qX7TC/Render', 13:15:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:15:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:15:50 INFO - 'HOME': '/Users/cltbld', 13:15:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:15:50 INFO - 'LOGNAME': 'cltbld', 13:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:50 INFO - 'MOZ_NO_REMOTE': '1', 13:15:50 INFO - 'NO_EM_RESTART': '1', 13:15:50 INFO - 'PAGER': '/bin/cat', 13:15:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:50 INFO - 'PWD': '/builds/slave/test', 13:15:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:15:50 INFO - 'SHELL': '/bin/bash', 13:15:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0npSKYXThG/Listeners', 13:15:50 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 13:15:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:15:50 INFO - 'USER': 'cltbld', 13:15:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:15:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:50 INFO - 'XPC_FLAGS': '0x0', 13:15:50 INFO - 'XPC_SERVICE_NAME': '0', 13:15:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:15:50 INFO - Cleaning up... 13:15:50 INFO - Return code: 0 13:15:50 INFO - Running post-action listener: _resource_record_post_action 13:15:50 INFO - Running post-action listener: _start_resource_monitoring 13:15:50 INFO - Starting resource monitoring. 13:15:50 INFO - [mozharness: 2016-09-23 20:15:50.286570Z] Finished create-virtualenv step (success) 13:15:50 INFO - [mozharness: 2016-09-23 20:15:50.287534Z] Running install step. 13:15:50 INFO - Running pre-action listener: _resource_record_pre_action 13:15:50 INFO - Running main action method: install 13:15:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:15:50 INFO - Reading from file tmpfile_stdout 13:15:50 INFO - Detecting whether we're running mozinstall >=1.0... 13:15:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:15:50 INFO - Reading from file tmpfile_stdout 13:15:50 INFO - Output received: 13:15:50 INFO - Usage: mozinstall [options] installer 13:15:50 INFO - Options: 13:15:50 INFO - -h, --help show this help message and exit 13:15:50 INFO - -d DEST, --destination=DEST 13:15:50 INFO - Directory to install application into. [default: 13:15:50 INFO - "/builds/slave/test"] 13:15:50 INFO - --app=APP Application being installed. [default: firefox] 13:15:50 INFO - mkdir: /builds/slave/test/build/application 13:15:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:16:25 INFO - Reading from file tmpfile_stdout 13:16:25 INFO - Output received: 13:16:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:16:25 INFO - Running post-action listener: _resource_record_post_action 13:16:25 INFO - [mozharness: 2016-09-23 20:16:25.070797Z] Finished install step (success) 13:16:25 INFO - [mozharness: 2016-09-23 20:16:25.070942Z] Running run-tests step. 13:16:25 INFO - Running pre-action listener: _resource_record_pre_action 13:16:25 INFO - Running main action method: run_tests 13:16:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:16:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:16:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:16:25 INFO - 2016-09-23 13:16:25.086 screenresolution[1943:12333] starting screenresolution argv=screenresolution get 13:16:25 INFO - 2016-09-23 13:16:25.089 screenresolution[1943:12333] Display 0: 1600x1200x32@60 13:16:25 INFO - 2016-09-23 13:16:25.095 screenresolution[1944:12335] starting screenresolution argv=screenresolution list 13:16:25 INFO - Available Modes on Display 0 13:16:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:16:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:16:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:16:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:16:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:16:25 INFO - Intel Iris: 13:16:25 INFO - Chipset Model: Intel Iris 13:16:25 INFO - Type: GPU 13:16:25 INFO - Bus: Built-In 13:16:25 INFO - VRAM (Dynamic, Max): 1536 MB 13:16:25 INFO - Vendor: Intel (0x8086) 13:16:25 INFO - Device ID: 0x0a2e 13:16:25 INFO - Revision ID: 0x0009 13:16:25 INFO - Displays: 13:16:25 INFO - Display: 13:16:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:16:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:16:25 INFO - Display Serial Number: 1600x1200 60 13:16:25 INFO - Main Display: Yes 13:16:25 INFO - Mirror: Off 13:16:25 INFO - Online: Yes 13:16:25 INFO - Rotation: Supported 13:16:25 INFO - Return code: 0 13:16:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:16:25 INFO - Python 2.7.3 13:16:25 INFO - Return code: 0 13:16:25 INFO - grabbing minidump binary from tooltool 13:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:16:25 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 0x1069c6d30>, '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 0x1067ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1069beb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:16:25 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 13:16:25 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 13:16:25 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 13:16:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:16:25 INFO - Return code: 0 13:16:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:16:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:16:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:16:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:16:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:16:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YeL4aS1pTvWVBl8XjliyFw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0311', '--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 13:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YeL4aS1pTvWVBl8XjliyFw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0311 --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 13:16:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kq9e6qX7TC/Render', 13:16:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:16:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:16:25 INFO - 'HOME': '/Users/cltbld', 13:16:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:16:25 INFO - 'LOGNAME': 'cltbld', 13:16:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:16:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:25 INFO - 'MOZ_NO_REMOTE': '1', 13:16:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:16:25 INFO - 'NO_EM_RESTART': '1', 13:16:25 INFO - 'PAGER': '/bin/cat', 13:16:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:25 INFO - 'PWD': '/builds/slave/test', 13:16:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:16:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:16:25 INFO - 'SHELL': '/bin/bash', 13:16:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0npSKYXThG/Listeners', 13:16:25 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 13:16:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:16:25 INFO - 'USER': 'cltbld', 13:16:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:16:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:25 INFO - 'XPC_FLAGS': '0x0', 13:16:25 INFO - 'XPC_SERVICE_NAME': '0', 13:16:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:16:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YeL4aS1pTvWVBl8XjliyFw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0311', '--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 13:16:25 INFO - mozversion application_buildid: 20160923101223 13:16:25 INFO - mozversion application_changeset: 5a9ce5f4d4d6b16aba8456635f664c2f87574e86 13:16:25 INFO - mozversion application_display_name: Nightly 13:16:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:16:25 INFO - mozversion application_name: Firefox 13:16:25 INFO - mozversion application_remotingname: firefox 13:16:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:16:25 INFO - mozversion application_vendor: Mozilla 13:16:25 INFO - mozversion application_version: 52.0a1 13:16:25 INFO - mozversion platform_buildid: 20160923101223 13:16:25 INFO - mozversion platform_changeset: 5a9ce5f4d4d6b16aba8456635f664c2f87574e86 13:16:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:16:25 INFO - mozversion platform_version: 52.0a1 13:16:25 INFO - using testdate: 1474661785 13:16:25 INFO - actual date: 1474661785 13:16:25 INFO - starting webserver on 'localhost:51860' 13:16:25 INFO - SUITE-START | Running 2 tests 13:16:25 INFO - TEST-START | dromaeo_css 13:16:25 INFO - operating with platform_type : mac_ 13:16:25 INFO - Initialising browser for dromaeo_css test... 13:16:25 INFO - TEST-INFO | started process 1954 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmp0slCd9/profile http://localhost:51860/getInfo.html) 13:16:28 INFO - PROCESS | 1954 | 2016-09-23 13:16:28.391 plugin-container[1956:12486] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c4b, name = 'com.apple.tsm.portname' 13:16:28 INFO - PROCESS | 1954 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:16:28 INFO - PROCESS | 1954 | 2016-09-23 13:16:28.394 plugin-container[1956:12486] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910f, name = 'com.apple.CFPasteboardClient' 13:16:28 INFO - PROCESS | 1954 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:16:28 INFO - PROCESS | 1954 | 2016-09-23 13:16:28.394 plugin-container[1956:12486] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:16:28 INFO - PROCESS | 1954 | __metrics Screen width/height:1600/1200 13:16:28 INFO - PROCESS | 1954 | colorDepth:24 13:16:28 INFO - PROCESS | 1954 | Browser inner width/height: 1024/689 13:16:28 INFO - PROCESS | 1954 | __metrics 13:16:28 ERROR - PROCESS | 1954 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 13:16:29 INFO - TEST-INFO | 1954: exit 0 13:16:29 INFO - Browser initialized. 13:16:29 INFO - Running cycle 1/1 for dromaeo_css test... 13:16:29 INFO - TEST-INFO | started process 1957 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmp0slCd9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:16:31 INFO - PROCESS | 1957 | 2016-09-23 13:16:31.887 plugin-container[1958:12606] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8823, name = 'com.apple.tsm.portname' 13:16:31 INFO - PROCESS | 1957 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:16:31 INFO - PROCESS | 1957 | 2016-09-23 13:16:31.889 plugin-container[1958:12606] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e03, name = 'com.apple.CFPasteboardClient' 13:16:31 INFO - PROCESS | 1957 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:16:31 INFO - PROCESS | 1957 | 2016-09-23 13:16:31.889 plugin-container[1958:12606] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:16:41 INFO - PROCESS | 1957 | RSS: Main: 239988736 13:16:41 INFO - PROCESS | 1957 | 13:17:31 INFO - PROCESS | 1957 | 1474661851086 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] 13:19:43 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:51860/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51860/tests/dromaeo/cssquery-ext.html) 13:19:44 INFO - PROCESS | 1957 | RSS: Main: 258048000 13:19:44 INFO - PROCESS | 1957 | 13:22:47 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:51860/tests/dromaeo/cssquery-ext.html (next: http://localhost:51860/tests/dromaeo/cssquery-jquery.html) 13:22:47 INFO - PROCESS | 1957 | RSS: Main: 271450112 13:22:47 INFO - PROCESS | 1957 | 13:25:49 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:51860/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51860/tests/dromaeo/cssquery-mootools.html) 13:25:50 INFO - PROCESS | 1957 | RSS: Main: 272867328 13:25:50 INFO - PROCESS | 1957 | 13:28:52 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:51860/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51860/tests/dromaeo/cssquery-prototype.html) 13:28:53 INFO - PROCESS | 1957 | RSS: Main: 270438400 13:28:53 INFO - PROCESS | 1957 | 13:31:55 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:51860/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51860/tests/dromaeo/cssquery-yui.html) 13:31:56 INFO - PROCESS | 1957 | RSS: Main: 275759104 13:31:56 INFO - PROCESS | 1957 | 13:34:59 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:51860/tests/dromaeo/cssquery-yui.html (next: http://localhost:51860/tests/dromaeo/cssquery-dojo.html) 13:34:59 INFO - PROCESS | 1957 | RSS: Main: 278384640 13:34:59 INFO - PROCESS | 1957 | 13:34:59 INFO - PROCESS | 1957 | __start_tp_report 13:34:59 INFO - PROCESS | 1957 | _x_x_mozilla_page_load 13:34:59 INFO - PROCESS | 1957 | _x_x_mozilla_page_load_details 13:34:59 INFO - PROCESS | 1957 | |i|pagename|runs| 13:34:59 INFO - PROCESS | 1957 | |0;dojo.html;3306.842605088218;3354.0440974322314;3368.4778859276807;3369.2250782320057;3379.817064027592;5576.832695019146;5608.018596745564;5615.606907516475;5641.605087643867;5675.2054712340305;5629.380768115514;5670.3479099903525;5679.659220446766;5714.314282286132;5768.509676677477;5106.76525464722;5118.104331741949;5146.202338637517;5235.214717792323;5250.553702935255;4700.670953033289;4935.815404302959;5267.209918512234;5294.205869119624;5301.575873930095;5030.2957585938;5114.462981386975;5185.092608793484;5192.1952097424955;5240;5153.9742301288625;5163.380394352702;5181.093308670967;5207.453217412193;5218.165093585046;5123.462036486189;5126.2054381570915;5130.102232109366;5134.229865520165;5141.562967147797;4514.0069184779295;5498.230247765316;5519.9448005519835;5533.197686335499;5583.6928968906695;5124.231365295198;6117.066276512122;6117.544242953886;6131.47882429994;6160.815175544741;6238.532110091761;6239.812805615838;6270.874582508324;6271.843203919939;6305.117283580303;5355.3841308249275;5643.746031428595;5763.682997435139;5772.191893134965;5818.5926985111055;4705.529447055267;4859.878503037452;5102.36220472441;6225.346338634468;6279.403456671609;4982.526659967298;6132.969335153296;6134.6625935573975;6147.508199344042;6155.415235552616;6065.2418447694035;6074.36219196978;6088.873558391623;6132.816015519542;6224.408681175281;6137.622145770991;6138.572327483795;6145.8156255312415;6157.507399408037;6203.720832562545;5571.693556854412;6178.165947597017;6180.412860778219;6186.381361863868;6196.225471816023;4114.485689288839;4808.687435316693;4835.298881662139;4850.83022094225;4894.95105048945;4341.696081274281;4346.630536404441;4385.451818522684;4436.489803672554;4466.865994020184;5734.168545560954;5776.624519406225;5809.390014048464;5847.415258474203;5889.558283128783;6108.633481991094;6135.508280839814;6181.938180618226;6204.100405441186;6211.9689401552705;5667.348254950651;5682.7442765075675;5766.192733017381;5775.913361299584;5825.1844741736195;5298.788048478094;5302.072137375943;5307.920381194285;5313.495217954288;5340.439253878365;6179.660118693335;6206.472449841724;6273.811785646438;6295.527835412271;6303.968480157753;6137.959273351923;6141.117811340085;6146.815595532141;6184.5980011299125;6283.403076707706;6267.091271765659;6269.028300613412;6280.654563999024;6289.056641503811;6294.402031806971;6023.00620397647;6028.608140470856;6067.848303792441;6103.84740381494;6134.509239260759;5665.773369065356;6165.969170154121;6243.37566243372;6278.529110316653;6467.708953097216;6086.939130608815;6104.20645316106;6124.14262003311;6125.908111378244;6130.111133885473;5898.675572843363;5937;6063;6100.572959892765;6119.388061193845;5712.5429965601825;5826.388229235869;5906.084556893688;5952.255968003999;5993.430624090704;6053.152558641706;6072.392760723892;6109.236345456818;6133.877322453437;6134.38656134383;5720.227769251098;5938;5938.584299099021;5953.821385358447;5964.821055368346 13:34:59 INFO - PROCESS | 1957 | |1;ext.html;460.6314948041566;461.68374663355604;523.6805548615343;540.4487422828713;543.0144288117069;31265.218369540744;41351.37972930405;41456.58543414565;41476.79261603688;41577.58422415775;29305;33646.15884602886;41239;42283;42343;9623.37448065877;9778.511074446285;9802.754931126708;9809.705708828747;9815.165710914582;9598.616055357777;9696.321257511978;9703.320767546275;9725.465099419529;9829.017098290185;8510.404271700983;9646.035396460367;9697.272704547151;9723.12491875731;9758.658446954358;9601.711948641552;9637.518124093802;9722.756931076708;9723.611055557805;9745.610175592969;9496.43021418717;9580.377275477073;9586.856197157049;9592.568334424968;9596.712098637052;39938.60061399378;40122;40132.398014029524;40156.795296141165;40361.99095022619;3275.0666060172975;3363.9663603363897;3391.932161356759;3402;3786.9053273668105;30513.389732205454;31230.687693123004;31267.37465250705;31335;31612.36775264505;3109.3159504908886;3116.812991220534;3119.298157914451;3151.889683861054;3231.418344697977;439109;440485;443627;446352;446426;32361.676383236336;33371.16572085669;56698;57132.14301785477;57168.856622868145;34412.96761097171;34609.48085778715;34820.65179348225;34886.30227395488;34983.475247871305;13404.798928015893;13632.454701811816;13741.381637826322;13798.241096739575;13807.309634518233;12056.216345937486;12175.086868484723;12206.694832629079;12345.135840491259;12353.444095015746;7662.501937374052;7688.807779805549;7765.456418050682;7771.494852834548;7890.053193616803;2817.21118086936;3275.755213019085;3282.163048422685;3294.6046474423224;3301.0756988043386;929.8558723397884;963.6964356227905;996.5864166371019;1025.477006726575;1033.9534720937577;29727;29826;30064.699353006188;30373.696263037527;30754.38491230163;1004.3923426327113;1065.3767545985531;1073.2487258918632;1079.3092420850662;1081.7782354617284;12700.237985720887;14536.491222807152;14843.40626374933;15464.38142474311;15700.68448354193;187015;189357.0532147358;650008;650451;652086;55694.88610227773;56154.15768763472;56295.155572666445;56396;56628.58428539237;1257.7485402025043;1264.8988080953686;1362.4822567424515;1369.5548946592398;1377.3457607636492;28436.715632843407;29326.26684332909;29443.411131777673;29876.850615746782;30148.09555713332;38051.80974095112;43379.481718139716;44969.100617986805;45186.322205167606;45366.31950520679;567989;568925;569655.1517242388;570425;570519;25497.490050199263;25954;26259;26328.4734305309;26445.942162314062;37780.62219377771;46540.06919861652;46806.29790553213;47229.52770472251;47601.523984761094;37996.62003379931;38519.614803851604;38690.568356068536;39851;40156.3976540358;29251;33210.6715731368;35629.75295864632;38080.80959595184;41049.589504105774;31588.684113159492;36451.27097458089;37420.81289593643;37529;38767;28718.856405717837;33640;34319.656803431644;34337.63463369177;34569.48145777765;25470.363240919127;25506.23481295564;25742.227733168034;25808.870955645103;26146.477070458102 13:34:59 INFO - PROCESS | 1957 | |2;jquery.html;303.55680706168994;354.1553395152561;374.5823406901306;378.464472771029;401.55026370465083;19032.61934761304;19628.705569416452;20200.898995505002;20697.482562935915;20863;20608;20643.17427302906;20998.160073597075;21045.47386315339;21110.683339749918;5956.97021514894;5980.7308671109795;6075.756969721206;6161.691915404234;6226.128342032119;6029.547783916224;6129.38706129388;6151.8769624607485;6154.138420621117;6163.506919446433;5851.824445266649;6050;6105.847353816146;6113.052476866093;6116.266048074215;5949.018411962021;5992.161097446361;6057.515398768088;6105.236845394348;6116.663583502906;4617.145828021827;5097.847064588032;5267.893742314119;5277.604179686539;5304.946950530484;25584.48831023369;25602.743972560223;25659.48681026369;25694.229173124837;25892.22323330303;2241.181968581472;2374.7150341959077;2498.400383907849;2899.913002609925;3172.0959526534825;15056;15665.921670391575;15709.057456552644;15731.685366292724;16182.271797769128;1865.7761068671712;1949.1618604000273;1953.1601411393094;1966.783653798081;1974.3385965701507;87216.12783872207;107381;109141;114182.85817141888;115104.42447787791;8856.05166863289;9003.864942025875;9190.63237470507;11113.611023614134;11256.774864502664;11288.887111128948;13974.790378144337;13989.580312590639;14001.929990349983;14014.579562613138;6333.556651034383;7972.521648701097;8021.312860191901;8099.635516401776;8163.346932245406;8412.705555305534;8467.49195048299;8472.830543389098;8637.91362086371;8646.221840034426;3405.7615966882577;3705.8326627112374;3914.549826769901;3929.3300347352833;3969.940450893239;1916.3197065041988;1935.2936178295101;1935.3613307608455;1936.3610008697096;1954.2280799084567;711.491283732134;794.7139029949213;831.3556993330218;834.8330333933237;901.1661269316909;20573.69139462909;21320.253791117237;21473;21688.34934951954;21774.564508710053;891.5453118909403;906.859436787299;951.1344676344494;966.1111777165025;967.1102585621245;11006.944965275123;11377.975982161644;11501.482433290523;11504.884951150549;11523.366214858095;473652;479397;480936;594541;601469;78434.21565784383;81044.18955810484;128910.85648668327;137988.31005845108;139060;975.317277905469;989.6931951095039;1005.7133716890797;1017.9796404071877;1019.4393083803878;16653.91673041627;19101.617967640846;19460.4161875144;19798.307059252857;19912.90043549773;53701;53985.73007134939;54622.726886365315;55245.44754552403;55957.440425595225;81687.59156204181;82023.5898820502;82657.93355165928;82877.75683364875;84409;6888.483363747639;7109.466789990668;7211.81005134147;7474.103107627119;7995.12053674107;11058.060064894253;12579.496820127459;12684.87315126837;12955.805662914876;13108;8910.465372077697;10258.333208341433;10799.838002430128;10950.890491094988;11242.931921467447;9677.70966870995;9798.216142708709;10978.396188209725;10990.780184396108;11121;9766.560504777444;10399.844002340122;11110.944445277722;11255.324680519196;11567.537298507965;6880;8036.307836874713;8112.18878112184;8141.307988820779;8197.754067377988;8937.374383793072;9935.65225217114;10297.12474439681;10483.580656773644;10616.991385818645 13:34:59 INFO - PROCESS | 1957 | |3;mootools.html;1524.5959820647524;1535.1479928639603;1737.2442987300526;1822.5625849796054;1834.4680042787584;7817.765467035983;8053.23494268045;8273.255407013368;8887.244584210343;8930.59812308446;8381.95809020954;8647.264982476498;8699.73900782976;8776.824463510726;8788.64845406183;2354.835161538693;2360.799332056777;2393.1982785766704;2396.269137912936;2397.6643269942224;2019.8182163605272;2376.988115059431;2400.603900356439;2415.4685969086772;2426.9393265168424;2366.5976783946685;2386.642003699442;2395.9281221563383;2408.0127147869375;2417.2385698505004;2357.0571771291447;2377.037299893546;2387.8328517003815;2391.294568102414;2395.293388450394;2337.3805941425535;2369.07606033647;2387.021321258293;2390.4740956989435;2401.5196960607773;8761.08008659088;8766.21104100634;8887.111288871061;8917.33120015995;8952.462852228888;5228.398734145584;5353.892922141536;5356.571474282087;5361.329833770778;5367.597430192751;3573.1960308930543;3596.7482276240676;3612.945805812915;3662.6703596676425;3665.9083522911874;1069.2461814420815;1070.6359837655157;1075.2634445404922;1078.7680648660498;1088.9455527223606;11507.827382589352;11562.653120406401;11578.826317605242;11646.475908584134;11649.068074554016;4566.931496027562;4597.241455159861;4742.312364707098;4800.687955282895;4813;8294.543800091053;9782.461964592016;9848.21214302854;9877.802443951081;9934.751631209278;4760.238361862085;5281.102212623863;5297.152455607084;5306.495882891119;5316.441773613715;4333.414988976511;4491.640668746492;4701.294805779161;4827.444843843003;4859.319695242669;3249.415105281072;3796.8291426885858;3882.9223415531533;3978.482797236341;4001.3597824347967;1127.21095233337;1218.0194943070912;1268.530643661851;1281.4105511464832;1290.1549485087282;861.1517655109712;870.7170169694874;877.6533269358567;912.9452232866049;925.1303774451993;4912.410510738734;5646.030415519126;5666.178404131378;5925.466707996301;5987.43119403656;411.8290909272678;415.9147374788161;430.26639579517473;433.62058199075807;436.5154678307077;3843.404272337792;3895.2599006188734;4005.439238506611;4019.8392064317686;4021.075152714892;10280.948595256976;10557.841632375521;10673.252872298865;10680.51937662807;10785.676429707122;10624.521896514676;10627;10665.520051597698;10670.733231669115;10731.570737170427;8028.558429286329;8038.598070096472;8090.4336696431865;8124.55314957683;8162.265396114378;5671;5704.1443783432815;5713.285839270091;5758.568107392046;5874.441928016831;9415.435073895589;9598.184154346958;9798.706038818847;9874.012598740068;9906.554205060933;9742.61029558838;9848.261380396356;9932.553035113293;9988.001199880244;10116.393016419039;6800.693968771318;6999.440044796303;7181.533200341961;7356.44826638015;7518.36093932;7975.162607926084;8151.103378628465;8212.384071194565;8242.381821363302;8258.380621453294;6442.774502892376;7262.419006479575;7467.365273951557;7533.924660753322;7548.8490230196185;7307.744228951961;7323.707051717872;7346.338829505156;7351.338379545867;7428.9628551856895;6865.107536020485;6881.243063262937;6927.134108236471;6931.930680693128;6933.445324374139;4873.756312184448;4950.554450099508;4965.1807451770055;4986.301917731448;5034.521720436553;4863.319135321129;4871.63462740303;4937.876553086202;5011.09800235961;5090.592752579711 13:34:59 INFO - PROCESS | 1957 | |4;prototype.html;253.41966895808596;292.5392506801788;310.077519379845;315.1789588122941;316.7323611548241;4311.741295522263;4525.434320709911;5464.371597266316;5584.385717571069;5608.355039170497;4650.8605391679;5233.969843220718;5248.68507889526;5344.545713614338;5416.187571864222;4188.727732697373;4203.957960420387;4235.788210589473;4261.382099595557;4300.8709738707885;3731.5708693500187;3991;4284.022604290019;4290.699651024414;4293.506246781629;3842.0992150926013;4177.916441671165;4203.243416185085;4227.577242275764;4236.279832428495;3339.4990751387245;3751.531058617673;4197.517285512175;4198.181354635832;4206.49522057352;3235.2558911450496;3705.221903400289;3710.128119891823;3713.350163721365;3734.3651579231323;4947.901041979177;5292.332915131759;5360.463953604608;5386.91919621206;5433.6196466247375;4710.246360582325;4727.858164255078;4736.881577960544;4736.976315118437;4746.596539294164;5758.790653962673;5771.249737534135;5795.3335366432975;5795.797147099874;5810.564207684399;3490.6858382745677;3633.3278343506536;3686.5391826021746;3873.31510792806;3939.0546268895546;4718.363020992157;5353.126405757993;5567.721613919288;6020.501491880908;6094.908576371358;3039.9088027359217;3433.176037750972;3449.413599688059;3941.684665226775;3980.44273801668;3298.3568204200433;3671.3391589514144;3959.8416063357145;3987.302222111119;4025.597440255951;3644.4351125575577;4011.799410029545;4435.268180750205;4738.976305118453;4752.881177970578;5824.213731146241;5836.503897168704;5865.736041878125;5873.412658734178;5873.735681894325;1178.0281267953972;1296.6110166949877;1308.2869835939437;1358.6060042587737;1370.8560601136737;884.7832281091174;910;923.2060428031887;924.5331107790523;927.3632039450375;5412.296401467784;5429.484199001088;5435.537979271727;5446.428125046892;5456.454354564591;5044.672096313728;5986.5809393342915;5990.64056156632;5998.850028749229;6011.311177281727;4689.460712018094;4965.726885021286;5270.868228294324;5438.945610543844;5463.262459567987;2636.419987602724;3094.4894092474938;3143.7799354045455;3144.5754823099046;3146.7954582952034;5765.913511297334;6178.443940045418;6283.277423096311;6293.213348331458;6363.295599370249;5158.646879528336;5505.862353441196;6167.23798482925;6222.888555722139;6260.311365749764;6251.593646412968;6292.937070629327;6298.307186209513;6341.746330146835;6405.775797847053;5710.145651685013;6038.788642397495;6075;6121.84695382619;6173.9073913892225;5030.496950304941;5643.927653745775;6000.369961154016;6015.608985415934;6043.667598282137;5641.323041235078;5880.323762767336;6293.496520278275;6358.205224346957;6391.712372943136;3980.7460649895193;4011.976945878899;4012.378081397388;4040.6767458602653;4055.809862674241;5820.417958204146;6084.300305464752;6084.330723620486;6091.441594530396;6101.816945491642;4729.290606409066;4793.161196790617;5074.847754567369;5233.927044955851;5811.302643682785;5032.773525191302;5408.486193811582;5500.697461639648;5696.493542841136;5814.5639077068545;4584.381108550303;5443.896978722249;5674.716264186856;5821.185034095145;5840.569060580185;5029.673071250503;5826.271716035496;5835.44563266489;5912.408759124053;5919.556033297434;5485.588580856372;5698.458646428583;5721.256236689203;5735.512481439125;5742.569307301886 13:34:59 INFO - PROCESS | 1957 | |5;yui.html;714.5676865496378;738.5753191914647;768.8352146498056;784.2040329066002;787.9290863822256;15304.464343747972;16328.428505002328;16331.101789401579;16378.836211637896;16418.671626567462;11499.252548584356;12165.965892899114;12360.258384496936;14722.55832325032;14894.702105957875;616.352829528995;695.0929037605922;783.7303568219478;835.4653022065883;867.3668222197799;851.3572252949045;865.9220670139687;867.1588559097665;868.5874209750381;871.2159056848824;917.321182325078;920.8112336970938;921.741912264567;925.0333401595316;929.7117893453018;912.4798864647154;914.5381582300929;914.7210100919217;915.6749353979308;915.743591794302;679.1578442731027;679.3987321220706;680.5270337115707;682.4983637026781;682.7917485167022;15146.01550899188;15180.544583662508;15234.923825380802;15242.923785381003;15243.16162611056;14667;14668.193249371281;14737.336819843133;14767.556973290819;14861.554153375417;11919.284842909366;12273.815892761615;12293.69265768354;12343.259404435763;12559.93720031403;3248.5614442050255;3776.6978641708597;3941.763494190329;3994.001499625094;3994.820233089518;122241;122475;123652.76347236503;123916;124331.3783431086;11037.668869933916;11328.886711132947;11431.314121152758;11612.6516204514;11700.06399488039;23707.64438533389;23707.7629223709;23777.167799126946;24102.39744006379;24121.758782412304;7684.6157692116285;7831.804204894809;7833.433313337356;8022.879656805153;8282.13037631052;4477.126960242721;4483.955160448354;4496.3705081288645;4560.977195114003;4640.95359046412;3459.3427248822645;3590.4973303736974;3594.964050359515;3602.1174812171184;3778.319902417591;722.8445884134936;726.4007194064917;729.9598072746315;731.7365748330596;732.9963350183322;523.9416378914572;561.3488353509908;605.2454606590429;606.8015669053584;705.1502938958542;7999.1600881907725;8331.750047498463;9225.53872306382;9665;9836.311458197857;544.6332374541674;553.9833804985857;563.6223730100842;617.9011358182669;674.8380388706676;4500.842470513517;4539.555129587413;4770.236762118045;4843.207133590769;4864.075825593126;131514.1091534511;140891;142694;143356;143751;123061;124404.37797810954;135864.32067839795;142009;147792;105733;119303;123451;125382;129618.35190823986;9177.816443671223;9249.445033298023;9446.29152813528;9743.46788645648;10075.970807283351;47917;52959.73520132375;54600.907981839344;56462;57105.42894571001;58604;80964.78552821594;85022.57488712764;91921.54039229761;92040.07959920315;12717.872821271669;12920.418581163682;12933.417996190006;12985.870141298466;13053.869461305645;14735.042222255519;14800.7779883304;14855.851441485447;14907.92546037263;15342.15618141013;13636.318184090955;13788.706648802507;13858.792118118035;13965;14011;13551.25468099264;13574.389152487964;14098.36557354901;14377.496787612383;14539.982201245812;13109.803352949522;13370.799438008633;13439.395227214603;13652.795208072086;13917.443302267797;11054.502547385226;11466.77066458683;11633.360165190996;11641.59254426091;11723.706907327385;8101;9873.25950553697;10984.340939543654;11574.30554166719;11712.121590880548 13:34:59 INFO - PROCESS | 1957 | __end_tp_report 13:34:59 INFO - PROCESS | 1957 | __start_cc_report 13:34:59 INFO - PROCESS | 1957 | _x_x_mozilla_cycle_collect,360 13:34:59 INFO - PROCESS | 1957 | __end_cc_report 13:34:59 INFO - PROCESS | 1957 | __startTimestamp1474662899838__endTimestamp 13:34:59 INFO - PROCESS | 1957 | 13:34:59 INFO - PROCESS | 1957 | ------- Summary: start ------- 13:34:59 INFO - PROCESS | 1957 | Number of tests: 6 13:34:59 INFO - PROCESS | 1957 | 13:34:59 INFO - PROCESS | 1957 | [#0] dojo.html Cycles:165 Average:5648.10 Median:5826.39 stddev:659.72 (11.3%) stddev-sans-first:635.66 13:34:59 INFO - PROCESS | 1957 | Values: 3306.8 3354.0 3368.5 3369.2 3379.8 5576.8 5608.0 5615.6 5641.6 5675.2 5629.4 5670.3 5679.7 5714.3 5768.5 5106.8 5118.1 5146.2 5235.2 5250.6 4700.7 4935.8 5267.2 5294.2 5301.6 5030.3 5114.5 5185.1 5192.2 5240.0 5154.0 5163.4 5181.1 5207.5 5218.2 5123.5 5126.2 5130.1 5134.2 5141.6 4514.0 5498.2 5519.9 5533.2 5583.7 5124.2 6117.1 6117.5 6131.5 6160.8 6238.5 6239.8 6270.9 6271.8 6305.1 5355.4 5643.7 5763.7 5772.2 5818.6 4705.5 4859.9 5102.4 6225.3 6279.4 4982.5 6133.0 6134.7 6147.5 6155.4 6065.2 6074.4 6088.9 6132.8 6224.4 6137.6 6138.6 6145.8 6157.5 6203.7 5571.7 6178.2 6180.4 6186.4 6196.2 4114.5 4808.7 4835.3 4850.8 4895.0 4341.7 4346.6 4385.5 4436.5 4466.9 5734.2 5776.6 5809.4 5847.4 5889.6 6108.6 6135.5 6181.9 6204.1 6212.0 5667.3 5682.7 5766.2 5775.9 5825.2 5298.8 5302.1 5307.9 5313.5 5340.4 6179.7 6206.5 6273.8 6295.5 6304.0 6138.0 6141.1 6146.8 6184.6 6283.4 6267.1 6269.0 6280.7 6289.1 6294.4 6023.0 6028.6 6067.8 6103.8 6134.5 5665.8 6166.0 6243.4 6278.5 6467.7 6086.9 6104.2 6124.1 6125.9 6130.1 5898.7 5937.0 6063.0 6100.6 6119.4 5712.5 5826.4 5906.1 5952.3 5993.4 6053.2 6072.4 6109.2 6133.9 6134.4 5720.2 5938.0 5938.6 5953.8 5964.8 13:34:59 INFO - PROCESS | 1957 | 13:34:59 INFO - PROCESS | 1957 | [#1] ext.html Cycles:180 Average:61652.02 Median:20783.76 stddev:137620.54 (662.2%) stddev-sans-first:137929.92 13:34:59 INFO - PROCESS | 1957 | Values: 460.6 461.7 523.7 540.4 543.0 31265.2 41351.4 41456.6 41476.8 41577.6 29305.0 33646.2 41239.0 42283.0 42343.0 9623.4 9778.5 9802.8 9809.7 9815.2 9598.6 9696.3 9703.3 9725.5 9829.0 8510.4 9646.0 9697.3 9723.1 9758.7 9601.7 9637.5 9722.8 9723.6 9745.6 9496.4 9580.4 9586.9 9592.6 9596.7 39938.6 40122.0 40132.4 40156.8 40362.0 3275.1 3364.0 3391.9 3402.0 3786.9 30513.4 31230.7 31267.4 31335.0 31612.4 3109.3 3116.8 3119.3 3151.9 3231.4 439109.0 440485.0 443627.0 446352.0 446426.0 32361.7 33371.2 56698.0 57132.1 57168.9 34413.0 34609.5 34820.7 34886.3 34983.5 13404.8 13632.5 13741.4 13798.2 13807.3 12056.2 12175.1 12206.7 12345.1 12353.4 7662.5 7688.8 7765.5 7771.5 7890.1 2817.2 3275.8 3282.2 3294.6 3301.1 929.9 963.7 996.6 1025.5 1034.0 29727.0 29826.0 30064.7 30373.7 30754.4 1004.4 1065.4 1073.2 1079.3 1081.8 12700.2 14536.5 14843.4 15464.4 15700.7 187015.0 189357.1 650008.0 650451.0 652086.0 55694.9 56154.2 56295.2 56396.0 56628.6 1257.7 1264.9 1362.5 1369.6 1377.3 28436.7 29326.3 29443.4 29876.9 30148.1 38051.8 43379.5 44969.1 45186.3 45366.3 567989.0 568925.0 569655.2 570425.0 570519.0 25497.5 25954.0 26259.0 26328.5 26445.9 37780.6 46540.1 46806.3 47229.5 47601.5 37996.6 38519.6 38690.6 39851.0 40156.4 29251.0 33210.7 35629.8 38080.8 41049.6 31588.7 36451.3 37420.8 37529.0 38767.0 28718.9 33640.0 34319.7 34337.6 34569.5 25470.4 25506.2 25742.2 25808.9 26146.5 13:34:59 INFO - PROCESS | 1957 | 13:34:59 INFO - PROCESS | 1957 | [#2] jquery.html Cycles:180 Average:32474.90 Median:376.52 stddev:88603.29 (23531.9%) stddev-sans-first:88818.92 13:34:59 INFO - PROCESS | 1957 | Values: 303.6 354.2 374.6 378.5 401.6 19032.6 19628.7 20200.9 20697.5 20863.0 20608.0 20643.2 20998.2 21045.5 21110.7 5957.0 5980.7 6075.8 6161.7 6226.1 6029.5 6129.4 6151.9 6154.1 6163.5 5851.8 6050.0 6105.8 6113.1 6116.3 5949.0 5992.2 6057.5 6105.2 6116.7 4617.1 5097.8 5267.9 5277.6 5304.9 25584.5 25602.7 25659.5 25694.2 25892.2 2241.2 2374.7 2498.4 2899.9 3172.1 15056.0 15665.9 15709.1 15731.7 16182.3 1865.8 1949.2 1953.2 1966.8 1974.3 87216.1 107381.0 109141.0 114182.9 115104.4 8856.1 9003.9 9190.6 11113.6 11256.8 11288.9 13974.8 13989.6 14001.9 14014.6 6333.6 7972.5 8021.3 8099.6 8163.3 8412.7 8467.5 8472.8 8637.9 8646.2 3405.8 3705.8 3914.5 3929.3 3969.9 1916.3 1935.3 1935.4 1936.4 1954.2 711.5 794.7 831.4 834.8 901.2 20573.7 21320.3 21473.0 21688.3 21774.6 891.5 906.9 951.1 966.1 967.1 11006.9 11378.0 11501.5 11504.9 11523.4 473652.0 479397.0 480936.0 594541.0 601469.0 78434.2 81044.2 128910.9 137988.3 139060.0 975.3 989.7 1005.7 1018.0 1019.4 16653.9 19101.6 19460.4 19798.3 19912.9 53701.0 53985.7 54622.7 55245.4 55957.4 81687.6 82023.6 82657.9 82877.8 84409.0 6888.5 7109.5 7211.8 7474.1 7995.1 11058.1 12579.5 12684.9 12955.8 13108.0 8910.5 10258.3 10799.8 10950.9 11242.9 9677.7 9798.2 10978.4 10990.8 11121.0 9766.6 10399.8 11110.9 11255.3 11567.5 6880.0 8036.3 8112.2 8141.3 8197.8 8937.4 9935.7 10297.1 10483.6 10617.0 13:34:59 INFO - PROCESS | 1957 | 13:34:59 INFO - PROCESS | 1957 | [#3] mootools.html Cycles:180 Average:5627.53 Median:4925.14 stddev:3162.81 (64.2%) stddev-sans-first:3156.65 13:34:59 INFO - PROCESS | 1957 | Values: 1524.6 1535.1 1737.2 1822.6 1834.5 7817.8 8053.2 8273.3 8887.2 8930.6 8382.0 8647.3 8699.7 8776.8 8788.6 2354.8 2360.8 2393.2 2396.3 2397.7 2019.8 2377.0 2400.6 2415.5 2426.9 2366.6 2386.6 2395.9 2408.0 2417.2 2357.1 2377.0 2387.8 2391.3 2395.3 2337.4 2369.1 2387.0 2390.5 2401.5 8761.1 8766.2 8887.1 8917.3 8952.5 5228.4 5353.9 5356.6 5361.3 5367.6 3573.2 3596.7 3612.9 3662.7 3665.9 1069.2 1070.6 1075.3 1078.8 1088.9 11507.8 11562.7 11578.8 11646.5 11649.1 4566.9 4597.2 4742.3 4800.7 4813.0 8294.5 9782.5 9848.2 9877.8 9934.8 4760.2 5281.1 5297.2 5306.5 5316.4 4333.4 4491.6 4701.3 4827.4 4859.3 3249.4 3796.8 3882.9 3978.5 4001.4 1127.2 1218.0 1268.5 1281.4 1290.2 861.2 870.7 877.7 912.9 925.1 4912.4 5646.0 5666.2 5925.5 5987.4 411.8 415.9 430.3 433.6 436.5 3843.4 3895.3 4005.4 4019.8 4021.1 10280.9 10557.8 10673.3 10680.5 10785.7 10624.5 10627.0 10665.5 10670.7 10731.6 8028.6 8038.6 8090.4 8124.6 8162.3 5671.0 5704.1 5713.3 5758.6 5874.4 9415.4 9598.2 9798.7 9874.0 9906.6 9742.6 9848.3 9932.6 9988.0 10116.4 6800.7 6999.4 7181.5 7356.4 7518.4 7975.2 8151.1 8212.4 8242.4 8258.4 6442.8 7262.4 7467.4 7533.9 7548.8 7307.7 7323.7 7346.3 7351.3 7429.0 6865.1 6881.2 6927.1 6931.9 6933.4 4873.8 4950.6 4965.2 4986.3 5034.5 4863.3 4871.6 4937.9 5011.1 5090.6 13:34:59 INFO - PROCESS | 1957 | 13:34:59 INFO - PROCESS | 1957 | [#4] prototype.html Cycles:180 Average:4685.10 Median:5318.44 stddev:1486.47 (27.9%) stddev-sans-first:1452.95 13:34:59 INFO - PROCESS | 1957 | Values: 253.4 292.5 310.1 315.2 316.7 4311.7 4525.4 5464.4 5584.4 5608.4 4650.9 5234.0 5248.7 5344.5 5416.2 4188.7 4204.0 4235.8 4261.4 4300.9 3731.6 3991.0 4284.0 4290.7 4293.5 3842.1 4177.9 4203.2 4227.6 4236.3 3339.5 3751.5 4197.5 4198.2 4206.5 3235.3 3705.2 3710.1 3713.4 3734.4 4947.9 5292.3 5360.5 5386.9 5433.6 4710.2 4727.9 4736.9 4737.0 4746.6 5758.8 5771.2 5795.3 5795.8 5810.6 3490.7 3633.3 3686.5 3873.3 3939.1 4718.4 5353.1 5567.7 6020.5 6094.9 3039.9 3433.2 3449.4 3941.7 3980.4 3298.4 3671.3 3959.8 3987.3 4025.6 3644.4 4011.8 4435.3 4739.0 4752.9 5824.2 5836.5 5865.7 5873.4 5873.7 1178.0 1296.6 1308.3 1358.6 1370.9 884.8 910.0 923.2 924.5 927.4 5412.3 5429.5 5435.5 5446.4 5456.5 5044.7 5986.6 5990.6 5998.9 6011.3 4689.5 4965.7 5270.9 5438.9 5463.3 2636.4 3094.5 3143.8 3144.6 3146.8 5765.9 6178.4 6283.3 6293.2 6363.3 5158.6 5505.9 6167.2 6222.9 6260.3 6251.6 6292.9 6298.3 6341.7 6405.8 5710.1 6038.8 6075.0 6121.8 6173.9 5030.5 5643.9 6000.4 6015.6 6043.7 5641.3 5880.3 6293.5 6358.2 6391.7 3980.7 4012.0 4012.4 4040.7 4055.8 5820.4 6084.3 6084.3 6091.4 6101.8 4729.3 4793.2 5074.8 5233.9 5811.3 5032.8 5408.5 5500.7 5696.5 5814.6 4584.4 5443.9 5674.7 5821.2 5840.6 5029.7 5826.3 5835.4 5912.4 5919.6 5485.6 5698.5 5721.3 5735.5 5742.6 13:34:59 INFO - PROCESS | 1957 | 13:34:59 INFO - PROCESS | 1957 | [#5] yui.html Cycles:180 Average:25070.52 Median:3524.92 stddev:40307.80 (1143.5%) stddev-sans-first:40379.39 13:34:59 INFO - PROCESS | 1957 | Values: 714.6 738.6 768.8 784.2 787.9 15304.5 16328.4 16331.1 16378.8 16418.7 11499.3 12166.0 12360.3 14722.6 14894.7 616.4 695.1 783.7 835.5 867.4 851.4 865.9 867.2 868.6 871.2 917.3 920.8 921.7 925.0 929.7 912.5 914.5 914.7 915.7 915.7 679.2 679.4 680.5 682.5 682.8 15146.0 15180.5 15234.9 15242.9 15243.2 14667.0 14668.2 14737.3 14767.6 14861.6 11919.3 12273.8 12293.7 12343.3 12559.9 3248.6 3776.7 3941.8 3994.0 3994.8 122241.0 122475.0 123652.8 123916.0 124331.4 11037.7 11328.9 11431.3 11612.7 11700.1 23707.6 23707.8 23777.2 24102.4 24121.8 7684.6 7831.8 7833.4 8022.9 8282.1 4477.1 4484.0 4496.4 4561.0 4641.0 3459.3 3590.5 3595.0 3602.1 3778.3 722.8 726.4 730.0 731.7 733.0 523.9 561.3 605.2 606.8 705.2 7999.2 8331.8 9225.5 9665.0 9836.3 544.6 554.0 563.6 617.9 674.8 4500.8 4539.6 4770.2 4843.2 4864.1 131514.1 140891.0 142694.0 143356.0 143751.0 123061.0 124404.4 135864.3 142009.0 147792.0 105733.0 119303.0 123451.0 125382.0 129618.4 9177.8 9249.4 9446.3 9743.5 10076.0 47917.0 52959.7 54600.9 56462.0 57105.4 58604.0 80964.8 85022.6 91921.5 92040.1 12717.9 12920.4 12933.4 12985.9 13053.9 14735.0 14800.8 14855.9 14907.9 15342.2 13636.3 13788.7 13858.8 13965.0 14011.0 13551.3 13574.4 14098.4 14377.5 14540.0 13109.8 13370.8 13439.4 13652.8 13917.4 11054.5 11466.8 11633.4 11641.6 11723.7 8101.0 9873.3 10984.3 11574.3 11712.1 13:34:59 INFO - PROCESS | 1957 | -------- Summary: end -------- 13:34:59 INFO - PROCESS | 1957 | 13:35:00 INFO - TEST-INFO | 1957: exit 0 13:35:00 INFO - TEST-OK | dromaeo_css | took 1114805ms 13:35:00 INFO - TEST-START | kraken 13:35:00 INFO - operating with platform_type : mac_ 13:35:00 INFO - Initialising browser for kraken test... 13:35:00 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmpp9JHgr/profile http://localhost:51860/getInfo.html) 13:35:03 INFO - PROCESS | 1964 | 2016-09-23 13:35:03.442 plugin-container[1965:14528] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a27, name = 'com.apple.tsm.portname' 13:35:03 INFO - PROCESS | 1964 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:35:03 INFO - PROCESS | 1964 | 2016-09-23 13:35:03.446 plugin-container[1965:14528] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f03, name = 'com.apple.CFPasteboardClient' 13:35:03 INFO - PROCESS | 1964 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:35:03 INFO - PROCESS | 1964 | 2016-09-23 13:35:03.446 plugin-container[1965:14528] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:35:03 INFO - PROCESS | 1964 | __metrics Screen width/height:1600/1200 13:35:03 INFO - PROCESS | 1964 | colorDepth:24 13:35:03 INFO - PROCESS | 1964 | Browser inner width/height: 1024/689 13:35:03 INFO - PROCESS | 1964 | __metrics 13:35:03 ERROR - PROCESS | 1964 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 13:35:04 INFO - TEST-INFO | 1964: exit 0 13:35:04 INFO - Browser initialized. 13:35:04 INFO - Running cycle 1/1 for kraken test... 13:35:04 INFO - TEST-INFO | started process 1966 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmpp9JHgr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:35:06 INFO - PROCESS | 1966 | 2016-09-23 13:35:06.800 plugin-container[1967:14641] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471f, name = 'com.apple.tsm.portname' 13:35:06 INFO - PROCESS | 1966 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:35:06 INFO - PROCESS | 1966 | 2016-09-23 13:35:06.802 plugin-container[1967:14641] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e03, name = 'com.apple.CFPasteboardClient' 13:35:06 INFO - PROCESS | 1966 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:35:06 INFO - PROCESS | 1966 | 2016-09-23 13:35:06.802 plugin-container[1967:14641] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:35:16 INFO - PROCESS | 1966 | RSS: Main: 240427008 13:35:16 INFO - PROCESS | 1966 | 13:35:19 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:51860/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51860/tests/kraken/driver.html?testName=audio-beat-detection) 13:35:20 INFO - PROCESS | 1966 | RSS: Main: 253767680 13:35:20 INFO - PROCESS | 1966 | 13:35:22 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:51860/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51860/tests/kraken/driver.html?testName=audio-dft) 13:35:23 INFO - PROCESS | 1966 | RSS: Main: 261287936 13:35:23 INFO - PROCESS | 1966 | 13:35:26 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:51860/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51860/tests/kraken/driver.html?testName=audio-fft) 13:35:27 INFO - PROCESS | 1966 | RSS: Main: 262017024 13:35:27 INFO - PROCESS | 1966 | 13:35:29 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:51860/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51860/tests/kraken/driver.html?testName=audio-oscillator) 13:35:30 INFO - PROCESS | 1966 | RSS: Main: 263372800 13:35:30 INFO - PROCESS | 1966 | 13:35:32 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:51860/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51860/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:35:32 INFO - PROCESS | 1966 | RSS: Main: 263532544 13:35:32 INFO - PROCESS | 1966 | 13:35:35 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:51860/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51860/tests/kraken/driver.html?testName=imaging-darkroom) 13:35:36 INFO - PROCESS | 1966 | RSS: Main: 264450048 13:35:36 INFO - PROCESS | 1966 | 13:35:39 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:51860/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51860/tests/kraken/driver.html?testName=imaging-desaturate) 13:35:39 INFO - PROCESS | 1966 | RSS: Main: 264622080 13:35:39 INFO - PROCESS | 1966 | 13:35:42 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:51860/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51860/tests/kraken/driver.html?testName=json-parse-financial) 13:35:43 INFO - PROCESS | 1966 | RSS: Main: 265011200 13:35:43 INFO - PROCESS | 1966 | 13:35:45 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:51860/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51860/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:35:45 INFO - PROCESS | 1966 | RSS: Main: 265478144 13:35:45 INFO - PROCESS | 1966 | 13:35:47 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:51860/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51860/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:35:48 INFO - PROCESS | 1966 | RSS: Main: 265367552 13:35:48 INFO - PROCESS | 1966 | 13:35:50 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:51860/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51860/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:35:51 INFO - PROCESS | 1966 | RSS: Main: 265420800 13:35:51 INFO - PROCESS | 1966 | 13:35:54 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:51860/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:35:54 INFO - PROCESS | 1966 | RSS: Main: 265736192 13:35:54 INFO - PROCESS | 1966 | 13:35:57 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:51860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:35:58 INFO - PROCESS | 1966 | RSS: Main: 265768960 13:35:58 INFO - PROCESS | 1966 | 13:36:00 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:51860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51860/tests/kraken/driver.html?testName=ai-astar) 13:36:00 INFO - PROCESS | 1966 | RSS: Main: 267067392 13:36:00 INFO - PROCESS | 1966 | 13:36:00 INFO - PROCESS | 1966 | __start_tp_report 13:36:00 INFO - PROCESS | 1966 | _x_x_mozilla_page_load 13:36:00 INFO - PROCESS | 1966 | _x_x_mozilla_page_load_details 13:36:00 INFO - PROCESS | 1966 | |i|pagename|runs| 13:36:00 INFO - PROCESS | 1966 | |0;ai-astar;111;120;122;166;117;118;124;141;117;118 13:36:00 INFO - PROCESS | 1966 | |1;audio-beat-detection;154;123;132;135;101;143;145;142;172;114 13:36:00 INFO - PROCESS | 1966 | |2;audio-dft;197;199;235;250;281;246;196;197;194;199 13:36:00 INFO - PROCESS | 1966 | |3;audio-fft;88;68;86;86;58;63;61;60;81;76 13:36:00 INFO - PROCESS | 1966 | |4;audio-oscillator;95;71;86;73;71;82;90;57;88;120 13:36:00 INFO - PROCESS | 1966 | |5;imaging-gaussian-blur;111;133;107;87;88;85;89;86;90;88 13:36:00 INFO - PROCESS | 1966 | |6;imaging-darkroom;134;100;98;98;115;98;99;99;131;169 13:36:00 INFO - PROCESS | 1966 | |7;imaging-desaturate;149;151;93;91;90;91;91;91;93;117 13:36:00 INFO - PROCESS | 1966 | |8;json-parse-financial;54;52;85;90;48;50;81;89;88;90 13:36:00 INFO - PROCESS | 1966 | |9;json-stringify-tinderbox;69;76;77;80;73;70;72;71;75;73 13:36:00 INFO - PROCESS | 1966 | |10;stanford-crypto-aes;106;110;90;92;86;89;80;79;107;106 13:36:00 INFO - PROCESS | 1966 | |11;stanford-crypto-ccm;147;154;155;158;155;142;143;142;175;141 13:36:00 INFO - PROCESS | 1966 | |12;stanford-crypto-pbkdf2;180;176;238;237;196;173;175;173;174;178 13:36:00 INFO - PROCESS | 1966 | |13;stanford-crypto-sha256-iterative;67;70;69;80;79;68;69;66;67;67 13:36:00 INFO - PROCESS | 1966 | __end_tp_report 13:36:00 INFO - PROCESS | 1966 | __start_cc_report 13:36:00 INFO - PROCESS | 1966 | _x_x_mozilla_cycle_collect,916 13:36:00 INFO - PROCESS | 1966 | __end_cc_report 13:36:00 INFO - PROCESS | 1966 | __startTimestamp1474662960539__endTimestamp 13:36:00 INFO - PROCESS | 1966 | 13:36:00 INFO - PROCESS | 1966 | ------- Summary: start ------- 13:36:00 INFO - PROCESS | 1966 | Number of tests: 14 13:36:00 INFO - PROCESS | 1966 | 13:36:00 INFO - PROCESS | 1966 | [#0] ai-astar Cycles:10 Average:125.40 Median:121.00 stddev:16.30 (13.5%) stddev-sans-first:16.44 13:36:00 INFO - PROCESS | 1966 | Values: 111.0 120.0 122.0 166.0 117.0 118.0 124.0 141.0 117.0 118.0 13:36:00 INFO - PROCESS | 1966 | 13:36:00 INFO - PROCESS | 1966 | [#1] audio-beat-detection Cycles:10 Average:136.10 Median:142.50 stddev:20.22 (14.2%) stddev-sans-first:20.39 13:36:00 INFO - PROCESS | 1966 | Values: 154.0 123.0 132.0 135.0 101.0 143.0 145.0 142.0 172.0 114.0 13:36:00 INFO - PROCESS | 1966 | 13:36:00 INFO - PROCESS | 1966 | [#2] audio-dft Cycles:10 Average:219.40 Median:217.00 stddev:31.11 (14.3%) stddev-sans-first:31.92 13:36:00 INFO - PROCESS | 1966 | Values: 197.0 199.0 235.0 250.0 281.0 246.0 196.0 197.0 194.0 199.0 13:36:00 INFO - PROCESS | 1966 | 13:36:00 INFO - PROCESS | 1966 | [#3] audio-fft Cycles:10 Average:72.70 Median:78.50 stddev:12.01 (15.3%) stddev-sans-first:11.39 13:36:00 INFO - PROCESS | 1966 | Values: 88.0 68.0 86.0 86.0 58.0 63.0 61.0 60.0 81.0 76.0 13:36:00 INFO - PROCESS | 1966 | 13:36:00 INFO - PROCESS | 1966 | [#4] audio-oscillator Cycles:10 Average:83.30 Median:84.00 stddev:17.19 (20.5%) stddev-sans-first:17.71 13:36:00 INFO - PROCESS | 1966 | Values: 95.0 71.0 86.0 73.0 71.0 82.0 90.0 57.0 88.0 120.0 13:36:00 INFO - PROCESS | 1966 | 13:36:00 INFO - PROCESS | 1966 | [#5] imaging-gaussian-blur Cycles:10 Average:96.40 Median:87.50 stddev:15.74 (18.0%) stddev-sans-first:15.78 13:36:00 INFO - PROCESS | 1966 | Values: 111.0 133.0 107.0 87.0 88.0 85.0 89.0 86.0 90.0 88.0 13:36:00 INFO - PROCESS | 1966 | 13:36:00 INFO - PROCESS | 1966 | [#6] imaging-darkroom Cycles:10 Average:114.10 Median:98.00 stddev:23.87 (24.4%) stddev-sans-first:24.21 13:36:00 INFO - PROCESS | 1966 | Values: 134.0 100.0 98.0 98.0 115.0 98.0 99.0 99.0 131.0 169.0 13:36:00 INFO - PROCESS | 1966 | 13:36:00 INFO - PROCESS | 1966 | [#7] imaging-desaturate Cycles:10 Average:105.70 Median:91.00 stddev:24.69 (27.1%) stddev-sans-first:20.63 13:36:00 INFO - PROCESS | 1966 | Values: 149.0 151.0 93.0 91.0 90.0 91.0 91.0 91.0 93.0 117.0 13:36:00 INFO - PROCESS | 1966 | 13:36:00 INFO - PROCESS | 1966 | [#8] json-parse-financial Cycles:10 Average:72.70 Median:86.50 stddev:18.92 (21.9%) stddev-sans-first:18.82 13:36:00 INFO - PROCESS | 1966 | Values: 54.0 52.0 85.0 90.0 48.0 50.0 81.0 89.0 88.0 90.0 13:36:00 INFO - PROCESS | 1966 | 13:36:00 INFO - PROCESS | 1966 | [#9] json-stringify-tinderbox Cycles:10 Average:73.60 Median:74.00 stddev:3.41 (4.6%) stddev-sans-first:3.18 13:36:00 INFO - PROCESS | 1966 | Values: 69.0 76.0 77.0 80.0 73.0 70.0 72.0 71.0 75.0 73.0 13:36:00 INFO - PROCESS | 1966 | 13:36:00 INFO - PROCESS | 1966 | [#10] stanford-crypto-aes Cycles:10 Average:94.50 Median:83.00 stddev:11.74 (14.1%) stddev-sans-first:11.69 13:36:00 INFO - PROCESS | 1966 | Values: 106.0 110.0 90.0 92.0 86.0 89.0 80.0 79.0 107.0 106.0 13:36:00 INFO - PROCESS | 1966 | 13:36:00 INFO - PROCESS | 1966 | [#11] stanford-crypto-ccm Cycles:10 Average:151.20 Median:154.50 stddev:10.58 (6.8%) stddev-sans-first:11.11 13:36:00 INFO - PROCESS | 1966 | Values: 147.0 154.0 155.0 158.0 155.0 142.0 143.0 142.0 175.0 141.0 13:36:00 INFO - PROCESS | 1966 | 13:36:00 INFO - PROCESS | 1966 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.00 Median:179.00 stddev:25.92 (14.5%) stddev-sans-first:27.24 13:36:00 INFO - PROCESS | 1966 | Values: 180.0 176.0 238.0 237.0 196.0 173.0 175.0 173.0 174.0 178.0 13:36:00 INFO - PROCESS | 1966 | 13:36:00 INFO - PROCESS | 1966 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:69.00 stddev:5.05 (7.3%) stddev-sans-first:5.22 13:36:00 INFO - PROCESS | 1966 | Values: 67.0 70.0 69.0 80.0 79.0 68.0 69.0 66.0 67.0 67.0 13:36:00 INFO - PROCESS | 1966 | -------- Summary: end -------- 13:36:00 INFO - PROCESS | 1966 | 13:36:01 INFO - TEST-INFO | 1966: exit 0 13:36:01 INFO - TEST-OK | kraken | took 60935ms 13:36:01 INFO - SUITE-END | took 1175s 13:36:01 INFO - Completed test suite (00:19:36) 13:36:01 INFO - javascript benchmark 13:36:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7208.432749254273, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3306.842605088218, 3354.0440974322314, 3368.4778859276807, 3369.2250782320057, 3379.817064027592, 5576.832695019146, 5608.018596745564, 5615.606907516475, 5641.605087643867, 5675.2054712340305, 5629.380768115514, 5670.3479099903525, 5679.659220446766, 5714.314282286132, 5768.509676677477, 5106.76525464722, 5118.104331741949, 5146.202338637517, 5235.214717792323, 5250.553702935255, 4700.670953033289, 4935.815404302959, 5267.209918512234, 5294.205869119624, 5301.575873930095, 5030.2957585938, 5114.462981386975, 5185.092608793484, 5192.1952097424955, 5240.0, 5153.9742301288625, 5163.380394352702, 5181.093308670967, 5207.453217412193, 5218.165093585046, 5123.462036486189, 5126.2054381570915, 5130.102232109366, 5134.229865520165, 5141.562967147797, 4514.0069184779295, 5498.230247765316, 5519.9448005519835, 5533.197686335499, 5583.6928968906695, 5124.231365295198, 6117.066276512122, 6117.544242953886, 6131.47882429994, 6160.815175544741, 6238.532110091761, 6239.812805615838, 6270.874582508324, 6271.843203919939, 6305.117283580303, 5355.3841308249275, 5643.746031428595, 5763.682997435139, 5772.191893134965, 5818.5926985111055, 4705.529447055267, 4859.878503037452, 5102.36220472441, 6225.346338634468, 6279.403456671609, 4982.526659967298, 6132.969335153296, 6134.6625935573975, 6147.508199344042, 6155.415235552616, 6065.2418447694035, 6074.36219196978, 6088.873558391623, 6132.816015519542, 6224.408681175281, 6137.622145770991, 6138.572327483795, 6145.8156255312415, 6157.507399408037, 6203.720832562545, 5571.693556854412, 6178.165947597017, 6180.412860778219, 6186.381361863868, 6196.225471816023, 4114.485689288839, 4808.687435316693, 4835.298881662139, 4850.83022094225, 4894.95105048945, 4341.696081274281, 4346.630536404441, 4385.451818522684, 4436.489803672554, 4466.865994020184, 5734.168545560954, 5776.624519406225, 5809.390014048464, 5847.415258474203, 5889.558283128783, 6108.633481991094, 6135.508280839814, 6181.938180618226, 6204.100405441186, 6211.9689401552705, 5667.348254950651, 5682.7442765075675, 5766.192733017381, 5775.913361299584, 5825.1844741736195, 5298.788048478094, 5302.072137375943, 5307.920381194285, 5313.495217954288, 5340.439253878365, 6179.660118693335, 6206.472449841724, 6273.811785646438, 6295.527835412271, 6303.968480157753, 6137.959273351923, 6141.117811340085, 6146.815595532141, 6184.5980011299125, 6283.403076707706, 6267.091271765659, 6269.028300613412, 6280.654563999024, 6289.056641503811, 6294.402031806971, 6023.00620397647, 6028.608140470856, 6067.848303792441, 6103.84740381494, 6134.509239260759, 5665.773369065356, 6165.969170154121, 6243.37566243372, 6278.529110316653, 6467.708953097216, 6086.939130608815, 6104.20645316106, 6124.14262003311, 6125.908111378244, 6130.111133885473, 5898.675572843363, 5937.0, 6063.0, 6100.572959892765, 6119.388061193845, 5712.5429965601825, 5826.388229235869, 5906.084556893688, 5952.255968003999, 5993.430624090704, 6053.152558641706, 6072.392760723892, 6109.236345456818, 6133.877322453437, 6134.38656134383, 5720.227769251098, 5938.0, 5938.584299099021, 5953.821385358447, 5964.821055368346], "value": 5607.34956817016, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.6314948041566, 461.68374663355604, 523.6805548615343, 540.4487422828713, 543.0144288117069, 31265.218369540744, 41351.37972930405, 41456.58543414565, 41476.79261603688, 41577.58422415775, 29305.0, 33646.15884602886, 41239.0, 42283.0, 42343.0, 9623.37448065877, 9778.511074446285, 9802.754931126708, 9809.705708828747, 9815.165710914582, 9598.616055357777, 9696.321257511978, 9703.320767546275, 9725.465099419529, 9829.017098290185, 8510.404271700983, 9646.035396460367, 9697.272704547151, 9723.12491875731, 9758.658446954358, 9601.711948641552, 9637.518124093802, 9722.756931076708, 9723.611055557805, 9745.610175592969, 9496.43021418717, 9580.377275477073, 9586.856197157049, 9592.568334424968, 9596.712098637052, 39938.60061399378, 40122.0, 40132.398014029524, 40156.795296141165, 40361.99095022619, 3275.0666060172975, 3363.9663603363897, 3391.932161356759, 3402.0, 3786.9053273668105, 30513.389732205454, 31230.687693123004, 31267.37465250705, 31335.0, 31612.36775264505, 3109.3159504908886, 3116.812991220534, 3119.298157914451, 3151.889683861054, 3231.418344697977, 439109.0, 440485.0, 443627.0, 446352.0, 446426.0, 32361.676383236336, 33371.16572085669, 56698.0, 57132.14301785477, 57168.856622868145, 34412.96761097171, 34609.48085778715, 34820.65179348225, 34886.30227395488, 34983.475247871305, 13404.798928015893, 13632.454701811816, 13741.381637826322, 13798.241096739575, 13807.309634518233, 12056.216345937486, 12175.086868484723, 12206.694832629079, 12345.135840491259, 12353.444095015746, 7662.501937374052, 7688.807779805549, 7765.456418050682, 7771.494852834548, 7890.053193616803, 2817.21118086936, 3275.755213019085, 3282.163048422685, 3294.6046474423224, 3301.0756988043386, 929.8558723397884, 963.6964356227905, 996.5864166371019, 1025.477006726575, 1033.9534720937577, 29727.0, 29826.0, 30064.699353006188, 30373.696263037527, 30754.38491230163, 1004.3923426327113, 1065.3767545985531, 1073.2487258918632, 1079.3092420850662, 1081.7782354617284, 12700.237985720887, 14536.491222807152, 14843.40626374933, 15464.38142474311, 15700.68448354193, 187015.0, 189357.0532147358, 650008.0, 650451.0, 652086.0, 55694.88610227773, 56154.15768763472, 56295.155572666445, 56396.0, 56628.58428539237, 1257.7485402025043, 1264.8988080953686, 1362.4822567424515, 1369.5548946592398, 1377.3457607636492, 28436.715632843407, 29326.26684332909, 29443.411131777673, 29876.850615746782, 30148.09555713332, 38051.80974095112, 43379.481718139716, 44969.100617986805, 45186.322205167606, 45366.31950520679, 567989.0, 568925.0, 569655.1517242388, 570425.0, 570519.0, 25497.490050199263, 25954.0, 26259.0, 26328.4734305309, 26445.942162314062, 37780.62219377771, 46540.06919861652, 46806.29790553213, 47229.52770472251, 47601.523984761094, 37996.62003379931, 38519.614803851604, 38690.568356068536, 39851.0, 40156.3976540358, 29251.0, 33210.6715731368, 35629.75295864632, 38080.80959595184, 41049.589504105774, 31588.684113159492, 36451.27097458089, 37420.81289593643, 37529.0, 38767.0, 28718.856405717837, 33640.0, 34319.656803431644, 34337.63463369177, 34569.48145777765, 25470.363240919127, 25506.23481295564, 25742.227733168034, 25808.870955645103, 26146.477070458102], "value": 17994.146467066792, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.55680706168994, 354.1553395152561, 374.5823406901306, 378.464472771029, 401.55026370465083, 19032.61934761304, 19628.705569416452, 20200.898995505002, 20697.482562935915, 20863.0, 20608.0, 20643.17427302906, 20998.160073597075, 21045.47386315339, 21110.683339749918, 5956.97021514894, 5980.7308671109795, 6075.756969721206, 6161.691915404234, 6226.128342032119, 6029.547783916224, 6129.38706129388, 6151.8769624607485, 6154.138420621117, 6163.506919446433, 5851.824445266649, 6050.0, 6105.847353816146, 6113.052476866093, 6116.266048074215, 5949.018411962021, 5992.161097446361, 6057.515398768088, 6105.236845394348, 6116.663583502906, 4617.145828021827, 5097.847064588032, 5267.893742314119, 5277.604179686539, 5304.946950530484, 25584.48831023369, 25602.743972560223, 25659.48681026369, 25694.229173124837, 25892.22323330303, 2241.181968581472, 2374.7150341959077, 2498.400383907849, 2899.913002609925, 3172.0959526534825, 15056.0, 15665.921670391575, 15709.057456552644, 15731.685366292724, 16182.271797769128, 1865.7761068671712, 1949.1618604000273, 1953.1601411393094, 1966.783653798081, 1974.3385965701507, 87216.12783872207, 107381.0, 109141.0, 114182.85817141888, 115104.42447787791, 8856.05166863289, 9003.864942025875, 9190.63237470507, 11113.611023614134, 11256.774864502664, 11288.887111128948, 13974.790378144337, 13989.580312590639, 14001.929990349983, 14014.579562613138, 6333.556651034383, 7972.521648701097, 8021.312860191901, 8099.635516401776, 8163.346932245406, 8412.705555305534, 8467.49195048299, 8472.830543389098, 8637.91362086371, 8646.221840034426, 3405.7615966882577, 3705.8326627112374, 3914.549826769901, 3929.3300347352833, 3969.940450893239, 1916.3197065041988, 1935.2936178295101, 1935.3613307608455, 1936.3610008697096, 1954.2280799084567, 711.491283732134, 794.7139029949213, 831.3556993330218, 834.8330333933237, 901.1661269316909, 20573.69139462909, 21320.253791117237, 21473.0, 21688.34934951954, 21774.564508710053, 891.5453118909403, 906.859436787299, 951.1344676344494, 966.1111777165025, 967.1102585621245, 11006.944965275123, 11377.975982161644, 11501.482433290523, 11504.884951150549, 11523.366214858095, 473652.0, 479397.0, 480936.0, 594541.0, 601469.0, 78434.21565784383, 81044.18955810484, 128910.85648668327, 137988.31005845108, 139060.0, 975.317277905469, 989.6931951095039, 1005.7133716890797, 1017.9796404071877, 1019.4393083803878, 16653.91673041627, 19101.617967640846, 19460.4161875144, 19798.307059252857, 19912.90043549773, 53701.0, 53985.73007134939, 54622.726886365315, 55245.44754552403, 55957.440425595225, 81687.59156204181, 82023.5898820502, 82657.93355165928, 82877.75683364875, 84409.0, 6888.483363747639, 7109.466789990668, 7211.81005134147, 7474.103107627119, 7995.12053674107, 11058.060064894253, 12579.496820127459, 12684.87315126837, 12955.805662914876, 13108.0, 8910.465372077697, 10258.333208341433, 10799.838002430128, 10950.890491094988, 11242.931921467447, 9677.70966870995, 9798.216142708709, 10978.396188209725, 10990.780184396108, 11121.0, 9766.560504777444, 10399.844002340122, 11110.944445277722, 11255.324680519196, 11567.537298507965, 6880.0, 8036.307836874713, 8112.18878112184, 8141.307988820779, 8197.754067377988, 8937.374383793072, 9935.65225217114, 10297.12474439681, 10483.580656773644, 10616.991385818645], "value": 9433.562783388206, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1524.5959820647524, 1535.1479928639603, 1737.2442987300526, 1822.5625849796054, 1834.4680042787584, 7817.765467035983, 8053.23494268045, 8273.255407013368, 8887.244584210343, 8930.59812308446, 8381.95809020954, 8647.264982476498, 8699.73900782976, 8776.824463510726, 8788.64845406183, 2354.835161538693, 2360.799332056777, 2393.1982785766704, 2396.269137912936, 2397.6643269942224, 2019.8182163605272, 2376.988115059431, 2400.603900356439, 2415.4685969086772, 2426.9393265168424, 2366.5976783946685, 2386.642003699442, 2395.9281221563383, 2408.0127147869375, 2417.2385698505004, 2357.0571771291447, 2377.037299893546, 2387.8328517003815, 2391.294568102414, 2395.293388450394, 2337.3805941425535, 2369.07606033647, 2387.021321258293, 2390.4740956989435, 2401.5196960607773, 8761.08008659088, 8766.21104100634, 8887.111288871061, 8917.33120015995, 8952.462852228888, 5228.398734145584, 5353.892922141536, 5356.571474282087, 5361.329833770778, 5367.597430192751, 3573.1960308930543, 3596.7482276240676, 3612.945805812915, 3662.6703596676425, 3665.9083522911874, 1069.2461814420815, 1070.6359837655157, 1075.2634445404922, 1078.7680648660498, 1088.9455527223606, 11507.827382589352, 11562.653120406401, 11578.826317605242, 11646.475908584134, 11649.068074554016, 4566.931496027562, 4597.241455159861, 4742.312364707098, 4800.687955282895, 4813.0, 8294.543800091053, 9782.461964592016, 9848.21214302854, 9877.802443951081, 9934.751631209278, 4760.238361862085, 5281.102212623863, 5297.152455607084, 5306.495882891119, 5316.441773613715, 4333.414988976511, 4491.640668746492, 4701.294805779161, 4827.444843843003, 4859.319695242669, 3249.415105281072, 3796.8291426885858, 3882.9223415531533, 3978.482797236341, 4001.3597824347967, 1127.21095233337, 1218.0194943070912, 1268.530643661851, 1281.4105511464832, 1290.1549485087282, 861.1517655109712, 870.7170169694874, 877.6533269358567, 912.9452232866049, 925.1303774451993, 4912.410510738734, 5646.030415519126, 5666.178404131378, 5925.466707996301, 5987.43119403656, 411.8290909272678, 415.9147374788161, 430.26639579517473, 433.62058199075807, 436.5154678307077, 3843.404272337792, 3895.2599006188734, 4005.439238506611, 4019.8392064317686, 4021.075152714892, 10280.948595256976, 10557.841632375521, 10673.252872298865, 10680.51937662807, 10785.676429707122, 10624.521896514676, 10627.0, 10665.520051597698, 10670.733231669115, 10731.570737170427, 8028.558429286329, 8038.598070096472, 8090.4336696431865, 8124.55314957683, 8162.265396114378, 5671.0, 5704.1443783432815, 5713.285839270091, 5758.568107392046, 5874.441928016831, 9415.435073895589, 9598.184154346958, 9798.706038818847, 9874.012598740068, 9906.554205060933, 9742.61029558838, 9848.261380396356, 9932.553035113293, 9988.001199880244, 10116.393016419039, 6800.693968771318, 6999.440044796303, 7181.533200341961, 7356.44826638015, 7518.36093932, 7975.162607926084, 8151.103378628465, 8212.384071194565, 8242.381821363302, 8258.380621453294, 6442.774502892376, 7262.419006479575, 7467.365273951557, 7533.924660753322, 7548.8490230196185, 7307.744228951961, 7323.707051717872, 7346.338829505156, 7351.338379545867, 7428.9628551856895, 6865.107536020485, 6881.243063262937, 6927.134108236471, 6931.930680693128, 6933.445324374139, 4873.756312184448, 4950.554450099508, 4965.1807451770055, 4986.301917731448, 5034.521720436553, 4863.319135321129, 4871.63462740303, 4937.876553086202, 5011.09800235961, 5090.592752579711], "value": 4454.248569097804, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [253.41966895808596, 292.5392506801788, 310.077519379845, 315.1789588122941, 316.7323611548241, 4311.741295522263, 4525.434320709911, 5464.371597266316, 5584.385717571069, 5608.355039170497, 4650.8605391679, 5233.969843220718, 5248.68507889526, 5344.545713614338, 5416.187571864222, 4188.727732697373, 4203.957960420387, 4235.788210589473, 4261.382099595557, 4300.8709738707885, 3731.5708693500187, 3991.0, 4284.022604290019, 4290.699651024414, 4293.506246781629, 3842.0992150926013, 4177.916441671165, 4203.243416185085, 4227.577242275764, 4236.279832428495, 3339.4990751387245, 3751.531058617673, 4197.517285512175, 4198.181354635832, 4206.49522057352, 3235.2558911450496, 3705.221903400289, 3710.128119891823, 3713.350163721365, 3734.3651579231323, 4947.901041979177, 5292.332915131759, 5360.463953604608, 5386.91919621206, 5433.6196466247375, 4710.246360582325, 4727.858164255078, 4736.881577960544, 4736.976315118437, 4746.596539294164, 5758.790653962673, 5771.249737534135, 5795.3335366432975, 5795.797147099874, 5810.564207684399, 3490.6858382745677, 3633.3278343506536, 3686.5391826021746, 3873.31510792806, 3939.0546268895546, 4718.363020992157, 5353.126405757993, 5567.721613919288, 6020.501491880908, 6094.908576371358, 3039.9088027359217, 3433.176037750972, 3449.413599688059, 3941.684665226775, 3980.44273801668, 3298.3568204200433, 3671.3391589514144, 3959.8416063357145, 3987.302222111119, 4025.597440255951, 3644.4351125575577, 4011.799410029545, 4435.268180750205, 4738.976305118453, 4752.881177970578, 5824.213731146241, 5836.503897168704, 5865.736041878125, 5873.412658734178, 5873.735681894325, 1178.0281267953972, 1296.6110166949877, 1308.2869835939437, 1358.6060042587737, 1370.8560601136737, 884.7832281091174, 910.0, 923.2060428031887, 924.5331107790523, 927.3632039450375, 5412.296401467784, 5429.484199001088, 5435.537979271727, 5446.428125046892, 5456.454354564591, 5044.672096313728, 5986.5809393342915, 5990.64056156632, 5998.850028749229, 6011.311177281727, 4689.460712018094, 4965.726885021286, 5270.868228294324, 5438.945610543844, 5463.262459567987, 2636.419987602724, 3094.4894092474938, 3143.7799354045455, 3144.5754823099046, 3146.7954582952034, 5765.913511297334, 6178.443940045418, 6283.277423096311, 6293.213348331458, 6363.295599370249, 5158.646879528336, 5505.862353441196, 6167.23798482925, 6222.888555722139, 6260.311365749764, 6251.593646412968, 6292.937070629327, 6298.307186209513, 6341.746330146835, 6405.775797847053, 5710.145651685013, 6038.788642397495, 6075.0, 6121.84695382619, 6173.9073913892225, 5030.496950304941, 5643.927653745775, 6000.369961154016, 6015.608985415934, 6043.667598282137, 5641.323041235078, 5880.323762767336, 6293.496520278275, 6358.205224346957, 6391.712372943136, 3980.7460649895193, 4011.976945878899, 4012.378081397388, 4040.6767458602653, 4055.809862674241, 5820.417958204146, 6084.300305464752, 6084.330723620486, 6091.441594530396, 6101.816945491642, 4729.290606409066, 4793.161196790617, 5074.847754567369, 5233.927044955851, 5811.302643682785, 5032.773525191302, 5408.486193811582, 5500.697461639648, 5696.493542841136, 5814.5639077068545, 4584.381108550303, 5443.896978722249, 5674.716264186856, 5821.185034095145, 5840.569060580185, 5029.673071250503, 5826.271716035496, 5835.44563266489, 5912.408759124053, 5919.556033297434, 5485.588580856372, 5698.458646428583, 5721.256236689203, 5735.512481439125, 5742.569307301886], "value": 4205.414159420311, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.5676865496378, 738.5753191914647, 768.8352146498056, 784.2040329066002, 787.9290863822256, 15304.464343747972, 16328.428505002328, 16331.101789401579, 16378.836211637896, 16418.671626567462, 11499.252548584356, 12165.965892899114, 12360.258384496936, 14722.55832325032, 14894.702105957875, 616.352829528995, 695.0929037605922, 783.7303568219478, 835.4653022065883, 867.3668222197799, 851.3572252949045, 865.9220670139687, 867.1588559097665, 868.5874209750381, 871.2159056848824, 917.321182325078, 920.8112336970938, 921.741912264567, 925.0333401595316, 929.7117893453018, 912.4798864647154, 914.5381582300929, 914.7210100919217, 915.6749353979308, 915.743591794302, 679.1578442731027, 679.3987321220706, 680.5270337115707, 682.4983637026781, 682.7917485167022, 15146.01550899188, 15180.544583662508, 15234.923825380802, 15242.923785381003, 15243.16162611056, 14667.0, 14668.193249371281, 14737.336819843133, 14767.556973290819, 14861.554153375417, 11919.284842909366, 12273.815892761615, 12293.69265768354, 12343.259404435763, 12559.93720031403, 3248.5614442050255, 3776.6978641708597, 3941.763494190329, 3994.001499625094, 3994.820233089518, 122241.0, 122475.0, 123652.76347236503, 123916.0, 124331.3783431086, 11037.668869933916, 11328.886711132947, 11431.314121152758, 11612.6516204514, 11700.06399488039, 23707.64438533389, 23707.7629223709, 23777.167799126946, 24102.39744006379, 24121.758782412304, 7684.6157692116285, 7831.804204894809, 7833.433313337356, 8022.879656805153, 8282.13037631052, 4477.126960242721, 4483.955160448354, 4496.3705081288645, 4560.977195114003, 4640.95359046412, 3459.3427248822645, 3590.4973303736974, 3594.964050359515, 3602.1174812171184, 3778.319902417591, 722.8445884134936, 726.4007194064917, 729.9598072746315, 731.7365748330596, 732.9963350183322, 523.9416378914572, 561.3488353509908, 605.2454606590429, 606.8015669053584, 705.1502938958542, 7999.1600881907725, 8331.750047498463, 9225.53872306382, 9665.0, 9836.311458197857, 544.6332374541674, 553.9833804985857, 563.6223730100842, 617.9011358182669, 674.8380388706676, 4500.842470513517, 4539.555129587413, 4770.236762118045, 4843.207133590769, 4864.075825593126, 131514.1091534511, 140891.0, 142694.0, 143356.0, 143751.0, 123061.0, 124404.37797810954, 135864.32067839795, 142009.0, 147792.0, 105733.0, 119303.0, 123451.0, 125382.0, 129618.35190823986, 9177.816443671223, 9249.445033298023, 9446.29152813528, 9743.46788645648, 10075.970807283351, 47917.0, 52959.73520132375, 54600.907981839344, 56462.0, 57105.42894571001, 58604.0, 80964.78552821594, 85022.57488712764, 91921.54039229761, 92040.07959920315, 12717.872821271669, 12920.418581163682, 12933.417996190006, 12985.870141298466, 13053.869461305645, 14735.042222255519, 14800.7779883304, 14855.851441485447, 14907.92546037263, 15342.15618141013, 13636.318184090955, 13788.706648802507, 13858.792118118035, 13965.0, 14011.0, 13551.25468099264, 13574.389152487964, 14098.36557354901, 14377.496787612383, 14539.982201245812, 13109.803352949522, 13370.799438008633, 13439.395227214603, 13652.795208072086, 13917.443302267797, 11054.502547385226, 11466.77066458683, 11633.360165190996, 11641.59254426091, 11723.706907327385, 8101.0, 9873.25950553697, 10984.340939543654, 11574.30554166719, 11712.121590880548], "value": 7867.833572052799, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1605.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 120.0, 122.0, 166.0, 117.0, 118.0, 124.0, 141.0, 117.0, 118.0], "value": 125.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 123.0, 132.0, 135.0, 101.0, 143.0, 145.0, 142.0, 172.0, 114.0], "value": 136.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 199.0, 235.0, 250.0, 281.0, 246.0, 196.0, 197.0, 194.0, 199.0], "value": 219.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 68.0, 86.0, 86.0, 58.0, 63.0, 61.0, 60.0, 81.0, 76.0], "value": 72.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 71.0, 86.0, 73.0, 71.0, 82.0, 90.0, 57.0, 88.0, 120.0], "value": 83.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 133.0, 107.0, 87.0, 88.0, 85.0, 89.0, 86.0, 90.0, 88.0], "value": 96.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 100.0, 98.0, 98.0, 115.0, 98.0, 99.0, 99.0, 131.0, 169.0], "value": 114.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 93.0, 91.0, 90.0, 91.0, 91.0, 91.0, 93.0, 117.0], "value": 105.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 85.0, 90.0, 48.0, 50.0, 81.0, 89.0, 88.0, 90.0], "value": 72.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 76.0, 77.0, 80.0, 73.0, 70.0, 72.0, 71.0, 75.0, 73.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 110.0, 90.0, 92.0, 86.0, 89.0, 80.0, 79.0, 107.0, 106.0], "value": 94.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 154.0, 155.0, 158.0, 155.0, 142.0, 143.0, 142.0, 175.0, 141.0], "value": 151.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 176.0, 238.0, 237.0, 196.0, 173.0, 175.0, 173.0, 174.0, 178.0], "value": 190.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 69.0, 80.0, 79.0, 68.0, 69.0, 66.0, 67.0, 67.0], "value": 70.2, "unit": "score"}]}]} 13:36:01 INFO - Return code: 0 13:36:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:36:01 ERROR - # TBPL SUCCESS # 13:36:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:36:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:36:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:36:01 INFO - 2016-09-23 13:36:01.862 screenresolution[1971:15014] starting screenresolution argv=screenresolution get 13:36:01 INFO - 2016-09-23 13:36:01.864 screenresolution[1971:15014] Display 0: 1600x1200x32@60 13:36:01 INFO - 2016-09-23 13:36:01.870 screenresolution[1972:15017] starting screenresolution argv=screenresolution list 13:36:01 INFO - Available Modes on Display 0 13:36:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:36:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:36:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:36:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:36:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:36:02 INFO - Intel Iris: 13:36:02 INFO - Chipset Model: Intel Iris 13:36:02 INFO - Type: GPU 13:36:02 INFO - Bus: Built-In 13:36:02 INFO - VRAM (Dynamic, Max): 1536 MB 13:36:02 INFO - Vendor: Intel (0x8086) 13:36:02 INFO - Device ID: 0x0a2e 13:36:02 INFO - Revision ID: 0x0009 13:36:02 INFO - Displays: 13:36:02 INFO - Display: 13:36:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:36:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:36:02 INFO - Display Serial Number: 1600x1200 60 13:36:02 INFO - Main Display: Yes 13:36:02 INFO - Mirror: Off 13:36:02 INFO - Online: Yes 13:36:02 INFO - Rotation: Supported 13:36:02 INFO - Return code: 0 13:36:02 INFO - Running post-action listener: _resource_record_post_action 13:36:02 INFO - [mozharness: 2016-09-23 20:36:02.104562Z] Finished run-tests step (success) 13:36:02 INFO - Running post-run listener: _resource_record_post_run 13:36:02 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 757760; Write bytes: 707682816; Read time: 9; Write time: 2000 13:36:02 INFO - TinderboxPrint: CPU usage
54.3% 13:36:02 INFO - TinderboxPrint: I/O read bytes / time
757,760 / 9 13:36:02 INFO - TinderboxPrint: I/O write bytes / time
707,682,816 / 2,000 13:36:02 INFO - TinderboxPrint: CPU idle
2,213.6 (45.7%) 13:36:02 INFO - TinderboxPrint: CPU system
976.5 (20.2%) 13:36:02 INFO - TinderboxPrint: CPU user
1,655.6 (34.2%) 13:36:02 INFO - TinderboxPrint: Swap in / out
407,285,760 / 0 13:36:02 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 390621696; Write bytes: 384595456; Read time: 29235; Write time: 778 13:36:02 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 757760; Write bytes: 298847232; Read time: 9; Write time: 1162 13:36:02 INFO - Running post-run listener: _upload_blobber_files 13:36:02 INFO - Blob upload gear active. 13:36:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:36:02 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 13:36:02 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:36:02 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:36:02 INFO - (blobuploader) - INFO - Open directory for files ... 13:36:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:36:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:36:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:36:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:36:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:36:05 INFO - (blobuploader) - INFO - Done attempting. 13:36:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:36:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:36:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:36:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:36:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:36:06 INFO - (blobuploader) - INFO - Done attempting. 13:36:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:36:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:36:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:36:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:36:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:36:08 INFO - (blobuploader) - INFO - Done attempting. 13:36:08 INFO - (blobuploader) - INFO - Iteration through files over. 13:36:08 INFO - Return code: 0 13:36:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:36:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:36:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c9e20854df2c0d46fd40d0f1b63c01e4500770eb8c58a938d140db93fc90f191ee8e90d99f3b64d5f6c36580a9151599babfc9163102a403cf994e1181677c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48f552e9f92f3a9ca8fc404285d9ab516e3704742e402a54cf7b6195935c116523364dd93de2c7e6589b2b552b6a0c809da1173f4949989203bcce12c71afcf7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e92ac05fcd8c0fdb8fe612982b2dcd5a741142517026fa6c78fc1aaebbac043778cfa30177f4e1e10f5ced431813a555654abe86bdfd3395d4d763ad02be263d"} 13:36:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:36:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:36:08 INFO - Contents: 13:36:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c9e20854df2c0d46fd40d0f1b63c01e4500770eb8c58a938d140db93fc90f191ee8e90d99f3b64d5f6c36580a9151599babfc9163102a403cf994e1181677c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48f552e9f92f3a9ca8fc404285d9ab516e3704742e402a54cf7b6195935c116523364dd93de2c7e6589b2b552b6a0c809da1173f4949989203bcce12c71afcf7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e92ac05fcd8c0fdb8fe612982b2dcd5a741142517026fa6c78fc1aaebbac043778cfa30177f4e1e10f5ced431813a555654abe86bdfd3395d4d763ad02be263d"} 13:36:08 INFO - Running post-run listener: copy_logs_to_upload_dir 13:36:08 INFO - Copying logs to upload dir... 13:36:08 INFO - mkdir: /builds/slave/test/build/upload/logs 13:36:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.221211 ========= master_lag: 3.74 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-23 13:36:12.401430) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 13:36:12.408386) ========= 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.kq9e6qX7TC/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.0npSKYXThG/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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/Fx-Team/sha512/5c9e20854df2c0d46fd40d0f1b63c01e4500770eb8c58a938d140db93fc90f191ee8e90d99f3b64d5f6c36580a9151599babfc9163102a403cf994e1181677c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48f552e9f92f3a9ca8fc404285d9ab516e3704742e402a54cf7b6195935c116523364dd93de2c7e6589b2b552b6a0c809da1173f4949989203bcce12c71afcf7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e92ac05fcd8c0fdb8fe612982b2dcd5a741142517026fa6c78fc1aaebbac043778cfa30177f4e1e10f5ced431813a555654abe86bdfd3395d4d763ad02be263d"} build_url:https://queue.taskcluster.net/v1/task/YeL4aS1pTvWVBl8XjliyFw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011629 build_url: 'https://queue.taskcluster.net/v1/task/YeL4aS1pTvWVBl8XjliyFw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c9e20854df2c0d46fd40d0f1b63c01e4500770eb8c58a938d140db93fc90f191ee8e90d99f3b64d5f6c36580a9151599babfc9163102a403cf994e1181677c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48f552e9f92f3a9ca8fc404285d9ab516e3704742e402a54cf7b6195935c116523364dd93de2c7e6589b2b552b6a0c809da1173f4949989203bcce12c71afcf7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e92ac05fcd8c0fdb8fe612982b2dcd5a741142517026fa6c78fc1aaebbac043778cfa30177f4e1e10f5ced431813a555654abe86bdfd3395d4d763ad02be263d"}' ========= master_lag: 0.08 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 13:36:12.496274) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 13:36:12.496638) ========= 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.kq9e6qX7TC/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.0npSKYXThG/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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.005336 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 13:36:12.526213) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 13:36:12.526861) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 13:36:12.527451) ========= ========= Total master_lag: 4.30 =========