builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0300 starttime: 1472525436.18 results: success (0) buildid: 20160829173530 builduid: e719c450bbf348dcb54fbfc2249261ef revision: 7293879d87d780790cb0f67e98226b7d4de6d4e1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 19:50:36.183804) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 19:50:36.184264) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 19:50:36.184565) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 19:50:36.234538) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 19:50:36.234883) ========= 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.YDXDek3S7I/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.fe1d4XUCTb/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-29 19:50:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 4.91M=0.002s 2016-08-29 19:50:36 (4.91 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103438 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 19:50:36.380384) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 19:50:36.380752) ========= 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.YDXDek3S7I/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.fe1d4XUCTb/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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.025973 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 19:50:36.433281) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-08-29 19:50:36.433662) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7293879d87d780790cb0f67e98226b7d4de6d4e1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 7293879d87d780790cb0f67e98226b7d4de6d4e1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YDXDek3S7I/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.fe1d4XUCTb/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-29 19:50:36,520 truncating revision to first 12 chars 2016-08-29 19:50:36,520 Setting DEBUG logging. 2016-08-29 19:50:36,520 attempt 1/10 2016-08-29 19:50:36,520 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7293879d87d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-29 19:50:37,901 unpacking tar archive at: mozilla-central-7293879d87d7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.642176 ========= master_lag: 1.43 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-08-29 19:50:39.502674) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 19:50:39.502969) ========= script_repo_revision: 7293879d87d780790cb0f67e98226b7d4de6d4e1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 19:50:39.503341) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 19:50:39.503632) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 19:50:39.561160) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-29 19:50:39.561495) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YDXDek3S7I/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.fe1d4XUCTb/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 19:50:39 INFO - MultiFileLogger online at 20160829 19:50:39 in /builds/slave/test 19:50:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:50:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:50:39 INFO - {'append_to_log': False, 19:50:39 INFO - 'base_work_dir': '/builds/slave/test', 19:50:39 INFO - 'blob_upload_branch': 'Firefox', 19:50:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:50:39 INFO - 'branch': 'Firefox', 19:50:39 INFO - 'buildbot_json_path': 'buildprops.json', 19:50:39 INFO - 'config_files': ('talos/mac_config.py',), 19:50:39 INFO - 'default_actions': ('clobber', 19:50:39 INFO - 'read-buildbot-config', 19:50:39 INFO - 'download-and-extract', 19:50:39 INFO - 'populate-webroot', 19:50:39 INFO - 'create-virtualenv', 19:50:39 INFO - 'install', 19:50:39 INFO - 'run-tests'), 19:50:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:50:39 INFO - 'download_minidump_stackwalk': True, 19:50:39 INFO - 'download_symbols': 'ondemand', 19:50:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:50:39 INFO - 'tooltool.py': '/tools/tooltool.py', 19:50:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:50:39 INFO - '/tools/misc-python/virtualenv.py')}, 19:50:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:50:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:50:39 INFO - 'installer_path': 'installer.exe', 19:50:39 INFO - 'log_level': 'info', 19:50:39 INFO - 'log_name': 'talos', 19:50:39 INFO - 'log_to_console': True, 19:50:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:50:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:50:39 INFO - 'opt_config_files': (), 19:50:39 INFO - 'pip_index': False, 19:50:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:50:39 INFO - 'cmd': ('bash', 19:50:39 INFO - '-c', 19:50:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:50:39 INFO - 'enabled': True, 19:50:39 INFO - 'halt_on_failure': False, 19:50:39 INFO - 'name': 'check_screen_resolution'},), 19:50:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:50:39 INFO - 'cmd': ('bash', 19:50:39 INFO - '-c', 19:50:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:50:39 INFO - 'enabled': True, 19:50:39 INFO - 'halt_on_failure': False, 19:50:39 INFO - 'name': 'check_screen_resolution'},), 19:50:39 INFO - 'run_cmd_checks_enabled': True, 19:50:39 INFO - 'sps_profile': False, 19:50:39 INFO - 'sps_profile_interval': 0, 19:50:39 INFO - 'suite': 'dromaeojs-e10s', 19:50:39 INFO - 'system_bits': '32', 19:50:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:50:39 INFO - 'title': 't-yosemite-r7-0300', 19:50:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:50:39 INFO - 'use_talos_json': True, 19:50:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:50:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:50:39 INFO - 'work_dir': 'build'} 19:50:39 INFO - [mozharness: 2016-08-30 02:50:39.765426Z] Running clobber step. 19:50:39 INFO - Running pre-action listener: _resource_record_pre_action 19:50:39 INFO - Running main action method: clobber 19:50:39 INFO - rmtree: /builds/slave/test/build 19:50:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:50:41 INFO - Running post-action listener: _resource_record_post_action 19:50:41 INFO - [mozharness: 2016-08-30 02:50:41.697480Z] Finished clobber step (success) 19:50:41 INFO - [mozharness: 2016-08-30 02:50:41.697671Z] Running read-buildbot-config step. 19:50:41 INFO - Running pre-action listener: _resource_record_pre_action 19:50:41 INFO - Running main action method: read_buildbot_config 19:50:41 INFO - Using buildbot properties: 19:50:41 INFO - { 19:50:41 INFO - "project": "", 19:50:41 INFO - "product": "firefox", 19:50:41 INFO - "script_repo_revision": "production", 19:50:41 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 19:50:41 INFO - "repository": "", 19:50:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 19:50:41 INFO - "buildid": "20160829173530", 19:50:41 INFO - "pgo_build": "False", 19:50:41 INFO - "basedir": "/builds/slave/test", 19:50:41 INFO - "buildnumber": 25, 19:50:41 INFO - "slavename": "t-yosemite-r7-0300", 19:50:41 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 19:50:41 INFO - "platform": "yosemite_r7", 19:50:41 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:50:41 INFO - "branch": "mozilla-central", 19:50:41 INFO - "repo_path": "mozilla-central", 19:50:41 INFO - "revision": "7293879d87d780790cb0f67e98226b7d4de6d4e1", 19:50:41 INFO - "stage_platform": "macosx64", 19:50:41 INFO - "builduid": "e719c450bbf348dcb54fbfc2249261ef", 19:50:41 INFO - "slavebuilddir": "test" 19:50:41 INFO - } 19:50:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/IA-Kx_oxROWwVIkFZkMP6g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 19:50:41 INFO - Running post-action listener: _resource_record_post_action 19:50:41 INFO - [mozharness: 2016-08-30 02:50:41.700956Z] Finished read-buildbot-config step (success) 19:50:41 INFO - [mozharness: 2016-08-30 02:50:41.701090Z] Running download-and-extract step. 19:50:41 INFO - Running pre-action listener: _resource_record_pre_action 19:50:41 INFO - Running main action method: download_and_extract 19:50:41 INFO - mkdir: /builds/slave/test/build/tests 19:50:41 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')]} 19:50:41 INFO - trying https://queue.taskcluster.net/v1/task/IA-Kx_oxROWwVIkFZkMP6g/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 19:50:41 INFO - Downloading https://queue.taskcluster.net/v1/task/IA-Kx_oxROWwVIkFZkMP6g/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 19:50:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IA-Kx_oxROWwVIkFZkMP6g/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 19:50:42 INFO - Downloaded 1199 bytes. 19:50:42 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 19:50:42 INFO - Using the following test package requirements: 19:50:42 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 19:50:42 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:50:42 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 19:50:42 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:50:42 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 19:50:42 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:50:42 INFO - u'jsshell-mac.zip'], 19:50:42 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:50:42 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 19:50:42 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 19:50:42 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:50:42 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 19:50:42 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:50:42 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 19:50:42 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:50:42 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 19:50:42 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:50:42 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 19:50:42 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:50:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:50:42 INFO - trying https://queue.taskcluster.net/v1/task/IA-Kx_oxROWwVIkFZkMP6g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 19:50:42 INFO - Downloading https://queue.taskcluster.net/v1/task/IA-Kx_oxROWwVIkFZkMP6g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 19:50:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IA-Kx_oxROWwVIkFZkMP6g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:50:43 INFO - Downloaded 16372604 bytes. 19:50:43 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 19:50:50 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:50:50 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')]} 19:50:50 INFO - trying https://queue.taskcluster.net/v1/task/IA-Kx_oxROWwVIkFZkMP6g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 19:50:50 INFO - Downloading https://queue.taskcluster.net/v1/task/IA-Kx_oxROWwVIkFZkMP6g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 19:50:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IA-Kx_oxROWwVIkFZkMP6g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:50:51 INFO - Downloaded 16372604 bytes. 19:50:51 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 19:50: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')]} 19:50:58 INFO - trying https://queue.taskcluster.net/v1/task/IA-Kx_oxROWwVIkFZkMP6g/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 19:50:58 INFO - Downloading https://queue.taskcluster.net/v1/task/IA-Kx_oxROWwVIkFZkMP6g/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 19:50:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IA-Kx_oxROWwVIkFZkMP6g/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:50:59 INFO - Downloaded 14413998 bytes. 19:50:59 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 19:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:50:59 INFO - trying https://queue.taskcluster.net/v1/task/IA-Kx_oxROWwVIkFZkMP6g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:50:59 INFO - Downloading https://queue.taskcluster.net/v1/task/IA-Kx_oxROWwVIkFZkMP6g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 19:50:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IA-Kx_oxROWwVIkFZkMP6g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 19:51:02 INFO - Downloaded 111549623 bytes. 19:51:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IA-Kx_oxROWwVIkFZkMP6g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:51:02 INFO - mkdir: /builds/slave/test/properties 19:51:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:51:02 INFO - Writing to file /builds/slave/test/properties/build_url 19:51:02 INFO - Contents: 19:51:02 INFO - build_url:https://queue.taskcluster.net/v1/task/IA-Kx_oxROWwVIkFZkMP6g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:51:02 INFO - Running post-action listener: _resource_record_post_action 19:51:02 INFO - Running post-action listener: set_extra_try_arguments 19:51:02 INFO - [mozharness: 2016-08-30 02:51:02.971337Z] Finished download-and-extract step (success) 19:51:02 INFO - [mozharness: 2016-08-30 02:51:02.971454Z] Running populate-webroot step. 19:51:02 INFO - Running pre-action listener: _resource_record_pre_action 19:51:02 INFO - Running main action method: populate_webroot 19:51:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:51:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:51:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:51:02 INFO - '--tppagecycles', 19:51:02 INFO - '7'], 19:51:02 INFO - 'tests': ['tsvgm']}}, 19:51:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:51:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:51:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:51:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:51:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:51:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:51:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:02 INFO - 'talos_options': ['--disable-e10s'], 19:51:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:51:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:51:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:02 INFO - 'talos_options': ['--disable-e10s'], 19:51:02 INFO - 'tests': ['damp', 'tps']}, 19:51:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:02 INFO - 'tests': ['damp', 'tps']}, 19:51:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:51:02 INFO - 'tests': ['dromaeo_dom']}, 19:51:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:51:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:51:02 INFO - 'tests': ['basic_compositor_video']}, 19:51:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:51:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:51:02 INFO - 'tests': ['a11yr', 19:51:02 INFO - 'ts_paint', 19:51:02 INFO - 'tpaint', 19:51:02 INFO - 'sessionrestore', 19:51:02 INFO - 'sessionrestore_no_auto_restore', 19:51:02 INFO - 'tabpaint']}, 19:51:02 INFO - 'other-e10s': {'tests': ['a11yr', 19:51:02 INFO - 'ts_paint', 19:51:02 INFO - 'tpaint', 19:51:02 INFO - 'sessionrestore', 19:51:02 INFO - 'sessionrestore_no_auto_restore', 19:51:02 INFO - 'tabpaint']}, 19:51:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:51:02 INFO - 'ts_paint', 19:51:02 INFO - 'tpaint', 19:51:02 INFO - 'sessionrestore', 19:51:02 INFO - 'sessionrestore_no_auto_restore', 19:51:02 INFO - 'tabpaint']}, 19:51:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:51:02 INFO - 'ts_paint', 19:51:02 INFO - 'tpaint', 19:51:02 INFO - 'sessionrestore', 19:51:02 INFO - 'sessionrestore_no_auto_restore', 19:51:02 INFO - 'tabpaint']}, 19:51:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:51:02 INFO - 'tests': ['a11yr', 19:51:02 INFO - 'ts_paint', 19:51:02 INFO - 'tpaint', 19:51:02 INFO - 'sessionrestore', 19:51:02 INFO - 'sessionrestore_no_auto_restore', 19:51:02 INFO - 'tabpaint']}, 19:51:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:51:02 INFO - 'tests': ['a11yr', 19:51:02 INFO - 'ts_paint', 19:51:02 INFO - 'tpaint', 19:51:02 INFO - 'sessionrestore', 19:51:02 INFO - 'sessionrestore_no_auto_restore', 19:51:02 INFO - 'tabpaint']}, 19:51:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:51:02 INFO - 'tests': ['tsvgx', 19:51:02 INFO - 'tsvgr_opacity', 19:51:02 INFO - 'tart', 19:51:02 INFO - 'tscrollx', 19:51:02 INFO - 'cart']}, 19:51:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:51:02 INFO - 'tsvgr_opacity', 19:51:02 INFO - 'tart', 19:51:02 INFO - 'tscrollx', 19:51:02 INFO - 'cart']}, 19:51:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:02 INFO - 'talos_options': ['--disable-e10s'], 19:51:02 INFO - 'tests': ['tp5o']}, 19:51:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:02 INFO - 'tests': ['tp5o']}, 19:51:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:02 INFO - 'talos_options': ['--disable-e10s', 19:51:02 INFO - '--xperf_path', 19:51:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:51:02 INFO - 'tests': ['tp5n']}, 19:51:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:02 INFO - 'talos_options': ['--xperf_path', 19:51:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:51:02 INFO - 'tests': ['tp5n']}}, 19:51:02 INFO - 'talos.zip': {'path': '', 19:51:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:51:02 INFO - Running post-action listener: _resource_record_post_action 19:51:02 INFO - [mozharness: 2016-08-30 02:51:02.989683Z] Finished populate-webroot step (success) 19:51:02 INFO - [mozharness: 2016-08-30 02:51:02.989800Z] Running create-virtualenv step. 19:51:02 INFO - Running pre-action listener: _resource_record_pre_action 19:51:02 INFO - Running main action method: create_virtualenv 19:51:02 INFO - Creating virtualenv /builds/slave/test/build/venv 19:51:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:51:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:51:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:51:03 INFO - Using real prefix '/tools/python27' 19:51:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:51:03 INFO - Installing distribute.............................................................................................................................................................................................done. 19:51:06 INFO - Installing pip.................done. 19:51:06 INFO - Return code: 0 19:51:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:51:06 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')]} 19:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:07 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')]} 19:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:07 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 0x1022a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102337618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd220d50da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102206d30>, '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 0x101f6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021feb20>, '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.YDXDek3S7I/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.fe1d4XUCTb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:51:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:51:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YDXDek3S7I/Render', 19:51:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:07 INFO - 'HOME': '/Users/cltbld', 19:51:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:07 INFO - 'LOGNAME': 'cltbld', 19:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:07 INFO - 'MOZ_NO_REMOTE': '1', 19:51:07 INFO - 'NO_EM_RESTART': '1', 19:51:07 INFO - 'PAGER': '/bin/cat', 19:51:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:07 INFO - 'PWD': '/builds/slave/test', 19:51:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:07 INFO - 'SHELL': '/bin/bash', 19:51:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fe1d4XUCTb/Listeners', 19:51:07 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 19:51:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:07 INFO - 'USER': 'cltbld', 19:51:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:07 INFO - 'XPC_FLAGS': '0x0', 19:51:07 INFO - 'XPC_SERVICE_NAME': '0', 19:51:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:51:07 INFO - Cleaning up... 19:51:07 INFO - Return code: 0 19:51:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:51:07 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')]} 19:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:07 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')]} 19:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:07 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 0x1022a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102337618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd220d50da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102206d30>, '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 0x101f6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021feb20>, '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.YDXDek3S7I/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.fe1d4XUCTb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:51:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:51:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YDXDek3S7I/Render', 19:51:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:07 INFO - 'HOME': '/Users/cltbld', 19:51:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:07 INFO - 'LOGNAME': 'cltbld', 19:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:07 INFO - 'MOZ_NO_REMOTE': '1', 19:51:07 INFO - 'NO_EM_RESTART': '1', 19:51:07 INFO - 'PAGER': '/bin/cat', 19:51:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:07 INFO - 'PWD': '/builds/slave/test', 19:51:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:07 INFO - 'SHELL': '/bin/bash', 19:51:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fe1d4XUCTb/Listeners', 19:51:07 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 19:51:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:07 INFO - 'USER': 'cltbld', 19:51:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:07 INFO - 'XPC_FLAGS': '0x0', 19:51:07 INFO - 'XPC_SERVICE_NAME': '0', 19:51:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:07 INFO - Downloading/unpacking psutil>=3.1.1 19:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:51:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:51:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:51:10 INFO - Installing collected packages: psutil 19:51:10 INFO - Running setup.py install for psutil 19:51:11 INFO - building 'psutil._psutil_osx' extension 19:51:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 19:51:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 19:51:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 19:51:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 19:51:11 INFO - building 'psutil._psutil_posix' extension 19:51:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 19:51:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:51:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:51:11 INFO - ^ 19:51:11 INFO - 1 warning generated. 19:51:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 19:51:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:51:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:51:12 INFO - Successfully installed psutil 19:51:12 INFO - Cleaning up... 19:51:12 INFO - Return code: 0 19:51:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:51:12 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')]} 19:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:12 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')]} 19:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:12 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 0x1022a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102337618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd220d50da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102206d30>, '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 0x101f6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021feb20>, '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.YDXDek3S7I/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.fe1d4XUCTb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:51:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:51:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YDXDek3S7I/Render', 19:51:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:12 INFO - 'HOME': '/Users/cltbld', 19:51:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:12 INFO - 'LOGNAME': 'cltbld', 19:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:12 INFO - 'MOZ_NO_REMOTE': '1', 19:51:12 INFO - 'NO_EM_RESTART': '1', 19:51:12 INFO - 'PAGER': '/bin/cat', 19:51:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:12 INFO - 'PWD': '/builds/slave/test', 19:51:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:12 INFO - 'SHELL': '/bin/bash', 19:51:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fe1d4XUCTb/Listeners', 19:51:12 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 19:51:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:12 INFO - 'USER': 'cltbld', 19:51:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:12 INFO - 'XPC_FLAGS': '0x0', 19:51:12 INFO - 'XPC_SERVICE_NAME': '0', 19:51:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:51:14 INFO - Installing collected packages: mozsystemmonitor 19:51:14 INFO - Running setup.py install for mozsystemmonitor 19:51:15 INFO - Successfully installed mozsystemmonitor 19:51:15 INFO - Cleaning up... 19:51:15 INFO - Return code: 0 19:51:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:51:15 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')]} 19:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:15 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')]} 19:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:15 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 0x1022a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102337618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd220d50da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102206d30>, '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 0x101f6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021feb20>, '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.YDXDek3S7I/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.fe1d4XUCTb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:51:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:51:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:51:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YDXDek3S7I/Render', 19:51:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:15 INFO - 'HOME': '/Users/cltbld', 19:51:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:15 INFO - 'LOGNAME': 'cltbld', 19:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:15 INFO - 'MOZ_NO_REMOTE': '1', 19:51:15 INFO - 'NO_EM_RESTART': '1', 19:51:15 INFO - 'PAGER': '/bin/cat', 19:51:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:15 INFO - 'PWD': '/builds/slave/test', 19:51:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:15 INFO - 'SHELL': '/bin/bash', 19:51:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fe1d4XUCTb/Listeners', 19:51:15 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 19:51:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:15 INFO - 'USER': 'cltbld', 19:51:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:15 INFO - 'XPC_FLAGS': '0x0', 19:51:15 INFO - 'XPC_SERVICE_NAME': '0', 19:51:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:15 INFO - Downloading/unpacking jsonschema==2.5.1 19:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:51:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:18 INFO - Downloading functools32-3.2.3-2.tar.gz 19:51:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:51:18 INFO - warning: no files found matching '*.txt' 19:51:18 INFO - no previously-included directories found matching 'build' 19:51:18 INFO - no previously-included directories found matching 'dist' 19:51:18 INFO - no previously-included directories found matching '.git*' 19:51:18 INFO - Installing collected packages: jsonschema, functools32 19:51:18 INFO - Running setup.py install for functools32 19:51:18 INFO - warning: no files found matching '*.txt' 19:51:18 INFO - no previously-included directories found matching 'build' 19:51:18 INFO - no previously-included directories found matching 'dist' 19:51:18 INFO - no previously-included directories found matching '.git*' 19:51:18 INFO - Successfully installed jsonschema functools32 19:51:18 INFO - Cleaning up... 19:51:18 INFO - Return code: 0 19:51:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:18 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 0x1022a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102337618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd220d50da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102206d30>, '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 0x101f6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021feb20>, '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.YDXDek3S7I/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.fe1d4XUCTb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:51:18 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 19:51:18 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 19:51:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YDXDek3S7I/Render', 19:51:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:18 INFO - 'HOME': '/Users/cltbld', 19:51:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:18 INFO - 'LOGNAME': 'cltbld', 19:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:18 INFO - 'MOZ_NO_REMOTE': '1', 19:51:18 INFO - 'NO_EM_RESTART': '1', 19:51:18 INFO - 'PAGER': '/bin/cat', 19:51:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:18 INFO - 'PWD': '/builds/slave/test', 19:51:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:18 INFO - 'SHELL': '/bin/bash', 19:51:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fe1d4XUCTb/Listeners', 19:51:18 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 19:51:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:18 INFO - 'USER': 'cltbld', 19:51:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:18 INFO - 'XPC_FLAGS': '0x0', 19:51:18 INFO - 'XPC_SERVICE_NAME': '0', 19:51:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:51:18 INFO - Cleaning up... 19:51:18 INFO - Return code: 0 19:51:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:18 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 0x1022a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102337618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd220d50da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102206d30>, '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 0x101f6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021feb20>, '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.YDXDek3S7I/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.fe1d4XUCTb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:51:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:51:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:51:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YDXDek3S7I/Render', 19:51:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:18 INFO - 'HOME': '/Users/cltbld', 19:51:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:18 INFO - 'LOGNAME': 'cltbld', 19:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:18 INFO - 'MOZ_NO_REMOTE': '1', 19:51:18 INFO - 'NO_EM_RESTART': '1', 19:51:18 INFO - 'PAGER': '/bin/cat', 19:51:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:18 INFO - 'PWD': '/builds/slave/test', 19:51:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:18 INFO - 'SHELL': '/bin/bash', 19:51:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fe1d4XUCTb/Listeners', 19:51:18 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 19:51:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:18 INFO - 'USER': 'cltbld', 19:51:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:18 INFO - 'XPC_FLAGS': '0x0', 19:51:18 INFO - 'XPC_SERVICE_NAME': '0', 19:51:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:19 INFO - Downloading/unpacking blobuploader==1.2.4 19:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:21 INFO - Downloading blobuploader-1.2.4.tar.gz 19:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:51:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:51:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:22 INFO - Downloading docopt-0.6.1.tar.gz 19:51:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:51:22 INFO - Installing collected packages: blobuploader, requests, docopt 19:51:22 INFO - Running setup.py install for blobuploader 19:51:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:51:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:51:23 INFO - Running setup.py install for requests 19:51:23 INFO - Running setup.py install for docopt 19:51:23 INFO - Successfully installed blobuploader requests docopt 19:51:23 INFO - Cleaning up... 19:51:23 INFO - Return code: 0 19:51:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:51: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')]} 19:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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')]} 19:51:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:23 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 0x1022a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102337618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd220d50da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102206d30>, '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 0x101f6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021feb20>, '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.YDXDek3S7I/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.fe1d4XUCTb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:51:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:51:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YDXDek3S7I/Render', 19:51:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:23 INFO - 'HOME': '/Users/cltbld', 19:51:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:23 INFO - 'LOGNAME': 'cltbld', 19:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:23 INFO - 'MOZ_NO_REMOTE': '1', 19:51:23 INFO - 'NO_EM_RESTART': '1', 19:51:23 INFO - 'PAGER': '/bin/cat', 19:51:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:23 INFO - 'PWD': '/builds/slave/test', 19:51:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:23 INFO - 'SHELL': '/bin/bash', 19:51:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fe1d4XUCTb/Listeners', 19:51:23 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 19:51:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:23 INFO - 'USER': 'cltbld', 19:51:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:23 INFO - 'XPC_FLAGS': '0x0', 19:51:23 INFO - 'XPC_SERVICE_NAME': '0', 19:51:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:51:24 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-ZDWVfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:51:24 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-J47_CB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:51:24 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-toaCdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:51:24 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-UNf9If-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:51:24 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-uJPkDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:51:24 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-GX33Gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:51:24 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-6mvjVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:51:24 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-rLfcQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:51:24 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-Y4XX8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:51:24 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-NpFFe_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:51:25 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-XZY323-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:51:25 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-903P3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:51:25 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-JJpZZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:51:25 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-6H1Wrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:51:25 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-lwwRUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:51:25 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-hPLw2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:51:25 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-bAaJGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:51:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:51:25 INFO - Running setup.py install for manifestparser 19:51:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:51:25 INFO - Running setup.py install for mozcrash 19:51:26 INFO - Running setup.py install for mozdebug 19:51:26 INFO - Running setup.py install for mozdevice 19:51:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:51:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:51:26 INFO - Running setup.py install for mozfile 19:51:26 INFO - Running setup.py install for mozhttpd 19:51:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:51:26 INFO - Running setup.py install for mozinfo 19:51:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:51:26 INFO - Running setup.py install for mozInstall 19:51:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:51:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:51:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:51:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:51:26 INFO - Running setup.py install for mozleak 19:51:27 INFO - Running setup.py install for mozlog 19:51:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:51:27 INFO - Running setup.py install for moznetwork 19:51:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:51:27 INFO - Running setup.py install for mozprocess 19:51:27 INFO - Running setup.py install for mozprofile 19:51:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:51:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:51:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:51:27 INFO - Running setup.py install for mozrunner 19:51:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:51:27 INFO - Running setup.py install for mozscreenshot 19:51:28 INFO - Running setup.py install for moztest 19:51:28 INFO - Running setup.py install for mozversion 19:51:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:51:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:51:28 INFO - Cleaning up... 19:51:28 INFO - Return code: 0 19:51:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:51: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')]} 19:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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')]} 19:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:28 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 0x1022a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102337618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd220d50da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102206d30>, '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 0x101f6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021feb20>, '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.YDXDek3S7I/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.fe1d4XUCTb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:51:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:51:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YDXDek3S7I/Render', 19:51:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:28 INFO - 'HOME': '/Users/cltbld', 19:51:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:28 INFO - 'LOGNAME': 'cltbld', 19:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:28 INFO - 'MOZ_NO_REMOTE': '1', 19:51:28 INFO - 'NO_EM_RESTART': '1', 19:51:28 INFO - 'PAGER': '/bin/cat', 19:51:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:28 INFO - 'PWD': '/builds/slave/test', 19:51:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:28 INFO - 'SHELL': '/bin/bash', 19:51:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fe1d4XUCTb/Listeners', 19:51:28 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 19:51:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:28 INFO - 'USER': 'cltbld', 19:51:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:28 INFO - 'XPC_FLAGS': '0x0', 19:51:28 INFO - 'XPC_SERVICE_NAME': '0', 19:51:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:51:28 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-yNlgnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:51:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:51:28 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-u3jI6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:51:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:51:28 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-Oa_bCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:51:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:51:28 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-Bozb_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:51:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:51:29 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-uL3sCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:51:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:51:29 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-560yVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:51:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:51:29 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-1n2dwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:51:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:51:29 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-sEY5rE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:51:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:51:29 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-2kSIft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:51:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:51:29 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-6Y6y1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:51:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:51:29 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-OWt1cW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:51:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:51:29 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-d4AWvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:51:29 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)) 19:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:51:29 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-E7oVR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:51:30 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-JnIWBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:51:30 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)) 19:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:51:30 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-S3Y1J3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:51:30 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-uAOWXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:51:30 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-sWFR_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:51:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:32 INFO - Downloading blessings-1.6.tar.gz 19:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:51:33 INFO - Installing collected packages: blessings 19:51:33 INFO - Running setup.py install for blessings 19:51:33 INFO - Successfully installed blessings 19:51:33 INFO - Cleaning up... 19:51:33 INFO - Return code: 0 19:51:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:51:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:51:33 INFO - Reading from file tmpfile_stdout 19:51:33 INFO - Current package versions: 19:51:33 INFO - blessings == 1.6 19:51:33 INFO - blobuploader == 1.2.4 19:51:33 INFO - docopt == 0.6.1 19:51:33 INFO - functools32 == 3.2.3-2 19:51:33 INFO - jsonschema == 2.5.1 19:51:33 INFO - manifestparser == 1.1 19:51:33 INFO - mozInstall == 1.12 19:51:33 INFO - mozcrash == 0.17 19:51:33 INFO - mozdebug == 0.1 19:51:33 INFO - mozdevice == 0.48 19:51:33 INFO - mozfile == 1.2 19:51:33 INFO - mozhttpd == 0.7 19:51:33 INFO - mozinfo == 0.9 19:51:33 INFO - mozleak == 0.1 19:51:33 INFO - mozlog == 3.3 19:51:33 INFO - moznetwork == 0.27 19:51:33 INFO - mozprocess == 0.23 19:51:33 INFO - mozprofile == 0.28 19:51:33 INFO - mozrunner == 6.12 19:51:33 INFO - mozscreenshot == 0.1 19:51:33 INFO - mozsystemmonitor == 0.3 19:51:33 INFO - moztest == 0.7 19:51:33 INFO - mozversion == 1.4 19:51:33 INFO - psutil == 3.1.1 19:51:33 INFO - requests == 1.2.3 19:51:33 INFO - wsgiref == 0.1.2 19:51:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:33 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 0x1022a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102337618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd220d50da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102206d30>, '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 0x101f6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021feb20>, '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.YDXDek3S7I/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.fe1d4XUCTb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:51:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:51:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YDXDek3S7I/Render', 19:51:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:33 INFO - 'HOME': '/Users/cltbld', 19:51:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:33 INFO - 'LOGNAME': 'cltbld', 19:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:33 INFO - 'MOZ_NO_REMOTE': '1', 19:51:33 INFO - 'NO_EM_RESTART': '1', 19:51:33 INFO - 'PAGER': '/bin/cat', 19:51:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:33 INFO - 'PWD': '/builds/slave/test', 19:51:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:33 INFO - 'SHELL': '/bin/bash', 19:51:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fe1d4XUCTb/Listeners', 19:51:33 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 19:51:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:33 INFO - 'USER': 'cltbld', 19:51:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:33 INFO - 'XPC_FLAGS': '0x0', 19:51:33 INFO - 'XPC_SERVICE_NAME': '0', 19:51:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:51:33 INFO - Cleaning up... 19:51:33 INFO - Return code: 0 19:51:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1022a2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102337618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd220d50da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102206d30>, '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 0x101f6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021feb20>, '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.YDXDek3S7I/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.fe1d4XUCTb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:51:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:51:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YDXDek3S7I/Render', 19:51:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:33 INFO - 'HOME': '/Users/cltbld', 19:51:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:33 INFO - 'LOGNAME': 'cltbld', 19:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:33 INFO - 'MOZ_NO_REMOTE': '1', 19:51:33 INFO - 'NO_EM_RESTART': '1', 19:51:33 INFO - 'PAGER': '/bin/cat', 19:51:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:33 INFO - 'PWD': '/builds/slave/test', 19:51:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:33 INFO - 'SHELL': '/bin/bash', 19:51:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fe1d4XUCTb/Listeners', 19:51:33 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 19:51:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:33 INFO - 'USER': 'cltbld', 19:51:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:33 INFO - 'XPC_FLAGS': '0x0', 19:51:33 INFO - 'XPC_SERVICE_NAME': '0', 19:51:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:51:34 INFO - Cleaning up... 19:51:34 INFO - Return code: 0 19:51:34 INFO - Running post-action listener: _resource_record_post_action 19:51:34 INFO - Running post-action listener: _start_resource_monitoring 19:51:34 INFO - Starting resource monitoring. 19:51:34 INFO - [mozharness: 2016-08-30 02:51:34.135998Z] Finished create-virtualenv step (success) 19:51:34 INFO - [mozharness: 2016-08-30 02:51:34.137081Z] Running install step. 19:51:34 INFO - Running pre-action listener: _resource_record_pre_action 19:51:34 INFO - Running main action method: install 19:51:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:51:34 INFO - Reading from file tmpfile_stdout 19:51:34 INFO - Detecting whether we're running mozinstall >=1.0... 19:51:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:51:34 INFO - Reading from file tmpfile_stdout 19:51:34 INFO - Output received: 19:51:34 INFO - Usage: mozinstall [options] installer 19:51:34 INFO - Options: 19:51:34 INFO - -h, --help show this help message and exit 19:51:34 INFO - -d DEST, --destination=DEST 19:51:34 INFO - Directory to install application into. [default: 19:51:34 INFO - "/builds/slave/test"] 19:51:34 INFO - --app=APP Application being installed. [default: firefox] 19:51:34 INFO - mkdir: /builds/slave/test/build/application 19:51:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:52:08 INFO - Reading from file tmpfile_stdout 19:52:08 INFO - Output received: 19:52:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:52:08 INFO - Running post-action listener: _resource_record_post_action 19:52:08 INFO - [mozharness: 2016-08-30 02:52:08.648377Z] Finished install step (success) 19:52:08 INFO - [mozharness: 2016-08-30 02:52:08.648515Z] Running run-tests step. 19:52:08 INFO - Running pre-action listener: _resource_record_pre_action 19:52:08 INFO - Running main action method: run_tests 19:52:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:52:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:52:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:52:08 INFO - 2016-08-29 19:52:08.663 screenresolution[1640:7611] starting screenresolution argv=screenresolution get 19:52:08 INFO - 2016-08-29 19:52:08.665 screenresolution[1640:7611] Display 0: 1600x1200x32@60 19:52:08 INFO - 2016-08-29 19:52:08.672 screenresolution[1641:7613] starting screenresolution argv=screenresolution list 19:52:08 INFO - Available Modes on Display 0 19:52:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:52:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:52:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:52:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:52:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:52:08 INFO - Intel Iris: 19:52:08 INFO - Chipset Model: Intel Iris 19:52:08 INFO - Type: GPU 19:52:08 INFO - Bus: Built-In 19:52:08 INFO - VRAM (Dynamic, Max): 1536 MB 19:52:08 INFO - Vendor: Intel (0x8086) 19:52:08 INFO - Device ID: 0x0a2e 19:52:08 INFO - Revision ID: 0x0009 19:52:08 INFO - Displays: 19:52:08 INFO - Display: 19:52:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:52:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:52:08 INFO - Display Serial Number: 1600x1200 60 19:52:08 INFO - Main Display: Yes 19:52:08 INFO - Mirror: Off 19:52:08 INFO - Online: Yes 19:52:08 INFO - Rotation: Supported 19:52:08 INFO - Return code: 0 19:52:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:52:08 INFO - Python 2.7.3 19:52:08 INFO - Return code: 0 19:52:08 INFO - grabbing minidump binary from tooltool 19:52:08 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')]} 19:52:08 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 0x102206d30>, '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 0x101f6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021feb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:52:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:52:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 19:52:08 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:52:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:52:09 INFO - Return code: 0 19:52:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:52:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:52:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:52:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:52:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:52:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IA-Kx_oxROWwVIkFZkMP6g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0300', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:52:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IA-Kx_oxROWwVIkFZkMP6g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0300 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:52:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YDXDek3S7I/Render', 19:52:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:52:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:52:09 INFO - 'HOME': '/Users/cltbld', 19:52:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:52:09 INFO - 'LOGNAME': 'cltbld', 19:52:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:52:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:09 INFO - 'MOZ_NO_REMOTE': '1', 19:52:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:52:09 INFO - 'NO_EM_RESTART': '1', 19:52:09 INFO - 'PAGER': '/bin/cat', 19:52:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:52:09 INFO - 'PWD': '/builds/slave/test', 19:52:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:52:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:52:09 INFO - 'SHELL': '/bin/bash', 19:52:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fe1d4XUCTb/Listeners', 19:52:09 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 19:52:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:52:09 INFO - 'USER': 'cltbld', 19:52:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:52:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:09 INFO - 'XPC_FLAGS': '0x0', 19:52:09 INFO - 'XPC_SERVICE_NAME': '0', 19:52:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:52:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IA-Kx_oxROWwVIkFZkMP6g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0300', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:52:09 INFO - mozversion application_buildid: 20160829173530 19:52:09 INFO - mozversion application_changeset: 7293879d87d780790cb0f67e98226b7d4de6d4e1 19:52:09 INFO - mozversion application_display_name: Nightly 19:52:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:52:09 INFO - mozversion application_name: Firefox 19:52:09 INFO - mozversion application_remotingname: firefox 19:52:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:52:09 INFO - mozversion application_vendor: Mozilla 19:52:09 INFO - mozversion application_version: 51.0a1 19:52:09 INFO - mozversion platform_buildid: 20160829173530 19:52:09 INFO - mozversion platform_changeset: 7293879d87d780790cb0f67e98226b7d4de6d4e1 19:52:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:52:09 INFO - mozversion platform_version: 51.0a1 19:52:09 INFO - using testdate: 1472525529 19:52:09 INFO - actual date: 1472525529 19:52:09 INFO - starting webserver on 'localhost:49277' 19:52:09 INFO - SUITE-START | Running 2 tests 19:52:09 INFO - TEST-START | dromaeo_css 19:52:09 INFO - operating with platform_type : mac_ 19:52:09 INFO - Initialising browser for dromaeo_css test... 19:52:09 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmpsU7ZeW/profile http://localhost:49277/getInfo.html) 19:52:12 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 19:52:12 INFO - PROCESS | 1651 | colorDepth:24 19:52:12 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 19:52:12 INFO - PROCESS | 1651 | __metrics 19:52:12 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 19:52:13 INFO - TEST-INFO | 1651: exit 0 19:52:13 INFO - Browser initialized. 19:52:13 INFO - Running cycle 1/1 for dromaeo_css test... 19:52:13 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmpsU7ZeW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:52:25 INFO - PROCESS | 1654 | RSS: Main: 244154368 19:52:25 INFO - PROCESS | 1654 | 19:53:14 INFO - PROCESS | 1654 | 1472525594822 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:55:26 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 19:55:28 INFO - PROCESS | 1654 | RSS: Main: 267255808 19:55:28 INFO - PROCESS | 1654 | 19:58:30 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 19:58:31 INFO - PROCESS | 1654 | RSS: Main: 277405696 19:58:31 INFO - PROCESS | 1654 | 20:01:33 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 20:01:33 INFO - PROCESS | 1654 | RSS: Main: 277704704 20:01:33 INFO - PROCESS | 1654 | 20:04:35 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 20:04:36 INFO - PROCESS | 1654 | RSS: Main: 273145856 20:04:36 INFO - PROCESS | 1654 | 20:07:39 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 20:07:39 INFO - PROCESS | 1654 | RSS: Main: 279457792 20:07:39 INFO - PROCESS | 1654 | 20:10:42 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 20:10:42 INFO - PROCESS | 1654 | RSS: Main: 282046464 20:10:42 INFO - PROCESS | 1654 | 20:10:42 INFO - PROCESS | 1654 | __start_tp_report 20:10:42 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 20:10:42 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 20:10:42 INFO - PROCESS | 1654 | |i|pagename|runs| 20:10:42 INFO - PROCESS | 1654 | |0;dojo.html;2840.559713244447;3340.6158291796437;3343.648916863731;3389.644087370826;3396.184915620252;4497.168023915574;4520.954790452094;5471.5896307776875;5529.364123125837;5599.300087489064;5547.1679248112805;5608.859778505539;5615.466530679589;5627.577931655132;5647.237622920915;5054.84835454936;5112.872178195537;5148.948510514903;5197.766100525467;5310.575153987672;5177;5204.453532379102;5215.504527069941;5254.264402983586;5274.235235890813;4980.352554167953;5022.271770593262;5106.131957567185;5130.9743451282875;5171.50870667286;5052.621053420971;5077.64456488046;5080.720560369178;5133.486651334874;5141.614378921596;5125.487451254882;5143;5144.948550514484;5181.740912954338;5310.840674779763;5476.2333273341765;5539.667619942776;5581.832545023656;5600.355959064678;5612.915806262909;6038.064100064497;6103.450689437927;6113.602615829956;6151.72317245725;6161.322254551996;5986.880262394728;6188.4739797116845;6216.87566248677;6229.0967809667345;6249.125122482856;5652.773889044433;5677.659340439545;5710.200571919934;5722.17028530869;5801.274840644919;6258.278973282293;6286.182796236551;6300.558960872787;6312.400321969406;6324.525660575475;5788.016037273674;6044.486218671374;6089.847753806191;6096.542759292982;6106.084087386927;5955.28536575605;6035.637861728311;6074.271087469444;6104.267487901391;6128.019516877278;5993.190919225936;5994.790182343684;6016.639001659914;6024.277086749618;6030.638161710312;5894.6757928314355;5992.610480318765;6027.126066720389;6040.456358927718;6065.696715164224;4821.349117869043;4886.511348865085;4892.363992680928;4894.3147959285725;4903.583195428429;3686.5207523022373;3696.537932758405;4351.608355248043;4382.715123516961;4451.910961780746;5109.821156259513;5595.552355811526;5616.803411880564;5687.857803554944;5693.174489699053;6200.472959798378;6200.844978875474;6215.906761398583;6224.346443623354;6238.282597501346;4820.758962051884;5045.344105266366;5633.549316054706;5650.26546548946;5651.378348381675;4533.52397998212;5310.070737620901;5362.570994320445;5373.704446255493;5448.591355648342;5448.618596698272;6086.965215913306;6278.15244941927;6298.8425289367215;6302.968485157637;4990.650654454299;6007.759689612367;6190.288116866618;6230.657313847782;6236.844078898064;6190.628562286277;6287.905681414874;6293.181886354928;6302.401271879165;6333.334999824952;6095.817125486243;6117.480014198843;6122.785702500391;6124.326324104256;6133.969330153321;5935.317438494629;5955.255593050869;6180.6600636965395;6202.596831206138;6222.564420490703;5896.8820623586425;5978.611390259619;5983.611065280743;6049.153118563317;6051.878962420815;5909.970450147894;5975.103734439869;5977.073553599199;5991.221141251609;5999.370066142992;5645.774169033192;5690.402507736628;5707.629004114885;5774.0761478163295;5815.04051831443;5053.216751403538;6011;6018.037114061729;6066.514678825772;6075.2405949256345;5828.883422331445;5834.766609335579;5851.1223316502865;5857.4435428634215;5859.355470898283 20:10:42 INFO - PROCESS | 1654 | |1;ext.html;484.84000279907633;506.2608591456474;532.760257883952;533.6397931396307;566.3062748133536;37852.62147378526;38572.421413678814;40073.799631001806;40097.198056038935;40107.59892401079;40467.59532404675;40500.59499405005;41078;41114;41406.37890431646;9703;9973.301868869183;9982.900170998306;9989;10001.449920254383;8250.793730156734;9758;9835.754106147331;9861.802763944717;9875.802483950316;9779;9862.013798620152;9867.703968880909;9871.555779989882;9882.9505852471;9808.411495310304;9867.210623150131;9878.654247101389;9885.406875587487;9897.851532226987;9510.809783804354;9769.169620582259;9843.753906152331;9861.90138098617;9870.309078364517;40458.595414045776;40596.98507537306;40712.982175445555;40762.38856417156;40791.59208407908;3241.692039256267;3371.6291207967106;3412.4710669845967;3452.3613131570487;4055.776932268724;30704.078877633707;30954.91657791989;31474.37051258985;31542.842285788425;31619.84190079035;3180.2685382361956;3351.245969656832;3369.427197376452;3408.403529382373;3412.129906873756;509527;516699.4165029151;517454;517528;518974;59020.40979590235;59106.931257405784;59283.703581481815;59426.40573594295;59721;61560.692196539625;61762.69118654468;61896.38103618996;62444;62557.374426255155;15410.229488525529;15768.526944191693;15800.60498487547;15917.965332253367;15994.68010639804;12344.259344439362;12435.253884766942;12536.247825130522;12560.748785024249;12565.18326308787;15897.489738474826;16524.421645242357;16580.668386632442;16606.833931660527;16630.002199868046;6742.39318461331;6806.659667016629;6821.1814582250445;6874.759383421556;6906.205786334535;847.3348421489102;957.5882370580717;970.369259981018;983.5082458770614;1021.7292417509366;32335.838320808245;33268.833655831564;33336.66653333888;33860.49209261863;34058.82970585181;926.7072433954596;947.8341290274175;953.6519170502855;996.5764550066193;1094.3215206571817;14018;14924.62688432798;15173;16754.4135955241;16825.906316089415;675561;692192;693372;693475.7935892896;695130;53518.73240633772;58126.709366452895;58716.412835871095;58823;59121;1035.8239099353127;1147.6384938744436;1380.4616199681932;1407.233057983381;1410.4569740649924;29585.964491242703;30773.692263077082;31774;31821.681783181873;31902.490726020584;50842.49157508525;51140.74429627828;51433.7428312871;51580.71048223674;51723.482765171866;486022;563513;568104.1594792164;568633.920759905;568889;34637;35261.47107793334;42844.35733463938;43633;44195.33706994462;46954;47523.76238118787;48212.517874820805;48483.5151648479;48647.75676121597;39477.40783888187;39535.40696889492;39613.40579891361;40631;40926.59073409228;34677.47983780296;38848.2230355397;39615.40576891291;39664;40659.98350041272;25766.613500797877;37663.2467350646;38963.220735585695;39358;40171;33368.49947250842;33611.99164024986;34603.65396346004;35029.12427189239;35042.824785875906;21265.6810147851;23549.940252688328;23791.405214869766;25945;25986.35034124162 20:10:42 INFO - PROCESS | 1654 | |2;jquery.html;323.8406504713127;340.8057407277851;364.2387410312447;371.3946267583838;389.8538048231913;20323.695144572845;20391.898040509794;21292;21510.354689359305;21588.460288492795;20408.489787755276;20629.587408251828;20995.895020524913;21036.78963210371;21349.679754803652;5892.793752218673;6008.57939944203;6092.756289748405;6217.937820621803;6250.624962502265;6062.939370606282;6152.753889844424;6163.1063495793305;6165.938340616603;6170.691465426733;5230.843074707765;5799.942000580004;6085.726142323584;6128.142060111588;6138.17134686816;5403.378611459654;6059.787907423263;6089.0866370044405;6103.42017508336;6157.076438534211;5894.941050589482;5997.280326360821;6037.396260373971;6042.758289668408;6053.424924632153;10794.892051079467;10832.783344333147;12906.612801615967;13198.538051168163;13219.669508262274;2030.5532782787764;2198.9439873718125;2459.667944827443;2730.24918147509;3014.7588192944513;9541.761455963588;10017.599296028151;10152.644657437027;10154.39073655583;10336.17310615149;1592.4585640882156;1853.7868145163343;1895.6113996630659;1905.1236431241646;1932.1112288347238;84556;114323.85676143215;116180;117720.40516353569;119774.4011279938;11282.548698051985;11314.886851131549;11438.94280528592;11456.427178641035;11839.467223974942;14082.85917140836;14190.858091418953;14211.573652790434;14218.431262749375;14240.145591264558;7018.263082376379;8349.123342049119;8443.408961372768;8478.618462169217;8519.531425771642;6899.379055884994;8436.40945133847;8468.491890486468;8558.828823423497;8587.270082043096;3650.251698401821;4348.9997300621035;4379.299312110047;4499.865004049884;4506.504284528699;1890.3100368365447;1920.3278852401827;1938.195648805758;1944.7569053868267;1958.079702539804;696.5194016128956;785.1677222144546;813.8331642013374;816.2205094135087;855.9186877246651;20171.495712607302;20413;21304.721716697048;21783.455413614785;21846.672299915514;878.060475291432;943.8348289049526;964.5225613321451;992.6575331510618;995.9850602240972;7659.119201291811;11353.091752659768;11357.943210283896;11366;11372.31766094037;610250;613395;613827;631021.8448907726;634387;59554;109166.81666366628;120158.39920800341;134371.65628343786;137783;907.8502047162144;1012.6354512375539;1024.626011505795;1065.9786804263872;1070.9143268538498;15285.388584456497;16746.916265418597;18931.810681893556;18976.810231897503;19235.230590776213;42651.36022959596;55769.721151393984;58217.12674309973;58448.70775646094;58656.653733851876;80507.59746201232;81419;81468.59265703634;83266.58366708127;88998;5792.420757924342;7686.346660533917;7694.88390692564;7859.84280314402;7866.213378662088;9351.85972210431;10994.230403871652;12147.139427036682;12473.625791226277;12554.748905021666;9477.526123693926;9938.503074846085;10299.845502317321;10671.306365086244;10876.673699789018;9995.850062248926;10606.522706478072;10620.84068738954;10989.340639561651;11083.944580277048;9075.273978081606;9361.4383137012;9430.434173949585;10752.193585480964;11031.669049928514;6813.931860681329;7533.698652054076;7803.804904877424;7848.489848159851;8082.515049097073;9143.542822858963;10705.678829635124;10808.621698240524;10855.805861355087;10929.453527323443 20:10:42 INFO - PROCESS | 1654 | |3;mootools.html;1411.6707432735986;1450.2821103553742;1512.5764785859956;1795.973060404095;1834.0829585207396;7937.642806073726;8407.453515521487;8427.578621068953;8997.05530919254;9018.594163262653;7265.818354541126;8844.734657960256;8844.77888052799;8846.20384165425;8862.512561809099;2341.309313752447;2379.7501262367464;2386.809055275574;2387.176424133671;2388.1163969331374;2027.9493012674727;2340.8829558522007;2390.725066617344;2393.7725916038034;2396.712394512661;2362.8227882908764;2369.5853225685437;2383.833131680783;2385.189035727852;2394.5330660521204;2309.445733024079;2327.2087490253225;2330.4057465346395;2342.2856028911174;2343.8124950003958;2315.270689732729;2358.516504116652;2360.3980984848927;2364.7398786133513;2366.0654041653625;8874.334424918157;8887.955560222223;8904.821903561957;8920.330975176888;8945.821083578292;5116.616253780944;5179.326687530597;5301.734913254322;5313.176457649032;5332.2801421808335;3417.470292104728;3544.379733546619;3620.0406892173596;3623.2572322673786;3624.2751449710163;1042.4318746283293;1068.209524951538;1084.7179733269327;1091.939943303118;1100.884407137247;11555.306681599131;11583.247088939192;11668.649940501798;11679.591214307544;11690.824637630443;4585.977070114628;4626.629869610423;4794.328793968847;4813.350197723333;4833.709977401367;7772.862462822656;8115.83768324642;8634;9318.394304370195;10502.894971050191;5316.069687804618;5330.253764472977;5334.759935802898;5341.545968592635;5349.973250133725;4196.740977706676;4429.357743127229;4821.180399332122;4915.139850526144;4945.826896058621;3901.8244179012013;3926.7447615904875;4024.577419370924;4026.3960405939342;4082.1223436961195;1274.8470183577845;1281.4686449692715;1287.0990306785288;1293.321006471591;1297.2411139483509;756.3759898084103;872.2542226396466;917.7797328641211;922.9953850230706;930.9115634014757;4923.507649235048;5930.1994230779155;5938.346781853993;6000.699965001732;6125.785597504066;410.07528024305594;418.6734347209182;435.6993674364678;437.13011107895693;445.7013800753438;3547.8935631931085;3916.412538119248;4063.6139566741113;4163.791810409467;4167.187398457272;9041.18629323364;10446;10676.359418434919;10831.67504974852;10833.512491937881;10632.202584806171;10643.627473038561;10658.307210031324;10726.356418614752;10818.350898946088;8135.959320203361;8232.547209903512;8333.125021872616;8380.706675266336;8387.62255698495;5060.569851562658;5831.8833623326445;5946.821595352147;6021.849453763691;6085.4523092921845;9033.728988130366;9615.086566776145;9987.151092156957;10052.94973525157;10084.042016008467;9985.201183905416;10149.949250253701;10162.79674406493;10319.174466042548;10382.42896640692;6882.4149947253045;7288.672009759467;7371.3734332582335;7508.474406791691;7523.811904702427;8462.619182136941;8538.402311838112;8541.377138343694;8560.614772335384;8578.485290882567;7347;7446;7474.177840437656;7514.661840217094;7571.167171611229;7243.275672432715;7296.854062918605;7320.450966177665;7429.59137247435;7455.515391499535;6754.797356079325;6912.55068420551;6996.300369962963;7060.046893669494;7082.822929426806;4873.171560834738;4983.725895075806;4990.460588746561;5144.0997825381155;5144.30551875492;4976.776045077908;5004.2493625956395;5134.255532947776;5149.845504634867;5154 20:10:42 INFO - PROCESS | 1654 | |4;prototype.html;264.6387680815687;292.564079521513;303.1239717217243;307.75687207106387;308.4155525279594;5080.364954380702;5086.567641750456;5333.493258168664;5355.410904800468;5468.261784659075;4712.963148107419;5359.08895487767;5364.436734142917;5372.892542149164;5397.62216644835;3640.8179591020476;3671.898430470848;3699.186179040607;4052.169305292408;4104.610062044101;3604.5849280981806;3968.920621587581;4012.598740125993;4120.402541631462;4228.5982831630945;3644.1800594866077;4023.295923213426;4062.5531191569053;4082.2856000199995;4083.692713616812;3003.414334204831;3711.294853977736;4125.216208920296;4128.195001974616;4129.245070844909;2948.4103179364215;3564.625714300013;3582.8566857325936;3590.7252925211433;3592.4252119660728;4508.887277818081;4700.897407710894;4869.537393947605;5220.59044058106;5261.842144735664;4631.444226692818;4640.09518143962;4671.392718946515;4691.15559199344;4716.693414928019;4624.745638989854;4783.928241076386;4900.142475066849;5169.560587350042;5649.915251271234;3227.4019414371423;3469.080693616194;3722.8696995605023;3908.5895980922164;3909.8465952543784;5934.554908381889;5937.228160339128;5948.940510594882;5999.73001214942;6026.758929642809;3078.3535457553717;3860.803151023136;3890.793853905242;3977.204559088194;4007.318755811519;2894.6526416830116;3203.103131123289;3495.570578447954;4017.7187596868525;4054.8986275342763;3765.4540091686554;3776.6789822864816;4549.044700612908;4567.406237189144;4580.236608905595;5722.7424765885635;5738.905299565628;5756.222909907193;5763.711814409263;5789.8552536186935;1254.7553227120625;1293.95471158509;1309.7315050414643;1329.4482789642384;1331.620488160889;747.2154238050134;789.5499565247868;864.2740098317317;870.7126648206076;884.8805411269396;3942.9299617700362;4786.7845946932475;5028.396592408934;5208.114620514521;5247.422783493813;4899.608031357483;5541.2796336476;5743.310802703702;5756.539476841926;5814.651120932757;4180.28935081037;4537.977310113428;5080.933004069113;5181.6631918925905;5227.451117632594;2528.9504855485134;2537.8604176770455;2761.6685997680006;2936.9706302937125;3042.680518545521;4639.768011599474;5282.709450980156;5781.364049954502;6106.717589306296;6156.569040167235;5142.845714628567;5536.944630553723;5913.408659134052;5980.491658209014;5992.471919660458;5592.440755924375;6046.969765151146;6051.606645568024;6096.207493025879;6124.295705993868;5285.7621407036;5492.725363731877;5561.499465048165;5895.380984996686;5900.232969714081;4905.798079470553;5126.74366281677;5314.97342513285;5439.748857762657;5736;5895.174675545341;6026.896148483447;6051.909221361771;6053.636781793107;6130.601510901777;3828.7511311764647;3923.6468717815533;3989.3417586097967;3994.6005399459823;4008.0180355813013;4794.832180873653;5532.3637781655625;5553.916691249715;5766.913496297475;5779.422057794187;5381;5503.9174412383045;5675.829725108253;5709.3719690834805;5711.8000869969355;4731.9589690268085;5669.78878237496;5670.518005969374;5672.290963629546;5675.517581005661;5245;5300.9734951325;5534.39121696605;5548.889022219452;5586.581006424453;5649.54803615718;5715.085586306171;5734.741936612779;5735.283089613798;5737.799177028784;5320.07176231694;5534.52956498686;5587.189857470726;5602.887942241214;5637.492625663546 20:10:42 INFO - PROCESS | 1654 | |5;yui.html;597.1460811040213;764.5450956680774;778.4978688745756;783.2559068884561;794.0907660728466;14873.330700118493;15665.530034098982;16034.75947860783;16059;16865.578360540992;14416.783748243784;16161.46466085723;16426.17869106546;16658.750118748227;16689.83310166901;719.791260534447;844.5734903873536;867.0592407238123;872.3806097670662;872.8210716803072;668.9030090636879;697.6965020216197;842.0358689300747;865.9523726195057;875.4090988582712;911.8723378726984;917.1974522292994;919.2691810011057;919.8482250428672;920.5535315372039;879.8680197970324;905.968291109808;911.8586619073988;913.2237598041678;913.5797533134732;665.078865770906;673.050998092687;673.1719984419143;674.8987651852212;675.8580698053365;15331.846681533265;15382.307796149089;15389.153596552185;15402.845971540253;15417.537473875802;13999.230042347666;14102.365393557315;14159.999999999896;14165.504207352693;14282.07166534172;9829.560466403169;11831.112666550043;11945.820812687816;12024.639260822189;12059.638210853689;3713.6472035156617;3742.3076730804614;3760.8871733848027;3793.506844110276;3823.6941044716355;84205;85234.57382713047;113007;117917;120847.39576302063;10661.466926653637;10669.83995240072;10753.623623173151;10769.623063192907;11087.889121108685;18886.150123244486;21483.603565768175;21891.67162492564;22172;22199.66700499494;7806.648700808477;7890.684372625145;7932.04815422153;7974.800629984181;8005.439619226715;4450.109978004412;4487.528809475023;4543.931841022388;4547.386102876069;4658.58072773452;3478.9478157827652;3551.94672079919;3574.98212508941;3582.0865679252147;3717.237966216919;648.2545073165898;681.9872489353306;689.5483458334799;693.5318659904544;709.1879797631786;550.6916126968911;552.701541167765;587.759018802289;646.9870602587922;663.4195079305607;9131.680391186277;9213.35506514551;9396.544892622334;9472.289578281656;9641.614335426644;587.5182350472571;626.2516293029786;644.4715333426545;650.7006776882592;651.4397618048474;4451.844185453494;4475.955240447619;4509.977450112794;4641.234196357564;4753.928691069636;106616;129317;148740.40744906888;165132;171681.99113030985;90957.54521227352;104834;137176.31411842877;144541;146557;119747;120241;121355.39322303332;123819;124604.40862526787;8623.008354039366;8735.825283494421;8892.466452012899;8950.731478055668;9080.364374493722;50711.49288507068;54942;67036;67463.62681865985;67947.3205267941;93384;101089.49455252677;101507;102377.97622023983;106221;10045.33798543372;11632.199044284336;11789.528418863492;11870.465829037887;11999.700007499883;12169.20900141488;12570.49718011306;12759;13304.534341298007;13911.234882081582;12230;12248.265104093784;12288.815667764811;12594.748105038032;12732.108752387245;11977.940110299742;12117.212381195193;12137.757244855231;12287.646461393573;12388.380580971096;11866.347350895783;11915;12091.274523528617;12179.147459678092;12397.75204495923;9992.800143997225;10332.690019299433;10429.68710938673;10449.738756530844;10504.737381565523;10420.32267902584;10462.267641265038;10636.14910807118;10782.67651970442;10826.89173108259 20:10:42 INFO - PROCESS | 1654 | __end_tp_report 20:10:42 INFO - PROCESS | 1654 | __start_cc_report 20:10:42 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,389 20:10:42 INFO - PROCESS | 1654 | __end_cc_report 20:10:42 INFO - PROCESS | 1654 | __startTimestamp1472526642638__endTimestamp 20:10:42 INFO - PROCESS | 1654 | 20:10:42 INFO - PROCESS | 1654 | ------- Summary: start ------- 20:10:42 INFO - PROCESS | 1654 | Number of tests: 6 20:10:42 INFO - PROCESS | 1654 | 20:10:42 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5603.51 Median:5801.27 stddev:673.99 (11.6%) stddev-sans-first:640.26 20:10:42 INFO - PROCESS | 1654 | Values: 2840.6 3340.6 3343.6 3389.6 3396.2 4497.2 4521.0 5471.6 5529.4 5599.3 5547.2 5608.9 5615.5 5627.6 5647.2 5054.8 5112.9 5148.9 5197.8 5310.6 5177.0 5204.5 5215.5 5254.3 5274.2 4980.4 5022.3 5106.1 5131.0 5171.5 5052.6 5077.6 5080.7 5133.5 5141.6 5125.5 5143.0 5144.9 5181.7 5310.8 5476.2 5539.7 5581.8 5600.4 5612.9 6038.1 6103.5 6113.6 6151.7 6161.3 5986.9 6188.5 6216.9 6229.1 6249.1 5652.8 5677.7 5710.2 5722.2 5801.3 6258.3 6286.2 6300.6 6312.4 6324.5 5788.0 6044.5 6089.8 6096.5 6106.1 5955.3 6035.6 6074.3 6104.3 6128.0 5993.2 5994.8 6016.6 6024.3 6030.6 5894.7 5992.6 6027.1 6040.5 6065.7 4821.3 4886.5 4892.4 4894.3 4903.6 3686.5 3696.5 4351.6 4382.7 4451.9 5109.8 5595.6 5616.8 5687.9 5693.2 6200.5 6200.8 6215.9 6224.3 6238.3 4820.8 5045.3 5633.5 5650.3 5651.4 4533.5 5310.1 5362.6 5373.7 5448.6 5448.6 6087.0 6278.2 6298.8 6303.0 4990.7 6007.8 6190.3 6230.7 6236.8 6190.6 6287.9 6293.2 6302.4 6333.3 6095.8 6117.5 6122.8 6124.3 6134.0 5935.3 5955.3 6180.7 6202.6 6222.6 5896.9 5978.6 5983.6 6049.2 6051.9 5910.0 5975.1 5977.1 5991.2 5999.4 5645.8 5690.4 5707.6 5774.1 5815.0 5053.2 6011.0 6018.0 6066.5 6075.2 5828.9 5834.8 5851.1 5857.4 5859.4 20:10:42 INFO - PROCESS | 1654 | 20:10:42 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:72009.54 Median:40859.09 stddev:157963.72 (386.6%) stddev-sans-first:158315.57 20:10:42 INFO - PROCESS | 1654 | Values: 484.8 506.3 532.8 533.6 566.3 37852.6 38572.4 40073.8 40097.2 40107.6 40467.6 40500.6 41078.0 41114.0 41406.4 9703.0 9973.3 9982.9 9989.0 10001.4 8250.8 9758.0 9835.8 9861.8 9875.8 9779.0 9862.0 9867.7 9871.6 9883.0 9808.4 9867.2 9878.7 9885.4 9897.9 9510.8 9769.2 9843.8 9861.9 9870.3 40458.6 40597.0 40713.0 40762.4 40791.6 3241.7 3371.6 3412.5 3452.4 4055.8 30704.1 30954.9 31474.4 31542.8 31619.8 3180.3 3351.2 3369.4 3408.4 3412.1 509527.0 516699.4 517454.0 517528.0 518974.0 59020.4 59106.9 59283.7 59426.4 59721.0 61560.7 61762.7 61896.4 62444.0 62557.4 15410.2 15768.5 15800.6 15918.0 15994.7 12344.3 12435.3 12536.2 12560.7 12565.2 15897.5 16524.4 16580.7 16606.8 16630.0 6742.4 6806.7 6821.2 6874.8 6906.2 847.3 957.6 970.4 983.5 1021.7 32335.8 33268.8 33336.7 33860.5 34058.8 926.7 947.8 953.7 996.6 1094.3 14018.0 14924.6 15173.0 16754.4 16825.9 675561.0 692192.0 693372.0 693475.8 695130.0 53518.7 58126.7 58716.4 58823.0 59121.0 1035.8 1147.6 1380.5 1407.2 1410.5 29586.0 30773.7 31774.0 31821.7 31902.5 50842.5 51140.7 51433.7 51580.7 51723.5 486022.0 563513.0 568104.2 568633.9 568889.0 34637.0 35261.5 42844.4 43633.0 44195.3 46954.0 47523.8 48212.5 48483.5 48647.8 39477.4 39535.4 39613.4 40631.0 40926.6 34677.5 38848.2 39615.4 39664.0 40660.0 25766.6 37663.2 38963.2 39358.0 40171.0 33368.5 33612.0 34603.7 35029.1 35042.8 21265.7 23549.9 23791.4 25945.0 25986.4 20:10:42 INFO - PROCESS | 1654 | 20:10:42 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:34678.98 Median:2010.82 stddev:103164.80 (5130.5%) stddev-sans-first:103421.95 20:10:42 INFO - PROCESS | 1654 | Values: 323.8 340.8 364.2 371.4 389.9 20323.7 20391.9 21292.0 21510.4 21588.5 20408.5 20629.6 20995.9 21036.8 21349.7 5892.8 6008.6 6092.8 6217.9 6250.6 6062.9 6152.8 6163.1 6165.9 6170.7 5230.8 5799.9 6085.7 6128.1 6138.2 5403.4 6059.8 6089.1 6103.4 6157.1 5894.9 5997.3 6037.4 6042.8 6053.4 10794.9 10832.8 12906.6 13198.5 13219.7 2030.6 2198.9 2459.7 2730.2 3014.8 9541.8 10017.6 10152.6 10154.4 10336.2 1592.5 1853.8 1895.6 1905.1 1932.1 84556.0 114323.9 116180.0 117720.4 119774.4 11282.5 11314.9 11438.9 11456.4 11839.5 14082.9 14190.9 14211.6 14218.4 14240.1 7018.3 8349.1 8443.4 8478.6 8519.5 6899.4 8436.4 8468.5 8558.8 8587.3 3650.3 4349.0 4379.3 4499.9 4506.5 1890.3 1920.3 1938.2 1944.8 1958.1 696.5 785.2 813.8 816.2 855.9 20171.5 20413.0 21304.7 21783.5 21846.7 878.1 943.8 964.5 992.7 996.0 7659.1 11353.1 11357.9 11366.0 11372.3 610250.0 613395.0 613827.0 631021.8 634387.0 59554.0 109166.8 120158.4 134371.7 137783.0 907.9 1012.6 1024.6 1066.0 1070.9 15285.4 16746.9 18931.8 18976.8 19235.2 42651.4 55769.7 58217.1 58448.7 58656.7 80507.6 81419.0 81468.6 83266.6 88998.0 5792.4 7686.3 7694.9 7859.8 7866.2 9351.9 10994.2 12147.1 12473.6 12554.7 9477.5 9938.5 10299.8 10671.3 10876.7 9995.9 10606.5 10620.8 10989.3 11083.9 9075.3 9361.4 9430.4 10752.2 11031.7 6813.9 7533.7 7803.8 7848.5 8082.5 9143.5 10705.7 10808.6 10855.8 10929.5 20:10:42 INFO - PROCESS | 1654 | 20:10:42 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5657.16 Median:4919.32 stddev:3176.27 (64.6%) stddev-sans-first:3169.15 20:10:42 INFO - PROCESS | 1654 | Values: 1411.7 1450.3 1512.6 1796.0 1834.1 7937.6 8407.5 8427.6 8997.1 9018.6 7265.8 8844.7 8844.8 8846.2 8862.5 2341.3 2379.8 2386.8 2387.2 2388.1 2027.9 2340.9 2390.7 2393.8 2396.7 2362.8 2369.6 2383.8 2385.2 2394.5 2309.4 2327.2 2330.4 2342.3 2343.8 2315.3 2358.5 2360.4 2364.7 2366.1 8874.3 8888.0 8904.8 8920.3 8945.8 5116.6 5179.3 5301.7 5313.2 5332.3 3417.5 3544.4 3620.0 3623.3 3624.3 1042.4 1068.2 1084.7 1091.9 1100.9 11555.3 11583.2 11668.6 11679.6 11690.8 4586.0 4626.6 4794.3 4813.4 4833.7 7772.9 8115.8 8634.0 9318.4 10502.9 5316.1 5330.3 5334.8 5341.5 5350.0 4196.7 4429.4 4821.2 4915.1 4945.8 3901.8 3926.7 4024.6 4026.4 4082.1 1274.8 1281.5 1287.1 1293.3 1297.2 756.4 872.3 917.8 923.0 930.9 4923.5 5930.2 5938.3 6000.7 6125.8 410.1 418.7 435.7 437.1 445.7 3547.9 3916.4 4063.6 4163.8 4167.2 9041.2 10446.0 10676.4 10831.7 10833.5 10632.2 10643.6 10658.3 10726.4 10818.4 8136.0 8232.5 8333.1 8380.7 8387.6 5060.6 5831.9 5946.8 6021.8 6085.5 9033.7 9615.1 9987.2 10052.9 10084.0 9985.2 10149.9 10162.8 10319.2 10382.4 6882.4 7288.7 7371.4 7508.5 7523.8 8462.6 8538.4 8541.4 8560.6 8578.5 7347.0 7446.0 7474.2 7514.7 7571.2 7243.3 7296.9 7320.5 7429.6 7455.5 6754.8 6912.6 6996.3 7060.0 7082.8 4873.2 4983.7 4990.5 5144.1 5144.3 4976.8 5004.2 5134.3 5149.8 5154.0 20:10:42 INFO - PROCESS | 1654 | 20:10:42 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4527.60 Median:5134.79 stddev:1443.28 (28.1%) stddev-sans-first:1411.41 20:10:42 INFO - PROCESS | 1654 | Values: 264.6 292.6 303.1 307.8 308.4 5080.4 5086.6 5333.5 5355.4 5468.3 4713.0 5359.1 5364.4 5372.9 5397.6 3640.8 3671.9 3699.2 4052.2 4104.6 3604.6 3968.9 4012.6 4120.4 4228.6 3644.2 4023.3 4062.6 4082.3 4083.7 3003.4 3711.3 4125.2 4128.2 4129.2 2948.4 3564.6 3582.9 3590.7 3592.4 4508.9 4700.9 4869.5 5220.6 5261.8 4631.4 4640.1 4671.4 4691.2 4716.7 4624.7 4783.9 4900.1 5169.6 5649.9 3227.4 3469.1 3722.9 3908.6 3909.8 5934.6 5937.2 5948.9 5999.7 6026.8 3078.4 3860.8 3890.8 3977.2 4007.3 2894.7 3203.1 3495.6 4017.7 4054.9 3765.5 3776.7 4549.0 4567.4 4580.2 5722.7 5738.9 5756.2 5763.7 5789.9 1254.8 1294.0 1309.7 1329.4 1331.6 747.2 789.5 864.3 870.7 884.9 3942.9 4786.8 5028.4 5208.1 5247.4 4899.6 5541.3 5743.3 5756.5 5814.7 4180.3 4538.0 5080.9 5181.7 5227.5 2529.0 2537.9 2761.7 2937.0 3042.7 4639.8 5282.7 5781.4 6106.7 6156.6 5142.8 5536.9 5913.4 5980.5 5992.5 5592.4 6047.0 6051.6 6096.2 6124.3 5285.8 5492.7 5561.5 5895.4 5900.2 4905.8 5126.7 5315.0 5439.7 5736.0 5895.2 6026.9 6051.9 6053.6 6130.6 3828.8 3923.6 3989.3 3994.6 4008.0 4794.8 5532.4 5553.9 5766.9 5779.4 5381.0 5503.9 5675.8 5709.4 5711.8 4732.0 5669.8 5670.5 5672.3 5675.5 5245.0 5301.0 5534.4 5548.9 5586.6 5649.5 5715.1 5734.7 5735.3 5737.8 5320.1 5534.5 5587.2 5602.9 5637.5 20:10:42 INFO - PROCESS | 1654 | 20:10:42 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:24845.64 Median:3563.46 stddev:40334.15 (1131.9%) stddev-sans-first:40406.21 20:10:42 INFO - PROCESS | 1654 | Values: 597.1 764.5 778.5 783.3 794.1 14873.3 15665.5 16034.8 16059.0 16865.6 14416.8 16161.5 16426.2 16658.8 16689.8 719.8 844.6 867.1 872.4 872.8 668.9 697.7 842.0 866.0 875.4 911.9 917.2 919.3 919.8 920.6 879.9 906.0 911.9 913.2 913.6 665.1 673.1 673.2 674.9 675.9 15331.8 15382.3 15389.2 15402.8 15417.5 13999.2 14102.4 14160.0 14165.5 14282.1 9829.6 11831.1 11945.8 12024.6 12059.6 3713.6 3742.3 3760.9 3793.5 3823.7 84205.0 85234.6 113007.0 117917.0 120847.4 10661.5 10669.8 10753.6 10769.6 11087.9 18886.2 21483.6 21891.7 22172.0 22199.7 7806.6 7890.7 7932.0 7974.8 8005.4 4450.1 4487.5 4543.9 4547.4 4658.6 3478.9 3551.9 3575.0 3582.1 3717.2 648.3 682.0 689.5 693.5 709.2 550.7 552.7 587.8 647.0 663.4 9131.7 9213.4 9396.5 9472.3 9641.6 587.5 626.3 644.5 650.7 651.4 4451.8 4476.0 4510.0 4641.2 4753.9 106616.0 129317.0 148740.4 165132.0 171682.0 90957.5 104834.0 137176.3 144541.0 146557.0 119747.0 120241.0 121355.4 123819.0 124604.4 8623.0 8735.8 8892.5 8950.7 9080.4 50711.5 54942.0 67036.0 67463.6 67947.3 93384.0 101089.5 101507.0 102378.0 106221.0 10045.3 11632.2 11789.5 11870.5 11999.7 12169.2 12570.5 12759.0 13304.5 13911.2 12230.0 12248.3 12288.8 12594.7 12732.1 11977.9 12117.2 12137.8 12287.6 12388.4 11866.3 11915.0 12091.3 12179.1 12397.8 9992.8 10332.7 10429.7 10449.7 10504.7 10420.3 10462.3 10636.1 10782.7 10826.9 20:10:42 INFO - PROCESS | 1654 | -------- Summary: end -------- 20:10:42 INFO - PROCESS | 1654 | 20:10:43 INFO - TEST-INFO | 1654: exit 0 20:10:43 INFO - TEST-OK | dromaeo_css | took 1114098ms 20:10:43 INFO - TEST-START | kraken 20:10:43 INFO - operating with platform_type : mac_ 20:10:43 INFO - Initialising browser for kraken test... 20:10:43 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmpnNeUmN/profile http://localhost:49277/getInfo.html) 20:10:46 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 20:10:46 INFO - PROCESS | 1663 | colorDepth:24 20:10:46 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 20:10:46 INFO - PROCESS | 1663 | __metrics 20:10:46 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 20:10:46 INFO - TEST-INFO | 1663: exit 0 20:10:46 INFO - Browser initialized. 20:10:46 INFO - Running cycle 1/1 for kraken test... 20:10:46 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmpnNeUmN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:10:58 INFO - PROCESS | 1665 | RSS: Main: 244387840 20:10:58 INFO - PROCESS | 1665 | 20:11:01 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 20:11:02 INFO - PROCESS | 1665 | RSS: Main: 257126400 20:11:02 INFO - PROCESS | 1665 | 20:11:05 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 20:11:05 INFO - PROCESS | 1665 | RSS: Main: 265887744 20:11:05 INFO - PROCESS | 1665 | 20:11:09 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 20:11:09 INFO - PROCESS | 1665 | RSS: Main: 264482816 20:11:09 INFO - PROCESS | 1665 | 20:11:11 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 20:11:12 INFO - PROCESS | 1665 | RSS: Main: 266813440 20:11:12 INFO - PROCESS | 1665 | 20:11:14 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:11:15 INFO - PROCESS | 1665 | RSS: Main: 267190272 20:11:15 INFO - PROCESS | 1665 | 20:11:17 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 20:11:18 INFO - PROCESS | 1665 | RSS: Main: 267857920 20:11:18 INFO - PROCESS | 1665 | 20:11:21 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 20:11:22 INFO - PROCESS | 1665 | RSS: Main: 267984896 20:11:22 INFO - PROCESS | 1665 | 20:11:25 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 20:11:25 INFO - PROCESS | 1665 | RSS: Main: 268169216 20:11:25 INFO - PROCESS | 1665 | 20:11:27 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:11:27 INFO - PROCESS | 1665 | RSS: Main: 267485184 20:11:27 INFO - PROCESS | 1665 | 20:11:29 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:11:30 INFO - PROCESS | 1665 | RSS: Main: 267948032 20:11:30 INFO - PROCESS | 1665 | 20:11:32 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:11:33 INFO - PROCESS | 1665 | RSS: Main: 268144640 20:11:33 INFO - PROCESS | 1665 | 20:11:36 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:11:36 INFO - PROCESS | 1665 | RSS: Main: 268148736 20:11:36 INFO - PROCESS | 1665 | 20:11:40 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:11:40 INFO - PROCESS | 1665 | RSS: Main: 268423168 20:11:40 INFO - PROCESS | 1665 | 20:11:42 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 20:11:42 INFO - PROCESS | 1665 | RSS: Main: 270401536 20:11:42 INFO - PROCESS | 1665 | 20:11:42 INFO - PROCESS | 1665 | __start_tp_report 20:11:42 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 20:11:42 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 20:11:42 INFO - PROCESS | 1665 | |i|pagename|runs| 20:11:42 INFO - PROCESS | 1665 | |0;ai-astar;111;118;116;114;117;116;115;116;114;133 20:11:42 INFO - PROCESS | 1665 | |1;audio-beat-detection;148;109;136;161;111;133;119;148;180;111 20:11:42 INFO - PROCESS | 1665 | |2;audio-dft;200;205;208;275;252;195;196;202;197;197 20:11:42 INFO - PROCESS | 1665 | |3;audio-fft;70;81;78;155;84;54;49;86;163;83 20:11:42 INFO - PROCESS | 1665 | |4;audio-oscillator;69;71;118;71;72;76;115;69;72;114 20:11:42 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;119;131;88;107;90;86;90;86;89;88 20:11:42 INFO - PROCESS | 1665 | |6;imaging-darkroom;100;99;103;100;102;101;99;112;98;100 20:11:42 INFO - PROCESS | 1665 | |7;imaging-desaturate;99;129;93;103;92;95;95;91;140;110 20:11:42 INFO - PROCESS | 1665 | |8;json-parse-financial;55;60;58;57;57;59;57;56;59;57 20:11:42 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;67;71;73;75;76;81;74;72;71;73 20:11:42 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;87;89;89;88;86;85;89;90;91;90 20:11:42 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;140;142;140;139;138;140;141;170;192;148 20:11:42 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;171;192;172;153;235;162;235;239;235;167 20:11:42 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;62;75;93;89;82;61;81;67;62;90 20:11:42 INFO - PROCESS | 1665 | __end_tp_report 20:11:42 INFO - PROCESS | 1665 | __start_cc_report 20:11:42 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,959 20:11:42 INFO - PROCESS | 1665 | __end_cc_report 20:11:42 INFO - PROCESS | 1665 | __startTimestamp1472526702692__endTimestamp 20:11:42 INFO - PROCESS | 1665 | 20:11:42 INFO - PROCESS | 1665 | ------- Summary: start ------- 20:11:42 INFO - PROCESS | 1665 | Number of tests: 14 20:11:42 INFO - PROCESS | 1665 | 20:11:42 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:117.00 Median:116.00 stddev:5.94 (5.1%) stddev-sans-first:5.89 20:11:42 INFO - PROCESS | 1665 | Values: 111.0 118.0 116.0 114.0 117.0 116.0 115.0 116.0 114.0 133.0 20:11:42 INFO - PROCESS | 1665 | 20:11:42 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:135.60 Median:142.00 stddev:23.86 (16.8%) stddev-sans-first:24.88 20:11:42 INFO - PROCESS | 1665 | Values: 148.0 109.0 136.0 161.0 111.0 133.0 119.0 148.0 180.0 111.0 20:11:42 INFO - PROCESS | 1665 | 20:11:42 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:212.70 Median:203.50 stddev:27.62 (13.6%) stddev-sans-first:28.92 20:11:42 INFO - PROCESS | 1665 | Values: 200.0 205.0 208.0 275.0 252.0 195.0 196.0 202.0 197.0 197.0 20:11:42 INFO - PROCESS | 1665 | 20:11:42 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:90.30 Median:79.50 stddev:38.38 (48.3%) stddev-sans-first:40.00 20:11:42 INFO - PROCESS | 1665 | Values: 70.0 81.0 78.0 155.0 84.0 54.0 49.0 86.0 163.0 83.0 20:11:42 INFO - PROCESS | 1665 | 20:11:42 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:84.70 Median:71.00 stddev:21.48 (30.3%) stddev-sans-first:22.02 20:11:42 INFO - PROCESS | 1665 | Values: 69.0 71.0 118.0 71.0 72.0 76.0 115.0 69.0 72.0 114.0 20:11:42 INFO - PROCESS | 1665 | 20:11:42 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:97.40 Median:88.00 stddev:16.00 (18.2%) stddev-sans-first:14.94 20:11:42 INFO - PROCESS | 1665 | Values: 119.0 131.0 88.0 107.0 90.0 86.0 90.0 86.0 89.0 88.0 20:11:42 INFO - PROCESS | 1665 | 20:11:42 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:101.40 Median:107.50 stddev:4.01 (3.7%) stddev-sans-first:4.22 20:11:42 INFO - PROCESS | 1665 | Values: 100.0 99.0 103.0 100.0 102.0 101.0 99.0 112.0 98.0 100.0 20:11:42 INFO - PROCESS | 1665 | 20:11:42 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:104.70 Median:92.50 stddev:16.91 (18.3%) stddev-sans-first:17.81 20:11:42 INFO - PROCESS | 1665 | Values: 99.0 129.0 93.0 103.0 92.0 95.0 95.0 91.0 140.0 110.0 20:11:42 INFO - PROCESS | 1665 | 20:11:42 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:57.50 stddev:1.51 (2.6%) stddev-sans-first:1.30 20:11:42 INFO - PROCESS | 1665 | Values: 55.0 60.0 58.0 57.0 57.0 59.0 57.0 56.0 59.0 57.0 20:11:42 INFO - PROCESS | 1665 | 20:11:42 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:73.30 Median:73.50 stddev:3.68 (5.0%) stddev-sans-first:3.12 20:11:42 INFO - PROCESS | 1665 | Values: 67.0 71.0 73.0 75.0 76.0 81.0 74.0 72.0 71.0 73.0 20:11:42 INFO - PROCESS | 1665 | 20:11:42 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:89.00 stddev:1.90 (2.1%) stddev-sans-first:1.94 20:11:42 INFO - PROCESS | 1665 | Values: 87.0 89.0 89.0 88.0 86.0 85.0 89.0 90.0 91.0 90.0 20:11:42 INFO - PROCESS | 1665 | 20:11:42 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:149.00 Median:141.50 stddev:17.85 (12.6%) stddev-sans-first:18.63 20:11:42 INFO - PROCESS | 1665 | Values: 140.0 142.0 140.0 139.0 138.0 140.0 141.0 170.0 192.0 148.0 20:11:42 INFO - PROCESS | 1665 | 20:11:42 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.10 Median:213.50 stddev:35.71 (16.7%) stddev-sans-first:36.70 20:11:42 INFO - PROCESS | 1665 | Values: 171.0 192.0 172.0 153.0 235.0 162.0 235.0 239.0 235.0 167.0 20:11:42 INFO - PROCESS | 1665 | 20:11:42 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.20 Median:81.50 stddev:12.53 (15.4%) stddev-sans-first:12.19 20:11:42 INFO - PROCESS | 1665 | Values: 62.0 75.0 93.0 89.0 82.0 61.0 81.0 67.0 62.0 90.0 20:11:42 INFO - PROCESS | 1665 | -------- Summary: end -------- 20:11:42 INFO - PROCESS | 1665 | 20:11:43 INFO - TEST-INFO | 1665: exit 0 20:11:43 INFO - TEST-OK | kraken | took 60146ms 20:11:43 INFO - SUITE-END | took 1174s 20:11:43 INFO - Completed test suite (00:19:34) 20:11:43 INFO - javascript benchmark 20:11:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7243.240064418189, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2840.559713244447, 3340.6158291796437, 3343.648916863731, 3389.644087370826, 3396.184915620252, 4497.168023915574, 4520.954790452094, 5471.5896307776875, 5529.364123125837, 5599.300087489064, 5547.1679248112805, 5608.859778505539, 5615.466530679589, 5627.577931655132, 5647.237622920915, 5054.84835454936, 5112.872178195537, 5148.948510514903, 5197.766100525467, 5310.575153987672, 5177.0, 5204.453532379102, 5215.504527069941, 5254.264402983586, 5274.235235890813, 4980.352554167953, 5022.271770593262, 5106.131957567185, 5130.9743451282875, 5171.50870667286, 5052.621053420971, 5077.64456488046, 5080.720560369178, 5133.486651334874, 5141.614378921596, 5125.487451254882, 5143.0, 5144.948550514484, 5181.740912954338, 5310.840674779763, 5476.2333273341765, 5539.667619942776, 5581.832545023656, 5600.355959064678, 5612.915806262909, 6038.064100064497, 6103.450689437927, 6113.602615829956, 6151.72317245725, 6161.322254551996, 5986.880262394728, 6188.4739797116845, 6216.87566248677, 6229.0967809667345, 6249.125122482856, 5652.773889044433, 5677.659340439545, 5710.200571919934, 5722.17028530869, 5801.274840644919, 6258.278973282293, 6286.182796236551, 6300.558960872787, 6312.400321969406, 6324.525660575475, 5788.016037273674, 6044.486218671374, 6089.847753806191, 6096.542759292982, 6106.084087386927, 5955.28536575605, 6035.637861728311, 6074.271087469444, 6104.267487901391, 6128.019516877278, 5993.190919225936, 5994.790182343684, 6016.639001659914, 6024.277086749618, 6030.638161710312, 5894.6757928314355, 5992.610480318765, 6027.126066720389, 6040.456358927718, 6065.696715164224, 4821.349117869043, 4886.511348865085, 4892.363992680928, 4894.3147959285725, 4903.583195428429, 3686.5207523022373, 3696.537932758405, 4351.608355248043, 4382.715123516961, 4451.910961780746, 5109.821156259513, 5595.552355811526, 5616.803411880564, 5687.857803554944, 5693.174489699053, 6200.472959798378, 6200.844978875474, 6215.906761398583, 6224.346443623354, 6238.282597501346, 4820.758962051884, 5045.344105266366, 5633.549316054706, 5650.26546548946, 5651.378348381675, 4533.52397998212, 5310.070737620901, 5362.570994320445, 5373.704446255493, 5448.591355648342, 5448.618596698272, 6086.965215913306, 6278.15244941927, 6298.8425289367215, 6302.968485157637, 4990.650654454299, 6007.759689612367, 6190.288116866618, 6230.657313847782, 6236.844078898064, 6190.628562286277, 6287.905681414874, 6293.181886354928, 6302.401271879165, 6333.334999824952, 6095.817125486243, 6117.480014198843, 6122.785702500391, 6124.326324104256, 6133.969330153321, 5935.317438494629, 5955.255593050869, 6180.6600636965395, 6202.596831206138, 6222.564420490703, 5896.8820623586425, 5978.611390259619, 5983.611065280743, 6049.153118563317, 6051.878962420815, 5909.970450147894, 5975.103734439869, 5977.073553599199, 5991.221141251609, 5999.370066142992, 5645.774169033192, 5690.402507736628, 5707.629004114885, 5774.0761478163295, 5815.04051831443, 5053.216751403538, 6011.0, 6018.037114061729, 6066.514678825772, 6075.2405949256345, 5828.883422331445, 5834.766609335579, 5851.1223316502865, 5857.4435428634215, 5859.355470898283], "value": 5559.702539746337, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [484.84000279907633, 506.2608591456474, 532.760257883952, 533.6397931396307, 566.3062748133536, 37852.62147378526, 38572.421413678814, 40073.799631001806, 40097.198056038935, 40107.59892401079, 40467.59532404675, 40500.59499405005, 41078.0, 41114.0, 41406.37890431646, 9703.0, 9973.301868869183, 9982.900170998306, 9989.0, 10001.449920254383, 8250.793730156734, 9758.0, 9835.754106147331, 9861.802763944717, 9875.802483950316, 9779.0, 9862.013798620152, 9867.703968880909, 9871.555779989882, 9882.9505852471, 9808.411495310304, 9867.210623150131, 9878.654247101389, 9885.406875587487, 9897.851532226987, 9510.809783804354, 9769.169620582259, 9843.753906152331, 9861.90138098617, 9870.309078364517, 40458.595414045776, 40596.98507537306, 40712.982175445555, 40762.38856417156, 40791.59208407908, 3241.692039256267, 3371.6291207967106, 3412.4710669845967, 3452.3613131570487, 4055.776932268724, 30704.078877633707, 30954.91657791989, 31474.37051258985, 31542.842285788425, 31619.84190079035, 3180.2685382361956, 3351.245969656832, 3369.427197376452, 3408.403529382373, 3412.129906873756, 509527.0, 516699.4165029151, 517454.0, 517528.0, 518974.0, 59020.40979590235, 59106.931257405784, 59283.703581481815, 59426.40573594295, 59721.0, 61560.692196539625, 61762.69118654468, 61896.38103618996, 62444.0, 62557.374426255155, 15410.229488525529, 15768.526944191693, 15800.60498487547, 15917.965332253367, 15994.68010639804, 12344.259344439362, 12435.253884766942, 12536.247825130522, 12560.748785024249, 12565.18326308787, 15897.489738474826, 16524.421645242357, 16580.668386632442, 16606.833931660527, 16630.002199868046, 6742.39318461331, 6806.659667016629, 6821.1814582250445, 6874.759383421556, 6906.205786334535, 847.3348421489102, 957.5882370580717, 970.369259981018, 983.5082458770614, 1021.7292417509366, 32335.838320808245, 33268.833655831564, 33336.66653333888, 33860.49209261863, 34058.82970585181, 926.7072433954596, 947.8341290274175, 953.6519170502855, 996.5764550066193, 1094.3215206571817, 14018.0, 14924.62688432798, 15173.0, 16754.4135955241, 16825.906316089415, 675561.0, 692192.0, 693372.0, 693475.7935892896, 695130.0, 53518.73240633772, 58126.709366452895, 58716.412835871095, 58823.0, 59121.0, 1035.8239099353127, 1147.6384938744436, 1380.4616199681932, 1407.233057983381, 1410.4569740649924, 29585.964491242703, 30773.692263077082, 31774.0, 31821.681783181873, 31902.490726020584, 50842.49157508525, 51140.74429627828, 51433.7428312871, 51580.71048223674, 51723.482765171866, 486022.0, 563513.0, 568104.1594792164, 568633.920759905, 568889.0, 34637.0, 35261.47107793334, 42844.35733463938, 43633.0, 44195.33706994462, 46954.0, 47523.76238118787, 48212.517874820805, 48483.5151648479, 48647.75676121597, 39477.40783888187, 39535.40696889492, 39613.40579891361, 40631.0, 40926.59073409228, 34677.47983780296, 38848.2230355397, 39615.40576891291, 39664.0, 40659.98350041272, 25766.613500797877, 37663.2467350646, 38963.220735585695, 39358.0, 40171.0, 33368.49947250842, 33611.99164024986, 34603.65396346004, 35029.12427189239, 35042.824785875906, 21265.6810147851, 23549.940252688328, 23791.405214869766, 25945.0, 25986.35034124162], "value": 20172.514548201576, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.8406504713127, 340.8057407277851, 364.2387410312447, 371.3946267583838, 389.8538048231913, 20323.695144572845, 20391.898040509794, 21292.0, 21510.354689359305, 21588.460288492795, 20408.489787755276, 20629.587408251828, 20995.895020524913, 21036.78963210371, 21349.679754803652, 5892.793752218673, 6008.57939944203, 6092.756289748405, 6217.937820621803, 6250.624962502265, 6062.939370606282, 6152.753889844424, 6163.1063495793305, 6165.938340616603, 6170.691465426733, 5230.843074707765, 5799.942000580004, 6085.726142323584, 6128.142060111588, 6138.17134686816, 5403.378611459654, 6059.787907423263, 6089.0866370044405, 6103.42017508336, 6157.076438534211, 5894.941050589482, 5997.280326360821, 6037.396260373971, 6042.758289668408, 6053.424924632153, 10794.892051079467, 10832.783344333147, 12906.612801615967, 13198.538051168163, 13219.669508262274, 2030.5532782787764, 2198.9439873718125, 2459.667944827443, 2730.24918147509, 3014.7588192944513, 9541.761455963588, 10017.599296028151, 10152.644657437027, 10154.39073655583, 10336.17310615149, 1592.4585640882156, 1853.7868145163343, 1895.6113996630659, 1905.1236431241646, 1932.1112288347238, 84556.0, 114323.85676143215, 116180.0, 117720.40516353569, 119774.4011279938, 11282.548698051985, 11314.886851131549, 11438.94280528592, 11456.427178641035, 11839.467223974942, 14082.85917140836, 14190.858091418953, 14211.573652790434, 14218.431262749375, 14240.145591264558, 7018.263082376379, 8349.123342049119, 8443.408961372768, 8478.618462169217, 8519.531425771642, 6899.379055884994, 8436.40945133847, 8468.491890486468, 8558.828823423497, 8587.270082043096, 3650.251698401821, 4348.9997300621035, 4379.299312110047, 4499.865004049884, 4506.504284528699, 1890.3100368365447, 1920.3278852401827, 1938.195648805758, 1944.7569053868267, 1958.079702539804, 696.5194016128956, 785.1677222144546, 813.8331642013374, 816.2205094135087, 855.9186877246651, 20171.495712607302, 20413.0, 21304.721716697048, 21783.455413614785, 21846.672299915514, 878.060475291432, 943.8348289049526, 964.5225613321451, 992.6575331510618, 995.9850602240972, 7659.119201291811, 11353.091752659768, 11357.943210283896, 11366.0, 11372.31766094037, 610250.0, 613395.0, 613827.0, 631021.8448907726, 634387.0, 59554.0, 109166.81666366628, 120158.39920800341, 134371.65628343786, 137783.0, 907.8502047162144, 1012.6354512375539, 1024.626011505795, 1065.9786804263872, 1070.9143268538498, 15285.388584456497, 16746.916265418597, 18931.810681893556, 18976.810231897503, 19235.230590776213, 42651.36022959596, 55769.721151393984, 58217.12674309973, 58448.70775646094, 58656.653733851876, 80507.59746201232, 81419.0, 81468.59265703634, 83266.58366708127, 88998.0, 5792.420757924342, 7686.346660533917, 7694.88390692564, 7859.84280314402, 7866.213378662088, 9351.85972210431, 10994.230403871652, 12147.139427036682, 12473.625791226277, 12554.748905021666, 9477.526123693926, 9938.503074846085, 10299.845502317321, 10671.306365086244, 10876.673699789018, 9995.850062248926, 10606.522706478072, 10620.84068738954, 10989.340639561651, 11083.944580277048, 9075.273978081606, 9361.4383137012, 9430.434173949585, 10752.193585480964, 11031.669049928514, 6813.931860681329, 7533.698652054076, 7803.804904877424, 7848.489848159851, 8082.515049097073, 9143.542822858963, 10705.678829635124, 10808.621698240524, 10855.805861355087, 10929.453527323443], "value": 9199.574890951455, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1411.6707432735986, 1450.2821103553742, 1512.5764785859956, 1795.973060404095, 1834.0829585207396, 7937.642806073726, 8407.453515521487, 8427.578621068953, 8997.05530919254, 9018.594163262653, 7265.818354541126, 8844.734657960256, 8844.77888052799, 8846.20384165425, 8862.512561809099, 2341.309313752447, 2379.7501262367464, 2386.809055275574, 2387.176424133671, 2388.1163969331374, 2027.9493012674727, 2340.8829558522007, 2390.725066617344, 2393.7725916038034, 2396.712394512661, 2362.8227882908764, 2369.5853225685437, 2383.833131680783, 2385.189035727852, 2394.5330660521204, 2309.445733024079, 2327.2087490253225, 2330.4057465346395, 2342.2856028911174, 2343.8124950003958, 2315.270689732729, 2358.516504116652, 2360.3980984848927, 2364.7398786133513, 2366.0654041653625, 8874.334424918157, 8887.955560222223, 8904.821903561957, 8920.330975176888, 8945.821083578292, 5116.616253780944, 5179.326687530597, 5301.734913254322, 5313.176457649032, 5332.2801421808335, 3417.470292104728, 3544.379733546619, 3620.0406892173596, 3623.2572322673786, 3624.2751449710163, 1042.4318746283293, 1068.209524951538, 1084.7179733269327, 1091.939943303118, 1100.884407137247, 11555.306681599131, 11583.247088939192, 11668.649940501798, 11679.591214307544, 11690.824637630443, 4585.977070114628, 4626.629869610423, 4794.328793968847, 4813.350197723333, 4833.709977401367, 7772.862462822656, 8115.83768324642, 8634.0, 9318.394304370195, 10502.894971050191, 5316.069687804618, 5330.253764472977, 5334.759935802898, 5341.545968592635, 5349.973250133725, 4196.740977706676, 4429.357743127229, 4821.180399332122, 4915.139850526144, 4945.826896058621, 3901.8244179012013, 3926.7447615904875, 4024.577419370924, 4026.3960405939342, 4082.1223436961195, 1274.8470183577845, 1281.4686449692715, 1287.0990306785288, 1293.321006471591, 1297.2411139483509, 756.3759898084103, 872.2542226396466, 917.7797328641211, 922.9953850230706, 930.9115634014757, 4923.507649235048, 5930.1994230779155, 5938.346781853993, 6000.699965001732, 6125.785597504066, 410.07528024305594, 418.6734347209182, 435.6993674364678, 437.13011107895693, 445.7013800753438, 3547.8935631931085, 3916.412538119248, 4063.6139566741113, 4163.791810409467, 4167.187398457272, 9041.18629323364, 10446.0, 10676.359418434919, 10831.67504974852, 10833.512491937881, 10632.202584806171, 10643.627473038561, 10658.307210031324, 10726.356418614752, 10818.350898946088, 8135.959320203361, 8232.547209903512, 8333.125021872616, 8380.706675266336, 8387.62255698495, 5060.569851562658, 5831.8833623326445, 5946.821595352147, 6021.849453763691, 6085.4523092921845, 9033.728988130366, 9615.086566776145, 9987.151092156957, 10052.94973525157, 10084.042016008467, 9985.201183905416, 10149.949250253701, 10162.79674406493, 10319.174466042548, 10382.42896640692, 6882.4149947253045, 7288.672009759467, 7371.3734332582335, 7508.474406791691, 7523.811904702427, 8462.619182136941, 8538.402311838112, 8541.377138343694, 8560.614772335384, 8578.485290882567, 7347.0, 7446.0, 7474.177840437656, 7514.661840217094, 7571.167171611229, 7243.275672432715, 7296.854062918605, 7320.450966177665, 7429.59137247435, 7455.515391499535, 6754.797356079325, 6912.55068420551, 6996.300369962963, 7060.046893669494, 7082.822929426806, 4873.171560834738, 4983.725895075806, 4990.460588746561, 5144.0997825381155, 5144.30551875492, 4976.776045077908, 5004.2493625956395, 5134.255532947776, 5149.845504634867, 5154.0], "value": 4473.092929195823, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [264.6387680815687, 292.564079521513, 303.1239717217243, 307.75687207106387, 308.4155525279594, 5080.364954380702, 5086.567641750456, 5333.493258168664, 5355.410904800468, 5468.261784659075, 4712.963148107419, 5359.08895487767, 5364.436734142917, 5372.892542149164, 5397.62216644835, 3640.8179591020476, 3671.898430470848, 3699.186179040607, 4052.169305292408, 4104.610062044101, 3604.5849280981806, 3968.920621587581, 4012.598740125993, 4120.402541631462, 4228.5982831630945, 3644.1800594866077, 4023.295923213426, 4062.5531191569053, 4082.2856000199995, 4083.692713616812, 3003.414334204831, 3711.294853977736, 4125.216208920296, 4128.195001974616, 4129.245070844909, 2948.4103179364215, 3564.625714300013, 3582.8566857325936, 3590.7252925211433, 3592.4252119660728, 4508.887277818081, 4700.897407710894, 4869.537393947605, 5220.59044058106, 5261.842144735664, 4631.444226692818, 4640.09518143962, 4671.392718946515, 4691.15559199344, 4716.693414928019, 4624.745638989854, 4783.928241076386, 4900.142475066849, 5169.560587350042, 5649.915251271234, 3227.4019414371423, 3469.080693616194, 3722.8696995605023, 3908.5895980922164, 3909.8465952543784, 5934.554908381889, 5937.228160339128, 5948.940510594882, 5999.73001214942, 6026.758929642809, 3078.3535457553717, 3860.803151023136, 3890.793853905242, 3977.204559088194, 4007.318755811519, 2894.6526416830116, 3203.103131123289, 3495.570578447954, 4017.7187596868525, 4054.8986275342763, 3765.4540091686554, 3776.6789822864816, 4549.044700612908, 4567.406237189144, 4580.236608905595, 5722.7424765885635, 5738.905299565628, 5756.222909907193, 5763.711814409263, 5789.8552536186935, 1254.7553227120625, 1293.95471158509, 1309.7315050414643, 1329.4482789642384, 1331.620488160889, 747.2154238050134, 789.5499565247868, 864.2740098317317, 870.7126648206076, 884.8805411269396, 3942.9299617700362, 4786.7845946932475, 5028.396592408934, 5208.114620514521, 5247.422783493813, 4899.608031357483, 5541.2796336476, 5743.310802703702, 5756.539476841926, 5814.651120932757, 4180.28935081037, 4537.977310113428, 5080.933004069113, 5181.6631918925905, 5227.451117632594, 2528.9504855485134, 2537.8604176770455, 2761.6685997680006, 2936.9706302937125, 3042.680518545521, 4639.768011599474, 5282.709450980156, 5781.364049954502, 6106.717589306296, 6156.569040167235, 5142.845714628567, 5536.944630553723, 5913.408659134052, 5980.491658209014, 5992.471919660458, 5592.440755924375, 6046.969765151146, 6051.606645568024, 6096.207493025879, 6124.295705993868, 5285.7621407036, 5492.725363731877, 5561.499465048165, 5895.380984996686, 5900.232969714081, 4905.798079470553, 5126.74366281677, 5314.97342513285, 5439.748857762657, 5736.0, 5895.174675545341, 6026.896148483447, 6051.909221361771, 6053.636781793107, 6130.601510901777, 3828.7511311764647, 3923.6468717815533, 3989.3417586097967, 3994.6005399459823, 4008.0180355813013, 4794.832180873653, 5532.3637781655625, 5553.916691249715, 5766.913496297475, 5779.422057794187, 5381.0, 5503.9174412383045, 5675.829725108253, 5709.3719690834805, 5711.8000869969355, 4731.9589690268085, 5669.78878237496, 5670.518005969374, 5672.290963629546, 5675.517581005661, 5245.0, 5300.9734951325, 5534.39121696605, 5548.889022219452, 5586.581006424453, 5649.54803615718, 5715.085586306171, 5734.741936612779, 5735.283089613798, 5737.799177028784, 5320.07176231694, 5534.52956498686, 5587.189857470726, 5602.887942241214, 5637.492625663546], "value": 4062.1066851351716, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.1460811040213, 764.5450956680774, 778.4978688745756, 783.2559068884561, 794.0907660728466, 14873.330700118493, 15665.530034098982, 16034.75947860783, 16059.0, 16865.578360540992, 14416.783748243784, 16161.46466085723, 16426.17869106546, 16658.750118748227, 16689.83310166901, 719.791260534447, 844.5734903873536, 867.0592407238123, 872.3806097670662, 872.8210716803072, 668.9030090636879, 697.6965020216197, 842.0358689300747, 865.9523726195057, 875.4090988582712, 911.8723378726984, 917.1974522292994, 919.2691810011057, 919.8482250428672, 920.5535315372039, 879.8680197970324, 905.968291109808, 911.8586619073988, 913.2237598041678, 913.5797533134732, 665.078865770906, 673.050998092687, 673.1719984419143, 674.8987651852212, 675.8580698053365, 15331.846681533265, 15382.307796149089, 15389.153596552185, 15402.845971540253, 15417.537473875802, 13999.230042347666, 14102.365393557315, 14159.999999999896, 14165.504207352693, 14282.07166534172, 9829.560466403169, 11831.112666550043, 11945.820812687816, 12024.639260822189, 12059.638210853689, 3713.6472035156617, 3742.3076730804614, 3760.8871733848027, 3793.506844110276, 3823.6941044716355, 84205.0, 85234.57382713047, 113007.0, 117917.0, 120847.39576302063, 10661.466926653637, 10669.83995240072, 10753.623623173151, 10769.623063192907, 11087.889121108685, 18886.150123244486, 21483.603565768175, 21891.67162492564, 22172.0, 22199.66700499494, 7806.648700808477, 7890.684372625145, 7932.04815422153, 7974.800629984181, 8005.439619226715, 4450.109978004412, 4487.528809475023, 4543.931841022388, 4547.386102876069, 4658.58072773452, 3478.9478157827652, 3551.94672079919, 3574.98212508941, 3582.0865679252147, 3717.237966216919, 648.2545073165898, 681.9872489353306, 689.5483458334799, 693.5318659904544, 709.1879797631786, 550.6916126968911, 552.701541167765, 587.759018802289, 646.9870602587922, 663.4195079305607, 9131.680391186277, 9213.35506514551, 9396.544892622334, 9472.289578281656, 9641.614335426644, 587.5182350472571, 626.2516293029786, 644.4715333426545, 650.7006776882592, 651.4397618048474, 4451.844185453494, 4475.955240447619, 4509.977450112794, 4641.234196357564, 4753.928691069636, 106616.0, 129317.0, 148740.40744906888, 165132.0, 171681.99113030985, 90957.54521227352, 104834.0, 137176.31411842877, 144541.0, 146557.0, 119747.0, 120241.0, 121355.39322303332, 123819.0, 124604.40862526787, 8623.008354039366, 8735.825283494421, 8892.466452012899, 8950.731478055668, 9080.364374493722, 50711.49288507068, 54942.0, 67036.0, 67463.62681865985, 67947.3205267941, 93384.0, 101089.49455252677, 101507.0, 102377.97622023983, 106221.0, 10045.33798543372, 11632.199044284336, 11789.528418863492, 11870.465829037887, 11999.700007499883, 12169.20900141488, 12570.49718011306, 12759.0, 13304.534341298007, 13911.234882081582, 12230.0, 12248.265104093784, 12288.815667764811, 12594.748105038032, 12732.108752387245, 11977.940110299742, 12117.212381195193, 12137.757244855231, 12287.646461393573, 12388.380580971096, 11866.347350895783, 11915.0, 12091.274523528617, 12179.147459678092, 12397.75204495923, 9992.800143997225, 10332.690019299433, 10429.68710938673, 10449.738756530844, 10504.737381565523, 10420.32267902584, 10462.267641265038, 10636.14910807118, 10782.67651970442, 10826.89173108259], "value": 7702.136299136364, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1584.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 118.0, 116.0, 114.0, 117.0, 116.0, 115.0, 116.0, 114.0, 133.0], "value": 117.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 109.0, 136.0, 161.0, 111.0, 133.0, 119.0, 148.0, 180.0, 111.0], "value": 135.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 205.0, 208.0, 275.0, 252.0, 195.0, 196.0, 202.0, 197.0, 197.0], "value": 212.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 81.0, 78.0, 155.0, 84.0, 54.0, 49.0, 86.0, 163.0, 83.0], "value": 90.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 118.0, 71.0, 72.0, 76.0, 115.0, 69.0, 72.0, 114.0], "value": 84.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 131.0, 88.0, 107.0, 90.0, 86.0, 90.0, 86.0, 89.0, 88.0], "value": 97.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 99.0, 103.0, 100.0, 102.0, 101.0, 99.0, 112.0, 98.0, 100.0], "value": 101.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 129.0, 93.0, 103.0, 92.0, 95.0, 95.0, 91.0, 140.0, 110.0], "value": 104.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 60.0, 58.0, 57.0, 57.0, 59.0, 57.0, 56.0, 59.0, 57.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 73.0, 75.0, 76.0, 81.0, 74.0, 72.0, 71.0, 73.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 89.0, 88.0, 86.0, 85.0, 89.0, 90.0, 91.0, 90.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 142.0, 140.0, 139.0, 138.0, 140.0, 141.0, 170.0, 192.0, 148.0], "value": 149.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 192.0, 172.0, 153.0, 235.0, 162.0, 235.0, 239.0, 235.0, 167.0], "value": 196.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 75.0, 93.0, 89.0, 82.0, 61.0, 81.0, 67.0, 62.0, 90.0], "value": 76.2, "unit": "score"}]}]} 20:11:43 INFO - Return code: 0 20:11:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:11:43 ERROR - # TBPL SUCCESS # 20:11:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:11:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:11:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:11:44 INFO - 2016-08-29 20:11:44.007 screenresolution[1670:10572] starting screenresolution argv=screenresolution get 20:11:44 INFO - 2016-08-29 20:11:44.009 screenresolution[1670:10572] Display 0: 1600x1200x32@60 20:11:44 INFO - 2016-08-29 20:11:44.015 screenresolution[1671:10575] starting screenresolution argv=screenresolution list 20:11:44 INFO - Available Modes on Display 0 20:11:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:11:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:11:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:11:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:11:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:11:44 INFO - Intel Iris: 20:11:44 INFO - Chipset Model: Intel Iris 20:11:44 INFO - Type: GPU 20:11:44 INFO - Bus: Built-In 20:11:44 INFO - VRAM (Dynamic, Max): 1536 MB 20:11:44 INFO - Vendor: Intel (0x8086) 20:11:44 INFO - Device ID: 0x0a2e 20:11:44 INFO - Revision ID: 0x0009 20:11:44 INFO - Displays: 20:11:44 INFO - Display: 20:11:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:11:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:11:44 INFO - Display Serial Number: 1600x1200 60 20:11:44 INFO - Main Display: Yes 20:11:44 INFO - Mirror: Off 20:11:44 INFO - Online: Yes 20:11:44 INFO - Rotation: Supported 20:11:44 INFO - Return code: 0 20:11:44 INFO - Running post-action listener: _resource_record_post_action 20:11:44 INFO - [mozharness: 2016-08-30 03:11:44.253082Z] Finished run-tests step (success) 20:11:44 INFO - Running post-run listener: _resource_record_post_run 20:11:44 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 36873216; Write bytes: 707788288; Read time: 249; Write time: 2016 20:11:44 INFO - TinderboxPrint: CPU usage
54.3% 20:11:44 INFO - TinderboxPrint: I/O read bytes / time
36,873,216 / 249 20:11:44 INFO - TinderboxPrint: I/O write bytes / time
707,788,288 / 2,016 20:11:44 INFO - TinderboxPrint: CPU idle
2,209.8 (45.7%) 20:11:44 INFO - TinderboxPrint: CPU system
981.4 (20.3%) 20:11:44 INFO - TinderboxPrint: CPU user
1,646.5 (34.0%) 20:11:44 INFO - TinderboxPrint: Swap in / out
443,633,664 / 0 20:11:44 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 402020864; Write bytes: 391321600; Read time: 29640; Write time: 799 20:11:44 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 29543424; Write bytes: 297793024; Read time: 189; Write time: 1170 20:11:44 INFO - Running post-run listener: _upload_blobber_files 20:11:44 INFO - Blob upload gear active. 20:11:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:11:44 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 20:11:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:11:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:11:45 INFO - (blobuploader) - INFO - Open directory for files ... 20:11:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:11:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:11:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:11:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:11:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:11:46 INFO - (blobuploader) - INFO - Done attempting. 20:11:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:11:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:11:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:11:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:11:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:11:47 INFO - (blobuploader) - INFO - Done attempting. 20:11:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:11:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:11:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:11:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:11:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:11:50 INFO - (blobuploader) - INFO - Done attempting. 20:11:50 INFO - (blobuploader) - INFO - Iteration through files over. 20:11:50 INFO - Return code: 0 20:11:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:11:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:11:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66a906e4e4388a30185eb40ac3b9f7793e6370908fda02d2433c2786bdb0d8d0682fd4929b1cf4b606bb3e2897cdb1746c652878a448beb712b2a75d5d97b919", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83a75604d0260af2f150fce009b89d3aceed995fe4cef8c1244d90ef8771bef02916cbdbb31903248eda08d575760ee7c3e4c2c3a2ad0773912b10a3babdefd2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b720e96ba615091318f4bd43ea9a1adbe9808f486559d52e15a9cec81ae4dd4837a6746c44ac61ed5b4fe0bbb5e4ec332a1409a13eded53383671e88cf5fbe29"} 20:11:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:11:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:11:50 INFO - Contents: 20:11:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66a906e4e4388a30185eb40ac3b9f7793e6370908fda02d2433c2786bdb0d8d0682fd4929b1cf4b606bb3e2897cdb1746c652878a448beb712b2a75d5d97b919", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83a75604d0260af2f150fce009b89d3aceed995fe4cef8c1244d90ef8771bef02916cbdbb31903248eda08d575760ee7c3e4c2c3a2ad0773912b10a3babdefd2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b720e96ba615091318f4bd43ea9a1adbe9808f486559d52e15a9cec81ae4dd4837a6746c44ac61ed5b4fe0bbb5e4ec332a1409a13eded53383671e88cf5fbe29"} 20:11:50 INFO - Running post-run listener: copy_logs_to_upload_dir 20:11:50 INFO - Copying logs to upload dir... 20:11:50 INFO - mkdir: /builds/slave/test/build/upload/logs 20:11:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.479173 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-29 20:11:50.083846) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 20:11:50.087744) ========= 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.YDXDek3S7I/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.fe1d4XUCTb/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66a906e4e4388a30185eb40ac3b9f7793e6370908fda02d2433c2786bdb0d8d0682fd4929b1cf4b606bb3e2897cdb1746c652878a448beb712b2a75d5d97b919", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83a75604d0260af2f150fce009b89d3aceed995fe4cef8c1244d90ef8771bef02916cbdbb31903248eda08d575760ee7c3e4c2c3a2ad0773912b10a3babdefd2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b720e96ba615091318f4bd43ea9a1adbe9808f486559d52e15a9cec81ae4dd4837a6746c44ac61ed5b4fe0bbb5e4ec332a1409a13eded53383671e88cf5fbe29"} build_url:https://queue.taskcluster.net/v1/task/IA-Kx_oxROWwVIkFZkMP6g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011188 build_url: 'https://queue.taskcluster.net/v1/task/IA-Kx_oxROWwVIkFZkMP6g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66a906e4e4388a30185eb40ac3b9f7793e6370908fda02d2433c2786bdb0d8d0682fd4929b1cf4b606bb3e2897cdb1746c652878a448beb712b2a75d5d97b919", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83a75604d0260af2f150fce009b89d3aceed995fe4cef8c1244d90ef8771bef02916cbdbb31903248eda08d575760ee7c3e4c2c3a2ad0773912b10a3babdefd2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b720e96ba615091318f4bd43ea9a1adbe9808f486559d52e15a9cec81ae4dd4837a6746c44ac61ed5b4fe0bbb5e4ec332a1409a13eded53383671e88cf5fbe29"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 20:11:50.124959) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 20:11:50.125594) ========= 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.YDXDek3S7I/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.fe1d4XUCTb/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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.005092 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 20:11:50.178740) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 20:11:50.179457) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 20:11:50.180086) ========= ========= Total master_lag: 1.61 =========