builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0390 starttime: 1471571900.68 results: success (0) buildid: 20160818161755 builduid: 0fe20b8d296d47ec9cf2f42deb930e13 revision: cf06fbc831754e54c6abb71d3136597488a530e0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 18:58:20.677389) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 18:58:20.677825) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 18:58:20.678103) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 18:58:20.707018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 18:58:20.707372) ========= 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.Q4wsyPIoCt/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.NjwraM89de/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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-18 18:58:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 147M=0s 2016-08-18 18:58:20 (147 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158375 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 18:58:20.888732) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 18:58:20.889043) ========= 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.Q4wsyPIoCt/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.NjwraM89de/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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.025303 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 18:58:20.941327) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-18 18:58:20.943708) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cf06fbc831754e54c6abb71d3136597488a530e0 --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 cf06fbc831754e54c6abb71d3136597488a530e0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Q4wsyPIoCt/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.NjwraM89de/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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-18 18:58:21,028 truncating revision to first 12 chars 2016-08-18 18:58:21,028 Setting DEBUG logging. 2016-08-18 18:58:21,028 attempt 1/10 2016-08-18 18:58:21,028 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cf06fbc83175?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-18 18:58:22,055 unpacking tar archive at: mozilla-central-cf06fbc83175/testing/mozharness/ program finished with exit code 0 elapsedTime=1.302629 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-18 18:58:22.268560) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 18:58:22.268904) ========= script_repo_revision: cf06fbc831754e54c6abb71d3136597488a530e0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 18:58:22.269329) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 18:58:22.269622) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 18:58:22.287919) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-08-18 18:58:22.288232) ========= /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.Q4wsyPIoCt/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.NjwraM89de/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 18:58:22 INFO - MultiFileLogger online at 20160818 18:58:22 in /builds/slave/test 18:58:22 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 18:58:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:58:22 INFO - {'append_to_log': False, 18:58:22 INFO - 'base_work_dir': '/builds/slave/test', 18:58:22 INFO - 'blob_upload_branch': 'Firefox', 18:58:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:58:22 INFO - 'branch': 'Firefox', 18:58:22 INFO - 'buildbot_json_path': 'buildprops.json', 18:58:22 INFO - 'config_files': ('talos/mac_config.py',), 18:58:22 INFO - 'default_actions': ('clobber', 18:58:22 INFO - 'read-buildbot-config', 18:58:22 INFO - 'download-and-extract', 18:58:22 INFO - 'populate-webroot', 18:58:22 INFO - 'create-virtualenv', 18:58:22 INFO - 'install', 18:58:22 INFO - 'run-tests'), 18:58:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:58:22 INFO - 'download_minidump_stackwalk': True, 18:58:22 INFO - 'download_symbols': 'ondemand', 18:58:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:58:22 INFO - 'tooltool.py': '/tools/tooltool.py', 18:58:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:58:22 INFO - '/tools/misc-python/virtualenv.py')}, 18:58:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:58:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:58:22 INFO - 'installer_path': 'installer.exe', 18:58:22 INFO - 'log_level': 'info', 18:58:22 INFO - 'log_name': 'talos', 18:58:22 INFO - 'log_to_console': True, 18:58:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:58:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:58:22 INFO - 'opt_config_files': (), 18:58:22 INFO - 'pip_index': False, 18:58:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:58:22 INFO - 'cmd': ('bash', 18:58:22 INFO - '-c', 18:58:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:58:22 INFO - 'enabled': True, 18:58:22 INFO - 'halt_on_failure': False, 18:58:22 INFO - 'name': 'check_screen_resolution'},), 18:58:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:58:22 INFO - 'cmd': ('bash', 18:58:22 INFO - '-c', 18:58:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:58:22 INFO - 'enabled': True, 18:58:22 INFO - 'halt_on_failure': False, 18:58:22 INFO - 'name': 'check_screen_resolution'},), 18:58:22 INFO - 'run_cmd_checks_enabled': True, 18:58:22 INFO - 'sps_profile': False, 18:58:22 INFO - 'sps_profile_interval': 0, 18:58:22 INFO - 'suite': 'dromaeojs-e10s', 18:58:22 INFO - 'system_bits': '32', 18:58:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:58:22 INFO - 'title': 't-yosemite-r7-0390', 18:58:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:58:22 INFO - 'use_talos_json': True, 18:58:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:58:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:58:22 INFO - 'work_dir': 'build'} 18:58:22 INFO - [mozharness: 2016-08-19 01:58:22.485568Z] Running clobber step. 18:58:22 INFO - Running pre-action listener: _resource_record_pre_action 18:58:22 INFO - Running main action method: clobber 18:58:22 INFO - rmtree: /builds/slave/test/build 18:58:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:58:24 INFO - Running post-action listener: _resource_record_post_action 18:58:24 INFO - [mozharness: 2016-08-19 01:58:24.337468Z] Finished clobber step (success) 18:58:24 INFO - [mozharness: 2016-08-19 01:58:24.337599Z] Running read-buildbot-config step. 18:58:24 INFO - Running pre-action listener: _resource_record_pre_action 18:58:24 INFO - Running main action method: read_buildbot_config 18:58:24 INFO - Using buildbot properties: 18:58:24 INFO - { 18:58:24 INFO - "project": "", 18:58:24 INFO - "product": "firefox", 18:58:24 INFO - "script_repo_revision": "production", 18:58:24 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 18:58:24 INFO - "repository": "", 18:58:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 18:58:24 INFO - "buildid": "20160818161755", 18:58:24 INFO - "pgo_build": "False", 18:58:24 INFO - "basedir": "/builds/slave/test", 18:58:24 INFO - "buildnumber": 25, 18:58:24 INFO - "slavename": "t-yosemite-r7-0390", 18:58:24 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 18:58:24 INFO - "platform": "yosemite_r7", 18:58:24 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:58:24 INFO - "branch": "mozilla-central", 18:58:24 INFO - "repo_path": "mozilla-central", 18:58:24 INFO - "revision": "cf06fbc831754e54c6abb71d3136597488a530e0", 18:58:24 INFO - "stage_platform": "macosx64", 18:58:24 INFO - "builduid": "0fe20b8d296d47ec9cf2f42deb930e13", 18:58:24 INFO - "slavebuilddir": "test" 18:58:24 INFO - } 18:58:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y3t-DEPxT2OQRUstt15QLQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 18:58:24 INFO - Running post-action listener: _resource_record_post_action 18:58:24 INFO - [mozharness: 2016-08-19 01:58:24.340519Z] Finished read-buildbot-config step (success) 18:58:24 INFO - [mozharness: 2016-08-19 01:58:24.340616Z] Running download-and-extract step. 18:58:24 INFO - Running pre-action listener: _resource_record_pre_action 18:58:24 INFO - Running main action method: download_and_extract 18:58:24 INFO - mkdir: /builds/slave/test/build/tests 18:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:24 INFO - trying https://queue.taskcluster.net/v1/task/Y3t-DEPxT2OQRUstt15QLQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 18:58:24 INFO - Downloading https://queue.taskcluster.net/v1/task/Y3t-DEPxT2OQRUstt15QLQ/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 18:58:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y3t-DEPxT2OQRUstt15QLQ/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 18:58:25 INFO - Downloaded 1199 bytes. 18:58:25 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 18:58:25 INFO - Using the following test package requirements: 18:58:25 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 18:58:25 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:58:25 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 18:58:25 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:58:25 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 18:58:25 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:58:25 INFO - u'jsshell-mac.zip'], 18:58:25 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:58:25 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 18:58:25 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 18:58:25 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:58:25 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 18:58:25 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:58:25 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 18:58:25 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:58:25 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 18:58:25 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:58:25 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 18:58:25 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:25 INFO - trying https://queue.taskcluster.net/v1/task/Y3t-DEPxT2OQRUstt15QLQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 18:58:25 INFO - Downloading https://queue.taskcluster.net/v1/task/Y3t-DEPxT2OQRUstt15QLQ/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 18:58:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y3t-DEPxT2OQRUstt15QLQ/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 18:58:26 INFO - Downloaded 16339498 bytes. 18:58:26 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 18:58:32 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 18:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:32 INFO - trying https://queue.taskcluster.net/v1/task/Y3t-DEPxT2OQRUstt15QLQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 18:58:32 INFO - Downloading https://queue.taskcluster.net/v1/task/Y3t-DEPxT2OQRUstt15QLQ/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 18:58:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y3t-DEPxT2OQRUstt15QLQ/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 18:58:33 INFO - Downloaded 16339498 bytes. 18:58:33 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 18:58:40 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')]} 18:58:40 INFO - trying https://queue.taskcluster.net/v1/task/Y3t-DEPxT2OQRUstt15QLQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 18:58:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Y3t-DEPxT2OQRUstt15QLQ/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 18:58:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y3t-DEPxT2OQRUstt15QLQ/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 18:58:41 INFO - Downloaded 14413981 bytes. 18:58:41 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 18:58: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')]} 18:58:41 INFO - trying https://queue.taskcluster.net/v1/task/Y3t-DEPxT2OQRUstt15QLQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 18:58:41 INFO - Downloading https://queue.taskcluster.net/v1/task/Y3t-DEPxT2OQRUstt15QLQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 18:58:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y3t-DEPxT2OQRUstt15QLQ/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 18:58:44 INFO - Downloaded 111249644 bytes. 18:58:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y3t-DEPxT2OQRUstt15QLQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 18:58:44 INFO - mkdir: /builds/slave/test/properties 18:58:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:58:44 INFO - Writing to file /builds/slave/test/properties/build_url 18:58:44 INFO - Contents: 18:58:44 INFO - build_url:https://queue.taskcluster.net/v1/task/Y3t-DEPxT2OQRUstt15QLQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 18:58:45 INFO - Running post-action listener: _resource_record_post_action 18:58:45 INFO - Running post-action listener: set_extra_try_arguments 18:58:45 INFO - [mozharness: 2016-08-19 01:58:45.586581Z] Finished download-and-extract step (success) 18:58:45 INFO - [mozharness: 2016-08-19 01:58:45.586730Z] Running populate-webroot step. 18:58:45 INFO - Running pre-action listener: _resource_record_pre_action 18:58:45 INFO - Running main action method: populate_webroot 18:58:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:58:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:58:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:58:45 INFO - '--tppagecycles', 18:58:45 INFO - '7'], 18:58:45 INFO - 'tests': ['tsvgm']}}, 18:58:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:58:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:58:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:58:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:58:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:58:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:58:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:45 INFO - 'talos_options': ['--disable-e10s'], 18:58:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:58:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:58:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:45 INFO - 'talos_options': ['--disable-e10s'], 18:58:45 INFO - 'tests': ['damp', 'tps']}, 18:58:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:45 INFO - 'tests': ['damp', 'tps']}, 18:58:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:58:45 INFO - 'tests': ['dromaeo_dom']}, 18:58:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:58:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:58:45 INFO - 'tests': ['basic_compositor_video']}, 18:58:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:58:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:58:45 INFO - 'tests': ['a11yr', 18:58:45 INFO - 'ts_paint', 18:58:45 INFO - 'tpaint', 18:58:45 INFO - 'sessionrestore', 18:58:45 INFO - 'sessionrestore_no_auto_restore', 18:58:45 INFO - 'tabpaint']}, 18:58:45 INFO - 'other-e10s': {'tests': ['a11yr', 18:58:45 INFO - 'ts_paint', 18:58:45 INFO - 'tpaint', 18:58:45 INFO - 'sessionrestore', 18:58:45 INFO - 'sessionrestore_no_auto_restore', 18:58:45 INFO - 'tabpaint']}, 18:58:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:58:45 INFO - 'ts_paint', 18:58:45 INFO - 'tpaint', 18:58:45 INFO - 'sessionrestore', 18:58:45 INFO - 'sessionrestore_no_auto_restore', 18:58:45 INFO - 'tabpaint']}, 18:58:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:58:45 INFO - 'ts_paint', 18:58:45 INFO - 'tpaint', 18:58:45 INFO - 'sessionrestore', 18:58:45 INFO - 'sessionrestore_no_auto_restore', 18:58:45 INFO - 'tabpaint']}, 18:58:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:58:45 INFO - 'tests': ['a11yr', 18:58:45 INFO - 'ts_paint', 18:58:45 INFO - 'tpaint', 18:58:45 INFO - 'sessionrestore', 18:58:45 INFO - 'sessionrestore_no_auto_restore', 18:58:45 INFO - 'tabpaint']}, 18:58:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:58:45 INFO - 'tests': ['a11yr', 18:58:45 INFO - 'ts_paint', 18:58:45 INFO - 'tpaint', 18:58:45 INFO - 'sessionrestore', 18:58:45 INFO - 'sessionrestore_no_auto_restore', 18:58:45 INFO - 'tabpaint']}, 18:58:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:58:45 INFO - 'tests': ['tsvgx', 18:58:45 INFO - 'tsvgr_opacity', 18:58:45 INFO - 'tart', 18:58:45 INFO - 'tscrollx', 18:58:45 INFO - 'cart']}, 18:58:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:58:45 INFO - 'tsvgr_opacity', 18:58:45 INFO - 'tart', 18:58:45 INFO - 'tscrollx', 18:58:45 INFO - 'cart']}, 18:58:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:45 INFO - 'talos_options': ['--disable-e10s'], 18:58:45 INFO - 'tests': ['tp5o']}, 18:58:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:45 INFO - 'tests': ['tp5o']}, 18:58:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:45 INFO - 'talos_options': ['--disable-e10s', 18:58:45 INFO - '--xperf_path', 18:58:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:58:45 INFO - 'tests': ['tp5n']}, 18:58:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:58:45 INFO - 'talos_options': ['--xperf_path', 18:58:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:58:45 INFO - 'tests': ['tp5n']}}, 18:58:45 INFO - 'talos.zip': {'path': '', 18:58:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:58:45 INFO - Running post-action listener: _resource_record_post_action 18:58:45 INFO - [mozharness: 2016-08-19 01:58:45.605635Z] Finished populate-webroot step (success) 18:58:45 INFO - [mozharness: 2016-08-19 01:58:45.605766Z] Running create-virtualenv step. 18:58:45 INFO - Running pre-action listener: _resource_record_pre_action 18:58:45 INFO - Running main action method: create_virtualenv 18:58:45 INFO - Creating virtualenv /builds/slave/test/build/venv 18:58:45 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 18:58:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:58:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:58:45 INFO - Using real prefix '/tools/python27' 18:58:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:58:46 INFO - Installing distribute.............................................................................................................................................................................................done. 18:58:49 INFO - Installing pip.................done. 18:58:49 INFO - Return code: 0 18:58:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e045a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0da618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe439570eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa9d30>, '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 0x10dd0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa1b20>, '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.Q4wsyPIoCt/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.NjwraM89de/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 18:58:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:58:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:58:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q4wsyPIoCt/Render', 18:58:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:58:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:58:49 INFO - 'HOME': '/Users/cltbld', 18:58:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:58:49 INFO - 'LOGNAME': 'cltbld', 18:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:49 INFO - 'MOZ_NO_REMOTE': '1', 18:58:49 INFO - 'NO_EM_RESTART': '1', 18:58:49 INFO - 'PAGER': '/bin/cat', 18:58:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:49 INFO - 'PWD': '/builds/slave/test', 18:58:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:58:49 INFO - 'SHELL': '/bin/bash', 18:58:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NjwraM89de/Listeners', 18:58:49 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 18:58:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:58:49 INFO - 'USER': 'cltbld', 18:58:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:58:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:49 INFO - 'XPC_FLAGS': '0x0', 18:58:49 INFO - 'XPC_SERVICE_NAME': '0', 18:58:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:49 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 18:58:49 INFO - Cleaning up... 18:58:49 INFO - Return code: 0 18:58:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e045a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0da618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe439570eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa9d30>, '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 0x10dd0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa1b20>, '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.Q4wsyPIoCt/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.NjwraM89de/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 18:58:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:58:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:58:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q4wsyPIoCt/Render', 18:58:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:58:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:58:49 INFO - 'HOME': '/Users/cltbld', 18:58:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:58:49 INFO - 'LOGNAME': 'cltbld', 18:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:49 INFO - 'MOZ_NO_REMOTE': '1', 18:58:49 INFO - 'NO_EM_RESTART': '1', 18:58:49 INFO - 'PAGER': '/bin/cat', 18:58:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:49 INFO - 'PWD': '/builds/slave/test', 18:58:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:58:49 INFO - 'SHELL': '/bin/bash', 18:58:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NjwraM89de/Listeners', 18:58:49 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 18:58:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:58:49 INFO - 'USER': 'cltbld', 18:58:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:58:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:49 INFO - 'XPC_FLAGS': '0x0', 18:58:49 INFO - 'XPC_SERVICE_NAME': '0', 18:58:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:49 INFO - Downloading/unpacking psutil>=3.1.1 18:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:58:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:58:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:58:52 INFO - Installing collected packages: psutil 18:58:52 INFO - Running setup.py install for psutil 18:58:52 INFO - building 'psutil._psutil_osx' extension 18:58:52 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 18:58:53 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 18:58:53 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 18:58:53 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 18:58:53 INFO - building 'psutil._psutil_posix' extension 18:58:53 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 18:58:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:58:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:58:53 INFO - ^ 18:58:53 INFO - 1 warning generated. 18:58:53 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 18:58:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:58:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:58:53 INFO - Successfully installed psutil 18:58:53 INFO - Cleaning up... 18:58:53 INFO - Return code: 0 18:58:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:53 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 0x10e045a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0da618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe439570eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa9d30>, '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 0x10dd0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa1b20>, '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.Q4wsyPIoCt/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.NjwraM89de/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 18:58:53 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 18:58:53 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 18:58:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q4wsyPIoCt/Render', 18:58:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:58:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:58:53 INFO - 'HOME': '/Users/cltbld', 18:58:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:58:53 INFO - 'LOGNAME': 'cltbld', 18:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:53 INFO - 'MOZ_NO_REMOTE': '1', 18:58:53 INFO - 'NO_EM_RESTART': '1', 18:58:53 INFO - 'PAGER': '/bin/cat', 18:58:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:53 INFO - 'PWD': '/builds/slave/test', 18:58:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:58:53 INFO - 'SHELL': '/bin/bash', 18:58:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NjwraM89de/Listeners', 18:58:53 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 18:58:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:58:53 INFO - 'USER': 'cltbld', 18:58:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:58:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:53 INFO - 'XPC_FLAGS': '0x0', 18:58:53 INFO - 'XPC_SERVICE_NAME': '0', 18:58:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:58:54 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 18:58:54 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 18:58:54 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 18:58:54 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 18:58:54 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 18:58:54 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 18:58:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:58:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:58:56 INFO - Installing collected packages: mozsystemmonitor 18:58:56 INFO - Running setup.py install for mozsystemmonitor 18:58:56 INFO - Successfully installed mozsystemmonitor 18:58:56 INFO - Cleaning up... 18:58:57 INFO - Return code: 0 18:58:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:58:57 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 0x10e045a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0da618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe439570eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa9d30>, '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 0x10dd0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa1b20>, '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.Q4wsyPIoCt/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.NjwraM89de/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 18:58:57 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 18:58:57 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 18:58:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q4wsyPIoCt/Render', 18:58:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:58:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:58:57 INFO - 'HOME': '/Users/cltbld', 18:58:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:58:57 INFO - 'LOGNAME': 'cltbld', 18:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:57 INFO - 'MOZ_NO_REMOTE': '1', 18:58:57 INFO - 'NO_EM_RESTART': '1', 18:58:57 INFO - 'PAGER': '/bin/cat', 18:58:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:57 INFO - 'PWD': '/builds/slave/test', 18:58:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:58:57 INFO - 'SHELL': '/bin/bash', 18:58:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NjwraM89de/Listeners', 18:58:57 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 18:58:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:58:57 INFO - 'USER': 'cltbld', 18:58:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:58:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:57 INFO - 'XPC_FLAGS': '0x0', 18:58:57 INFO - 'XPC_SERVICE_NAME': '0', 18:58:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:57 INFO - Downloading/unpacking jsonschema==2.5.1 18:58:57 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 18:58:57 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 18:58:57 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 18:58:57 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 18:58:57 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 18:58:57 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 18:58:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:58:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:58:59 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 18:58:59 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 18:58:59 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 18:58:59 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 18:58:59 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 18:58:59 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 18:59:00 INFO - Downloading functools32-3.2.3-2.tar.gz 18:59:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:59:00 INFO - warning: no files found matching '*.txt' 18:59:00 INFO - no previously-included directories found matching 'build' 18:59:00 INFO - no previously-included directories found matching 'dist' 18:59:00 INFO - no previously-included directories found matching '.git*' 18:59:00 INFO - Installing collected packages: jsonschema, functools32 18:59:00 INFO - Running setup.py install for functools32 18:59:00 INFO - warning: no files found matching '*.txt' 18:59:00 INFO - no previously-included directories found matching 'build' 18:59:00 INFO - no previously-included directories found matching 'dist' 18:59:00 INFO - no previously-included directories found matching '.git*' 18:59:00 INFO - Successfully installed jsonschema functools32 18:59:00 INFO - Cleaning up... 18:59:00 INFO - Return code: 0 18:59:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:59:00 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')]} 18:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:00 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')]} 18:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:00 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 0x10e045a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0da618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe439570eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa9d30>, '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 0x10dd0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa1b20>, '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.Q4wsyPIoCt/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.NjwraM89de/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 18:59:00 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 18:59:00 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 18:59:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q4wsyPIoCt/Render', 18:59:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:00 INFO - 'HOME': '/Users/cltbld', 18:59:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:00 INFO - 'LOGNAME': 'cltbld', 18:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:00 INFO - 'MOZ_NO_REMOTE': '1', 18:59:00 INFO - 'NO_EM_RESTART': '1', 18:59:00 INFO - 'PAGER': '/bin/cat', 18:59:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:00 INFO - 'PWD': '/builds/slave/test', 18:59:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:00 INFO - 'SHELL': '/bin/bash', 18:59:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NjwraM89de/Listeners', 18:59:00 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 18:59:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:00 INFO - 'USER': 'cltbld', 18:59:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:00 INFO - 'XPC_FLAGS': '0x0', 18:59:00 INFO - 'XPC_SERVICE_NAME': '0', 18:59:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:59:00 INFO - Cleaning up... 18:59:00 INFO - Return code: 0 18:59:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:59:00 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')]} 18:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:00 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')]} 18:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:00 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 0x10e045a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0da618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe439570eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa9d30>, '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 0x10dd0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa1b20>, '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.Q4wsyPIoCt/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.NjwraM89de/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 18:59:00 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 18:59:00 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 18:59:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q4wsyPIoCt/Render', 18:59:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:00 INFO - 'HOME': '/Users/cltbld', 18:59:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:00 INFO - 'LOGNAME': 'cltbld', 18:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:00 INFO - 'MOZ_NO_REMOTE': '1', 18:59:00 INFO - 'NO_EM_RESTART': '1', 18:59:00 INFO - 'PAGER': '/bin/cat', 18:59:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:00 INFO - 'PWD': '/builds/slave/test', 18:59:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:00 INFO - 'SHELL': '/bin/bash', 18:59:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NjwraM89de/Listeners', 18:59:00 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 18:59:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:00 INFO - 'USER': 'cltbld', 18:59:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:00 INFO - 'XPC_FLAGS': '0x0', 18:59:00 INFO - 'XPC_SERVICE_NAME': '0', 18:59:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:01 INFO - Downloading/unpacking blobuploader==1.2.4 18:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:03 INFO - Downloading blobuploader-1.2.4.tar.gz 18:59:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:59:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:59:03 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 18:59:03 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 18:59:03 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 18:59:03 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 18:59:03 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 18:59:03 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 18:59:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:59:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:59:04 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 18:59:04 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 18:59:04 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 18:59:04 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 18:59:04 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 18:59:04 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 18:59:04 INFO - Downloading docopt-0.6.1.tar.gz 18:59:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:59:04 INFO - Installing collected packages: blobuploader, requests, docopt 18:59:04 INFO - Running setup.py install for blobuploader 18:59:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:59:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:59:04 INFO - Running setup.py install for requests 18:59:05 INFO - Running setup.py install for docopt 18:59:05 INFO - Successfully installed blobuploader requests docopt 18:59:05 INFO - Cleaning up... 18:59:05 INFO - Return code: 0 18:59:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:59:05 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')]} 18:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:05 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')]} 18:59:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:05 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 0x10e045a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0da618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe439570eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa9d30>, '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 0x10dd0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa1b20>, '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.Q4wsyPIoCt/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.NjwraM89de/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 18:59:05 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 18:59:05 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 18:59:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q4wsyPIoCt/Render', 18:59:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:05 INFO - 'HOME': '/Users/cltbld', 18:59:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:05 INFO - 'LOGNAME': 'cltbld', 18:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:05 INFO - 'MOZ_NO_REMOTE': '1', 18:59:05 INFO - 'NO_EM_RESTART': '1', 18:59:05 INFO - 'PAGER': '/bin/cat', 18:59:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:05 INFO - 'PWD': '/builds/slave/test', 18:59:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:05 INFO - 'SHELL': '/bin/bash', 18:59:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NjwraM89de/Listeners', 18:59:05 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 18:59:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:05 INFO - 'USER': 'cltbld', 18:59:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:05 INFO - 'XPC_FLAGS': '0x0', 18:59:05 INFO - 'XPC_SERVICE_NAME': '0', 18:59:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:59:05 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-VcXFG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:59:05 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-WwY0Vk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:59:06 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-2kOZsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:59:06 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-eb0HsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:59:06 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-N3l_NO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:59:06 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-U2tfVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:59:06 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-kBvp2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:59:06 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-ky216d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:59:06 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-dDl9Qx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:59:06 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-37LhHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:59:06 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-Bn7In0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:59:06 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-ESO8UV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:59:07 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-aJwdm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:59:07 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-YXFmoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:07 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-AYhfjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:59:07 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-H9P8S3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:59:07 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-zSHHJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:59:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:59:07 INFO - Running setup.py install for manifestparser 18:59:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:59:07 INFO - Running setup.py install for mozcrash 18:59:07 INFO - Running setup.py install for mozdebug 18:59:08 INFO - Running setup.py install for mozdevice 18:59:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:59:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:59:08 INFO - Running setup.py install for mozfile 18:59:08 INFO - Running setup.py install for mozhttpd 18:59:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:59:08 INFO - Running setup.py install for mozinfo 18:59:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:59:08 INFO - Running setup.py install for mozInstall 18:59:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:59:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:59:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:59:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:59:08 INFO - Running setup.py install for mozleak 18:59:08 INFO - Running setup.py install for mozlog 18:59:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:59:09 INFO - Running setup.py install for moznetwork 18:59:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:59:09 INFO - Running setup.py install for mozprocess 18:59:09 INFO - Running setup.py install for mozprofile 18:59:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:59:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:59:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:59:09 INFO - Running setup.py install for mozrunner 18:59:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:59:09 INFO - Running setup.py install for mozscreenshot 18:59:09 INFO - Running setup.py install for moztest 18:59:10 INFO - Running setup.py install for mozversion 18:59:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:59:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:59:10 INFO - Cleaning up... 18:59:10 INFO - Return code: 0 18:59:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:10 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 0x10e045a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0da618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe439570eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa9d30>, '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 0x10dd0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa1b20>, '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.Q4wsyPIoCt/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.NjwraM89de/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 18:59:10 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 18:59:10 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 18:59:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q4wsyPIoCt/Render', 18:59:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:10 INFO - 'HOME': '/Users/cltbld', 18:59:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:10 INFO - 'LOGNAME': 'cltbld', 18:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:10 INFO - 'MOZ_NO_REMOTE': '1', 18:59:10 INFO - 'NO_EM_RESTART': '1', 18:59:10 INFO - 'PAGER': '/bin/cat', 18:59:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:10 INFO - 'PWD': '/builds/slave/test', 18:59:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:10 INFO - 'SHELL': '/bin/bash', 18:59:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NjwraM89de/Listeners', 18:59:10 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 18:59:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:10 INFO - 'USER': 'cltbld', 18:59:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:10 INFO - 'XPC_FLAGS': '0x0', 18:59:10 INFO - 'XPC_SERVICE_NAME': '0', 18:59:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:59:10 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-UuShE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:59:10 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)) 18:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:59:10 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-WljIG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:59:10 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)) 18:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:59:10 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-wh1X62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:59:10 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)) 18:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:59:10 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-rj8dwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:59:10 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)) 18:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:59:10 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-0TGzmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:59:10 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)) 18:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:59:10 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-5GRBWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:59:11 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)) 18:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:59:11 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-sizo4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:59:11 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)) 18:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:59:11 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-gSk6FF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:59:11 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)) 18:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:59:11 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-u5pDoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:59:11 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)) 18:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:59:11 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-f3egdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:59:11 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)) 18:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:59:11 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-5e5bQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:59:11 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)) 18:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:59:11 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-Nq9IZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:59:11 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)) 18:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:59:11 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-6BvbSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:59:11 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)) 18:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:59:11 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-WuyJzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:59:11 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)) 18:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:11 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-mY6tTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:12 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)) 18:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:59:12 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-qT3hTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:59:12 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)) 18:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:59:12 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-YI8Hz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:59:12 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)) 18:59:12 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)) 18:59:12 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)) 18:59:12 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)) 18:59:12 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)) 18:59:12 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)) 18:59:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 18:59:14 INFO - Downloading blessings-1.6.tar.gz 18:59:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:59:14 INFO - Installing collected packages: blessings 18:59:14 INFO - Running setup.py install for blessings 18:59:14 INFO - Successfully installed blessings 18:59:14 INFO - Cleaning up... 18:59:15 INFO - Return code: 0 18:59:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:59:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:59:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:59:15 INFO - Reading from file tmpfile_stdout 18:59:15 INFO - Current package versions: 18:59:15 INFO - blessings == 1.6 18:59:15 INFO - blobuploader == 1.2.4 18:59:15 INFO - docopt == 0.6.1 18:59:15 INFO - functools32 == 3.2.3-2 18:59:15 INFO - jsonschema == 2.5.1 18:59:15 INFO - manifestparser == 1.1 18:59:15 INFO - mozInstall == 1.12 18:59:15 INFO - mozcrash == 0.17 18:59:15 INFO - mozdebug == 0.1 18:59:15 INFO - mozdevice == 0.48 18:59:15 INFO - mozfile == 1.2 18:59:15 INFO - mozhttpd == 0.7 18:59:15 INFO - mozinfo == 0.9 18:59:15 INFO - mozleak == 0.1 18:59:15 INFO - mozlog == 3.3 18:59:15 INFO - moznetwork == 0.27 18:59:15 INFO - mozprocess == 0.23 18:59:15 INFO - mozprofile == 0.28 18:59:15 INFO - mozrunner == 6.12 18:59:15 INFO - mozscreenshot == 0.1 18:59:15 INFO - mozsystemmonitor == 0.3 18:59:15 INFO - moztest == 0.7 18:59:15 INFO - mozversion == 1.4 18:59:15 INFO - psutil == 3.1.1 18:59:15 INFO - requests == 1.2.3 18:59:15 INFO - wsgiref == 0.1.2 18:59:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:59: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')]} 18:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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')]} 18:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:15 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 0x10e045a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0da618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe439570eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa9d30>, '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 0x10dd0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa1b20>, '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.Q4wsyPIoCt/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.NjwraM89de/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 18:59:15 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 18:59:15 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 18:59:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q4wsyPIoCt/Render', 18:59:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:15 INFO - 'HOME': '/Users/cltbld', 18:59:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:15 INFO - 'LOGNAME': 'cltbld', 18:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:15 INFO - 'MOZ_NO_REMOTE': '1', 18:59:15 INFO - 'NO_EM_RESTART': '1', 18:59:15 INFO - 'PAGER': '/bin/cat', 18:59:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:15 INFO - 'PWD': '/builds/slave/test', 18:59:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:15 INFO - 'SHELL': '/bin/bash', 18:59:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NjwraM89de/Listeners', 18:59:15 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 18:59:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:15 INFO - 'USER': 'cltbld', 18:59:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:15 INFO - 'XPC_FLAGS': '0x0', 18:59:15 INFO - 'XPC_SERVICE_NAME': '0', 18:59:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:15 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)) 18:59:15 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)) 18:59:15 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)) 18:59:15 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)) 18:59:15 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)) 18:59:15 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)) 18:59:15 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)) 18:59:15 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)) 18:59:15 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)) 18:59:15 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)) 18:59:15 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)) 18:59:15 INFO - Cleaning up... 18:59:15 INFO - Return code: 0 18:59:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:59: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')]} 18:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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')]} 18:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e045a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0da618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe439570eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa9d30>, '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 0x10dd0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa1b20>, '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.Q4wsyPIoCt/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.NjwraM89de/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 18:59: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'] in /builds/slave/test/build 18:59: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 18:59:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q4wsyPIoCt/Render', 18:59:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:15 INFO - 'HOME': '/Users/cltbld', 18:59:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:15 INFO - 'LOGNAME': 'cltbld', 18:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:15 INFO - 'MOZ_NO_REMOTE': '1', 18:59:15 INFO - 'NO_EM_RESTART': '1', 18:59:15 INFO - 'PAGER': '/bin/cat', 18:59:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:15 INFO - 'PWD': '/builds/slave/test', 18:59:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:15 INFO - 'SHELL': '/bin/bash', 18:59:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NjwraM89de/Listeners', 18:59:15 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 18:59:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:15 INFO - 'USER': 'cltbld', 18:59:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:15 INFO - 'XPC_FLAGS': '0x0', 18:59:15 INFO - 'XPC_SERVICE_NAME': '0', 18:59:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:59:15 INFO - Cleaning up... 18:59:15 INFO - Return code: 0 18:59:15 INFO - Running post-action listener: _resource_record_post_action 18:59:15 INFO - Running post-action listener: _start_resource_monitoring 18:59:15 INFO - Starting resource monitoring. 18:59:15 INFO - [mozharness: 2016-08-19 01:59:15.883760Z] Finished create-virtualenv step (success) 18:59:15 INFO - [mozharness: 2016-08-19 01:59:15.884701Z] Running install step. 18:59:15 INFO - Running pre-action listener: _resource_record_pre_action 18:59:15 INFO - Running main action method: install 18:59:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:59:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:59:16 INFO - Reading from file tmpfile_stdout 18:59:16 INFO - Detecting whether we're running mozinstall >=1.0... 18:59:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:59:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:59:16 INFO - Reading from file tmpfile_stdout 18:59:16 INFO - Output received: 18:59:16 INFO - Usage: mozinstall [options] installer 18:59:16 INFO - Options: 18:59:16 INFO - -h, --help show this help message and exit 18:59:16 INFO - -d DEST, --destination=DEST 18:59:16 INFO - Directory to install application into. [default: 18:59:16 INFO - "/builds/slave/test"] 18:59:16 INFO - --app=APP Application being installed. [default: firefox] 18:59:16 INFO - mkdir: /builds/slave/test/build/application 18:59:16 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'] 18:59:16 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 18:59:50 INFO - Reading from file tmpfile_stdout 18:59:50 INFO - Output received: 18:59:50 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:59:50 INFO - Running post-action listener: _resource_record_post_action 18:59:50 INFO - [mozharness: 2016-08-19 01:59:50.304438Z] Finished install step (success) 18:59:50 INFO - [mozharness: 2016-08-19 01:59:50.304570Z] Running run-tests step. 18:59:50 INFO - Running pre-action listener: _resource_record_pre_action 18:59:50 INFO - Running main action method: run_tests 18:59:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:59:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:59:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:59:50 INFO - 2016-08-18 18:59:50.319 screenresolution[1648:7436] starting screenresolution argv=screenresolution get 18:59:50 INFO - 2016-08-18 18:59:50.321 screenresolution[1648:7436] Display 0: 1600x1200x32@60 18:59:50 INFO - 2016-08-18 18:59:50.328 screenresolution[1649:7438] starting screenresolution argv=screenresolution list 18:59:50 INFO - Available Modes on Display 0 18:59:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:59:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:59:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:59:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:59:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:59:50 INFO - Intel Iris: 18:59:50 INFO - Chipset Model: Intel Iris 18:59:50 INFO - Type: GPU 18:59:50 INFO - Bus: Built-In 18:59:50 INFO - VRAM (Dynamic, Max): 1536 MB 18:59:50 INFO - Vendor: Intel (0x8086) 18:59:50 INFO - Device ID: 0x0a2e 18:59:50 INFO - Revision ID: 0x0009 18:59:50 INFO - Displays: 18:59:50 INFO - Display: 18:59:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:59:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:59:50 INFO - Display Serial Number: 1600x1200 60 18:59:50 INFO - Main Display: Yes 18:59:50 INFO - Mirror: Off 18:59:50 INFO - Online: Yes 18:59:50 INFO - Rotation: Supported 18:59:50 INFO - Return code: 0 18:59:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:59:50 INFO - Python 2.7.3 18:59:50 INFO - Return code: 0 18:59:50 INFO - grabbing minidump binary from tooltool 18:59: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')]} 18:59:50 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 0x10dfa9d30>, '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 0x10dd0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfa1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:59:50 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 18:59:50 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 18:59:50 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 18:59:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:59:50 INFO - Return code: 0 18:59:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:59:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:59:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:59:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:59:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:59:50 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/Y3t-DEPxT2OQRUstt15QLQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0390', '--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 18:59:50 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/Y3t-DEPxT2OQRUstt15QLQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0390 --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 18:59:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q4wsyPIoCt/Render', 18:59:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:50 INFO - 'HOME': '/Users/cltbld', 18:59:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:50 INFO - 'LOGNAME': 'cltbld', 18:59:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:59:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:50 INFO - 'MOZ_NO_REMOTE': '1', 18:59:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:59:50 INFO - 'NO_EM_RESTART': '1', 18:59:50 INFO - 'PAGER': '/bin/cat', 18:59:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:50 INFO - 'PWD': '/builds/slave/test', 18:59:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:59:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:50 INFO - 'SHELL': '/bin/bash', 18:59:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NjwraM89de/Listeners', 18:59:50 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 18:59:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:50 INFO - 'USER': 'cltbld', 18:59:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:50 INFO - 'XPC_FLAGS': '0x0', 18:59:50 INFO - 'XPC_SERVICE_NAME': '0', 18:59:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:50 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/Y3t-DEPxT2OQRUstt15QLQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0390', '--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 18:59:50 INFO - mozversion application_buildid: 20160818161755 18:59:50 INFO - mozversion application_changeset: cf06fbc831754e54c6abb71d3136597488a530e0 18:59:50 INFO - mozversion application_display_name: Nightly 18:59:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:59:50 INFO - mozversion application_name: Firefox 18:59:50 INFO - mozversion application_remotingname: firefox 18:59:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:59:50 INFO - mozversion application_vendor: Mozilla 18:59:50 INFO - mozversion application_version: 51.0a1 18:59:50 INFO - mozversion platform_buildid: 20160818161755 18:59:50 INFO - mozversion platform_changeset: cf06fbc831754e54c6abb71d3136597488a530e0 18:59:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:59:50 INFO - mozversion platform_version: 51.0a1 18:59:50 INFO - using testdate: 1471571990 18:59:50 INFO - actual date: 1471571990 18:59:50 INFO - starting webserver on 'localhost:49262' 18:59:50 INFO - SUITE-START | Running 2 tests 18:59:50 INFO - TEST-START | dromaeo_css 18:59:50 INFO - operating with platform_type : mac_ 18:59:50 INFO - Initialising browser for dromaeo_css test... 18:59:50 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmp6ytC4k/profile http://localhost:49262/getInfo.html) 18:59:53 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 18:59:53 INFO - PROCESS | 1659 | colorDepth:24 18:59:53 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 18:59:53 INFO - PROCESS | 1659 | __metrics 18:59:53 ERROR - PROCESS | 1659 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 18:59:54 INFO - TEST-INFO | 1659: exit 0 18:59:54 INFO - Browser initialized. 18:59:54 INFO - Running cycle 1/1 for dromaeo_css test... 18:59:54 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmp6ytC4k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:00:06 INFO - PROCESS | 1662 | RSS: Main: 239616000 19:00:06 INFO - PROCESS | 1662 | 19:00:56 INFO - PROCESS | 1662 | 1471572056150 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:03:07 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49262/tests/dromaeo/cssquery-ext.html) 19:03:09 INFO - PROCESS | 1662 | RSS: Main: 254328832 19:03:09 INFO - PROCESS | 1662 | 19:06:11 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-ext.html (next: http://localhost:49262/tests/dromaeo/cssquery-jquery.html) 19:06:12 INFO - PROCESS | 1662 | RSS: Main: 266403840 19:06:12 INFO - PROCESS | 1662 | 19:09:14 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49262/tests/dromaeo/cssquery-mootools.html) 19:09:14 INFO - PROCESS | 1662 | RSS: Main: 271085568 19:09:14 INFO - PROCESS | 1662 | 19:12:16 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49262/tests/dromaeo/cssquery-prototype.html) 19:12:17 INFO - PROCESS | 1662 | RSS: Main: 270909440 19:12:17 INFO - PROCESS | 1662 | 19:15:19 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49262/tests/dromaeo/cssquery-yui.html) 19:15:20 INFO - PROCESS | 1662 | RSS: Main: 276766720 19:15:20 INFO - PROCESS | 1662 | 19:18:23 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-yui.html (next: http://localhost:49262/tests/dromaeo/cssquery-dojo.html) 19:18:23 INFO - PROCESS | 1662 | RSS: Main: 279142400 19:18:23 INFO - PROCESS | 1662 | 19:18:23 INFO - PROCESS | 1662 | __start_tp_report 19:18:23 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 19:18:23 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 19:18:23 INFO - PROCESS | 1662 | |i|pagename|runs| 19:18:23 INFO - PROCESS | 1662 | |0;dojo.html;3021.833799141047;3255.625603055648;3448.5172075909377;3454.896353109406;3455.9136021599475;4696.248600223965;5237.135872581024;5761.107028410593;5794.855128621786;5822.243108395914;4149.83400663973;5328.786848526064;5823.941760582404;5830.82507524775;5899.970500147493;5267.420583735796;5312.415634280226;5379.220013098098;5405.081136206834;5466.34403871536;5213.374395072597;5250.8687282817855;5364.785408583652;5366.624336296461;5387.757550910199;5281.128613778722;5314.840554783344;5330.760115794798;5344.225087362311;5346.6524675896335;5303.416624171338;5323.467653234684;5326.973365133188;5341.985022845685;5402.91895621566;5141.562967147797;5210.817621383271;5314.0700377433795;5318.1225097858805;5356.517913387775;4488.865334039951;5782.56630752691;5844.853878653025;5851.385604511507;5914.556408269354;6289.905651415233;6319.873602527924;6327.683615819236;6341.080543321239;6383.39357761012;6248.625082495065;6295.968520157416;6355.396237357444;6355.586886852339;6365.713542890581;4742.383490146293;5896.410358964069;5905.704714764331;5936.465718085393;5961.8807623847715;6325.715342809584;6362.141110950055;6374.808755737336;6396.5202609804455;6416.903746443807;5790.61025353912;6125.724342404603;6267.4986001119805;6296.590721603081;6303.6217826929615;5242.554382877422;5519.806806761744;6349.396807303298;6350.0792385103905;6353.555251132377;4680.976595117071;4865.416150061945;5203.19350500673;5585.9107474042985;6284.685765711696;4737.38414006177;5956.52347812174;6153.230846144232;6366.236051673736;6366.745330186741;4211.957880421218;4221;4405.471343438744;4470.2177119004045;4962.950370496321;4465.151621191963;4467.642588592905;4478.41780568524;4481.775911204492;4490.438695163105;4706.811727530929;4934.950650493521;5016.2224855147515;6002.249718785152;6023.765128148719;4954.331165292711;6299.716512756937;6301.306856245809;6313;6336.89104406727;4597.287420449836;5367.731613419313;5918.467337939606;6067.969660151671;6083.209182806207;5398.13629819227;5454.072807622713;5456.727163641802;5512.173174023848;5538.280023596906;6367.522435817332;6479.708413121421;6489.610623362708;6507.609543427409;6530.47756179495;6290.654014029273;6312.621242725451;6313.589616674902;6340.556161068681;6415.58298710601;6290.779822706183;6424.4860411166055;6472.320406357453;6482.740690372332;6483.675816209265;6245.812625621057;6246.750129994749;6297;6310.5898116622275;6343;6338.207724034496;6341.746330146742;6344.619322840645;6347.365263473615;6371.904421433775;6043.607165534227;6074.058520929263;6098.976888192089;6180.907286390798;6259.280182778856;6144.03390914903;6244.625322480666;6249.812505624838;6252.187215661935;6291.402316779899;5937.025796661477;6022.759089636541;6100.298465676504;6144.078388241799;6171.1668924694595;6075.939240607538;6146.200993870768;6270.968645156745;6280.340564240689;6281.277653069956;5805.767769289181;5839.708014599338;5873.324567674601;5885.205497257815;5889.146073819358 19:18:23 INFO - PROCESS | 1662 | |1;ext.html;434.9739015659061;478.7127723365981;520.7553946068895;531.4897698209719;572.9054705973515;38649;41130.58869411305;41310.79344603277;41371;41499;42186.578134218646;42768.786156069174;42775;42809;42876.57123428772;9570.042995700443;9746.951265243699;9754.365966212174;9768.023197680246;9771.462569558671;9609.80780384392;9670.468124253162;9694.272929530278;9698.709038728814;9701.805963880719;9706.951465242664;9717.125458708715;9726.562304696306;9731.75670608237;9754.951225243864;8996.640134394616;9649;9688.46713430761;9689.90310096897;9729.124378805942;7378.926210737931;9245.167934885825;9643.951780241125;9657.71026869195;9683.661071862522;32994.67005329964;39368.62209822643;40054.79972600118;40199;40288.59711402878;3565.625609311011;3590.5152804371337;3605.9098522536883;3692.538432695913;4041.8787436376956;30980.0705978821;31576.210594735086;32151.83924080388;32184.678153218403;32300;3290.7038366546885;3366.360391525602;3388.3731509670542;3446.327966046622;3454.5509083818943;514257;519222;524823;526899;527465;63346;63613.68193159004;63718.72562548723;63749.36250637527;63897.04154437687;65647.67176164089;65712;66097.66951165213;66257.6687116571;66600.6669966647;16438.095904725356;16698.499045028668;16720.08039557836;16758.832411675972;16800.24398902028;12806.743865122646;12816;12878;12933.676658083436;12933.965282777355;15537.84462155364;15832.129232892301;17587.73618395725;17780.46658600244;17818.821811781974;5496.038193316153;6567.376099270562;6782.93217067823;7189.388901943394;7216.8917466238045;809.951402915827;936.6253498600614;992.4640694025146;1022.3870948492869;1043.2540733375672;30587.388252234832;31132;31621;31942.361152776815;32485.5381507828;1000.6197644895038;1064.5103252503934;1083.631565267797;1153.7404084081015;1182.066167727503;15952.601184970468;15954.28205730745;15989.440369587008;16077.919610402107;16337.101459419608;714532;719648;721099;721671;725046;62019;62136;62482.68758656178;62510.68744656248;62829.371706283266;1353.2557093598482;1368.5962641020724;1410.2173293822232;1413.7596608576566;1417.1709549913417;29707.702922970493;30853.69146308508;31042.68957310398;31508.849115089226;31582.842085789423;52191;52959.73520132375;53178.543394679225;53209.733951329996;53358.93282134413;445570.7721461372;445635.7718211388;445963.77018116;446108;447950;27253;27679.861600691867;27780.305492362044;27787.888484460396;27842.860785695942;48448;48929.5107048925;49122.75438622784;49508.762280943265;50358;38645.806770965966;39282.60717392789;40945.952702364164;42103.7894810524;42177.78911105425;41113.97215069647;41270;41340.08151565384;41618.95952601088;41660.16679666329;32794;37210.06974825651;39064.023399415244;39541.40687889742;40858.591414086666;35435.29129417449;36375.63624363722;36460.45309320309;36738.38528186175;37112.88661340164;23223.767762322837;26512.337191570365;26542.5401602906;26661.200163995112;26684.332891677863 19:18:23 INFO - PROCESS | 1662 | |2;jquery.html;361.9746617736758;374.6590602551678;375.92293579816123;377.5054678371333;390.2818813383374;16232.756508652365;19733.63440172648;20700.792992070114;21309.041093150827;21552.784472155272;20369.4907627309;20498.282560110398;20902.37292881212;20904;21379.25172618959;5380.300560927074;5960.135780311853;6144.692765361714;6212.65830379329;6221.688915554227;6094.238220222473;6172.506199504029;6206.813795586117;6211.378862113797;6211.90682139766;5917.852053698649;6058.515318774509;6155.415235552616;6183.1034499997695;6192.349803270659;5889.293284805808;6098.14625952367;6124.663143527104;6127.877442451148;6154.984427569446;5999.490043346321;6040.214772079602;6096.573239873211;6135.447809697104;6160.691965401712;13192.6701832454;13413.731725365438;13456.327183640877;13578.25319607431;13799.172049677052;2138.518833262519;2340.2277248507953;2345.82406319525;2584.7286034966432;2693.2862791360303;9615.375000624937;10122.1657885949;10201.642942497052;10306.89693103067;10649;1814.355903654197;1898.6107847891149;1937.8740381875134;1947.0751393088312;1962.1464662871554;123146;136527;137274.31362843222;137315;137865.310673446;11294;11611;11620.302781832948;11764.294142351486;11813.704657383461;14379.496717614833;14512.274386280855;14513.637159071108;14536.418543258364;14554.563363099123;8368.958155209306;8500.702475413455;8507.829843403097;8555.443896146731;8647.827043459096;6943.444524438033;8415.747527574182;8536.573171341408;8540.74377768668;8668.356151373891;4481.641468682497;4486.842960496367;4506.436695413074;4532.410786597788;4604.7927843247135;1905.266472408105;1948.1622902151928;1952.863299569045;1953.4139758072522;1956.090417955629;775.3138472451808;782.9295363417319;872.7432497204132;940.9555393513195;1006.9345492542961;16962.660746784994;20701.58596828055;21691.240806571695;21751.67372489414;21883.562328753655;885.420049867338;921.9400738951947;953.3183773601769;955.81361634482;976.8437050071955;10279;10871.891281087246;11585;11657.883421165849;11671.649850504498;598774.0183897245;610127;610537;634879;638689;76458.2354176451;130906;133767;141891;142709;968.3463662028103;985.6353149334792;987.7530617345664;994.9205112453069;1002.4386343647435;18864.33974810875;19145.32991345352;19390.127444265323;19445.51386215356;19463.513412164244;45889.54110458853;54477.09330173425;59535.70232148811;60093;60246.28891699796;73980;84712.15287847289;85197;86536;88142.55928720316;7970.322522585645;8071.959640201996;8200.05699344559;8259.256666900008;8387.664493420194;9804.950975245078;10931.945340273247;12697.301648409426;13010.544630937871;13102.606921792361;10596.993285637853;10622.628208012682;10749.731256718645;11291.378974156172;11493.770124597628;8459.83080338402;10104.747381315527;10699.14406847466;11075.380497742903;11378.943105284421;7349.595772232578;10043.497825108861;11039.558417663204;11193.608223712132;11251.7749645005;8044.758657240292;8053.1946805319;8212.58937053133;8222.465539739898;8420.15798420153;8053.31546818527;10726.410047447465;10937.83593246118;10960.506777195205;11598.94200528992 19:18:23 INFO - PROCESS | 1662 | |3;mootools.html;1487.9330430130647;1529.0137861079604;1554.4559404208535;1719.7678313427691;1845.6124213915068;7733.917251584782;7837.177096404881;8312.625931833067;8479.703210387637;8567.871481927768;7152.320529549697;8665.436746611482;8697.739067827975;8706.3905526613;8715.651373945035;1944.6888497840348;2313.479467119897;2357.95284094318;2362.3031205794246;2364.538914911593;2323.453988312745;2346.8239882008834;2371.8339716219784;2384.7615238476187;2391.0913852735935;2361.445060410802;2374.442006128558;2374.5488357212075;2388.164142550102;2395.6047252203366;2298.494331247123;2339.251439539348;2347.730011048726;2348.7686697637314;2378.8096952243777;2352.788249057593;2362.11420717231;2366.7396586375485;2367.893444794988;2368.2539999899977;8688.261497772697;8832.779180520474;8836.204741573225;8854.601542930584;8868.02451730309;5156.561692256163;5174.068667639824;5198.948010519922;5300.681959082467;5321.973390133063;2938.44169607776;3559.804210768407;3582.6954708849516;3605.441156620728;3620.945685814715;1029.4543891737317;1068.8663917010374;1083.101026148303;1087.12486448409;1093.240198062347;10195.4392508412;11613.361265130414;11726.061915046861;11729;11740.178187526877;4534.750588717652;4632.513586073481;4794.256890182028;4809.927851082237;4811.109944660179;9835.901640983642;9941.204703623838;9951.900480995242;9960.302778805413;9968.950155249177;5342.679439233659;5359.892802144013;5361.8123365682795;5367.087595108841;5370.865728356823;3673.3387990162028;4744.169770290186;4872.3909511311085;4931.334269873521;4952.5542701157065;3892.630200130983;3914.745541539791;3921.3725803871243;4013.4381186633896;4036.6972477064337;1096.2490693874722;1259.4647274908127;1298.0978220137104;1298.1886321049344;1316.085320702122;840.9152193670219;861.6940985950023;907.2605826251715;908.6183802802839;928.9767755806024;5709.457601527848;5799.594028417971;5911.728978269607;6069.484093851984;6132.6933653317155;844.8859403980507;951.6336210558985;956.168133723651;970.9757256068655;1006.094514936563;3960.2277555876326;3987.7208595398624;4011.478507793968;4031.4759081319826;4081.1837632473625;8481.279091277187;10298.382097074049;10733.302335348177;10758.515866786014;10773.461326933622;7735.883961740578;10528.368297901998;10575.20685948557;10660.360378377321;10760.677179684622;6839.452843772487;8064.959675201587;8216.507009579325;8282.958585207036;8304.252617264354;5387;5795.94204057954;5910.7931222407005;6086.452219300284;6189.659568723763;8318.667253310043;8623.611937462954;9788.874279457954;9974.700758977242;10024.047715467019;9888.653897113567;10162.491875406347;10165.695029149138;10166.796664066826;10256.128229100312;6919.930800691928;7317.597532135784;7434.925650743639;7487.588182650006;7622.16156222804;8351.164883511843;8451.8732219018;8505.91494085076;8523.91476085256;8534.615942282488;6300.873982520416;7438.442116841366;7558.886616700864;7690.077190737147;7717.845643086995;7214;7365.926340736524;7418.851622967619;7421.925780742339;7447.5531468112085;6348.269948955929;6721.630310332783;6929.965350173217;6959.7216111357;7024.192217895007;4643.326717625993;5043.193089105725;5044.722540260321;5078.466760990191;5135.05001574695;4312.482502099768;5063.468335824833;5065.924011139762;5128.487151284841;5135.6918584885025 19:18:23 INFO - PROCESS | 1662 | |4;prototype.html;301.520582274184;306.199288859632;312.6404634670129;315.66854802457414;318.4300102815958;5432.375276843164;5518.889622207554;5595.440455954407;5685.431456854318;5713.5143512801405;4738.360321356616;5556.416576259495;5590.133529302954;5624.943750562493;5664.830055098354;3523.5947865995354;3772;4199.7690127043;4312.792418122931;4317.978410107945;3470.3406352793013;4144.611555129035;4226.519888917742;4304.935425968597;4335.1979883721615;4172.769033135232;4186.697316475941;4187.7277976931555;4201.180769749884;4204.726692764976;3586.4799604057525;4205.780323706122;4216.894577635569;4220.85227017053;4262.637675797561;3659.6157403472516;3660.816959152032;3664.212194378195;3672.9632703672887;3677.9080522986874;4527.547245275479;5138.229265610151;5266.7366631668265;5446.700431476267;5450.656217826333;4904.852854414337;4918.311436398907;4932.235503496964;4941.20940649498;4970.378702662168;5638.577106717013;5969.940300597025;5970.552208584373;5982.73077711504;6018.21763170785;3549.982250088759;3996.18078293949;4030.2342554914767;4042.2319759245647;4074.979625101885;6192.049504406143;6193.225846769154;6212.254529456449;6266.78066267683;6299.464545513637;3938.8030598469963;4087.550369459357;4105.322621767435;4116.320807066801;4130.938035929404;3316.5522654441825;4143.881152088919;4164.1879833432795;4165.770882601425;4171.20747058058;4461.4569695273385;4885.926711099336;4894.681845680019;4907.411110666742;4918.606511479073;5509.449055094458;5692.719138193873;5834.329052159056;5970.194023806817;6045.818625441244;1382.9515966941108;1387.2924808347816;1422.8434872164053;1424.7391058912729;1429.399652146101;808.4462143431768;845.8308338332358;855.9657613695507;875.1665261277614;876.4259410086404;4406.735595864258;4673.439187297478;4782.95217047832;4788.467690339058;4790.784414701347;4133.648639865585;4568.840090596813;4630.606398456169;5033.874153146201;5174.558918319351;4046.2109888571445;4111.794410279534;4217.599328063829;4750.406199225097;4791.915516750225;2342.906283748631;2391.4725779475134;2408.9759102409103;2422;2686.200245835295;4367.606915377632;4739.857804265877;5300.946990530046;5328.653637513549;5361.79359644077;4360.05696155094;4750.382450281441;5061.240813877947;5262.60530460217;5270.868228294324;4700.989287303246;4716.339712440261;4824.228123500223;5243.292155559027;5271.288376069181;4458.175237581057;4777.757782976381;4918.778654960463;5149;5175.92236116451;3689.741718079816;4250.426192464101;4749.928751068667;5140.794368225229;5155.2782610435315;4574.232589283436;4629.95825939161;4828.782704778364;5305.734713264244;5315;3287.391832510993;3546.680798728127;3841.1357444575865;3849.844087311115;3962.722609417313;4800.639952003544;5077.060743762416;5987.491063259672;6035.6076855004285;6038.9396106038375;5510.173473978935;5584.268876648252;5847.327557330791;5903.483834866416;5905.379935106752;5337.57299416038;5579.609427340048;5816.680082595498;5855.3266374367495;5861.238039054895;4794.568488836021;5044.319016932667;5732.254806875079;5739.24079727779;5744.396838331915;4970.9254361183885;5658.783361577281;5798.333191682842;5868.970655146697;5880.882382352243;4400.493943196573;5447.64590301645;5554.611177217556;5556.527695145958;5589.776408943597 19:18:23 INFO - PROCESS | 1662 | |5;yui.html;682.6245564939285;736.4660621049738;763.1147868472573;782.8747400415934;812.991870081299;15411.845881541181;16386.50840474785;16428.83571164288;16469.341226350945;16472.752908706378;14756.926215368934;14872.405103795834;14887.25563721815;14895.404183832661;14943.551693449186;596.3648714119471;662.6156829039157;819.9262066414021;834.7078522517131;855.3670283989834;823.259066839843;838.9412741108125;845.6110189312924;849.6856163219618;850.3792231670884;884.3102380143498;889.5418859287472;890.5502721125822;892.6429428228728;893.4549924546021;879.4283715584857;885.4200498673347;888.564603344363;889.884315039044;891.6700820696319;655.203927228415;664.8603793203384;666.3569655282627;666.6000399760154;667.8897981832991;14665.926670366687;14749.77875331871;14770.26148692561;14770.630734231623;14806.555803325917;14566.344514496874;14615.415383384652;14624.488142914946;14691.485797997126;14756.48352307664;11933.641990740292;12108.939455302667;12349.5060197592;12367.196132251374;12493.18794278369;3528.606200550768;3844.6539811417106;4028.7784171870535;4077.3883917412327;4077.7145599808027;89920;93374;102787.97212027859;125465;126070.36964815209;10080.689510363605;10524.631637892637;10979.28634638746;11145.275557088764;11599.362035087983;23104.4223894404;23132.190373337187;23161.536769264858;23166.3050108497;23213.071477140726;7891.921080789233;7939.166387529226;8055.033395992401;8158.918410815934;8215.465994710325;4463.687541872103;4564.497905230422;4609.631229501631;4631.235846085426;4727.57451829337;3133.827639479805;3516.8065756383135;3527.8059706716376;3610.7833529988284;3615.680276698986;621.3910367839543;626.8307556959595;631.643121636274;635.9300476947532;647.8121344810047;494.21173228700167;571.8084441712073;587.7707693999344;597.9760809567568;663.4559661077966;8862.20240178387;9254.583543740548;9397.154256116983;9404.012578679278;9502.144806967406;583.5069366385397;613.187526527353;636.4558302651259;647.970841312142;665.3413121010165;4338.674599405057;4385.0133719912765;4614.97692511542;4632.821606606939;4680.110778951988;86388;124452;128403;128562.35718821346;143709.88061671375;94503;106126.93873061326;106905.8618827619;126627;130738;76880.84678729823;78321;96483.9999999986;112891.43554282175;115748;9481.383710058824;9766.267529935141;9799.755006124904;9875.506224688881;9879.901200987899;63226.735465289516;63844.042339364016;64258;64855.37861553499;65642.67178664076;93032.53483732538;94122;94201.05798941923;94322;96881.51559242158;12898.48406063747;12989.805152922903;13083.934580327037;13162.670933226746;13329.400176992252;14459.566213013626;14746.63133421673;14782.260886955824;14850.331735072165;15104.848951510345;13476.427142942035;13681.384337705027;13730.382132803848;13887.388570381128;14183.14901105937;13379.53171638988;13440.728907585393;13632.454701811816;13746.175229486264;13851.722965540432;13454.646533837678;13461.596152115451;13753.931230343784;13771;14038.929805351316;10936.289141205796;11261.211715180187;11406.429678515875;11437.542498299976;11497.885021149681;7633.091727068233;9535.38020028696;10065.483629092727;10348.741281468023;11684.18210725241 19:18:23 INFO - PROCESS | 1662 | __end_tp_report 19:18:23 INFO - PROCESS | 1662 | __start_cc_report 19:18:23 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,411 19:18:23 INFO - PROCESS | 1662 | __end_cc_report 19:18:23 INFO - PROCESS | 1662 | __startTimestamp1471573103495__endTimestamp 19:18:23 INFO - PROCESS | 1662 | 19:18:23 INFO - PROCESS | 1662 | ------- Summary: start ------- 19:18:23 INFO - PROCESS | 1662 | Number of tests: 6 19:18:23 INFO - PROCESS | 1662 | 19:18:23 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5704.40 Median:5918.47 stddev:740.68 (12.5%) stddev-sans-first:712.43 19:18:23 INFO - PROCESS | 1662 | Values: 3021.8 3255.6 3448.5 3454.9 3455.9 4696.2 5237.1 5761.1 5794.9 5822.2 4149.8 5328.8 5823.9 5830.8 5900.0 5267.4 5312.4 5379.2 5405.1 5466.3 5213.4 5250.9 5364.8 5366.6 5387.8 5281.1 5314.8 5330.8 5344.2 5346.7 5303.4 5323.5 5327.0 5342.0 5402.9 5141.6 5210.8 5314.1 5318.1 5356.5 4488.9 5782.6 5844.9 5851.4 5914.6 6289.9 6319.9 6327.7 6341.1 6383.4 6248.6 6296.0 6355.4 6355.6 6365.7 4742.4 5896.4 5905.7 5936.5 5961.9 6325.7 6362.1 6374.8 6396.5 6416.9 5790.6 6125.7 6267.5 6296.6 6303.6 5242.6 5519.8 6349.4 6350.1 6353.6 4681.0 4865.4 5203.2 5585.9 6284.7 4737.4 5956.5 6153.2 6366.2 6366.7 4212.0 4221.0 4405.5 4470.2 4963.0 4465.2 4467.6 4478.4 4481.8 4490.4 4706.8 4935.0 5016.2 6002.2 6023.8 4954.3 6299.7 6301.3 6313.0 6336.9 4597.3 5367.7 5918.5 6068.0 6083.2 5398.1 5454.1 5456.7 5512.2 5538.3 6367.5 6479.7 6489.6 6507.6 6530.5 6290.7 6312.6 6313.6 6340.6 6415.6 6290.8 6424.5 6472.3 6482.7 6483.7 6245.8 6246.8 6297.0 6310.6 6343.0 6338.2 6341.7 6344.6 6347.4 6371.9 6043.6 6074.1 6099.0 6180.9 6259.3 6144.0 6244.6 6249.8 6252.2 6291.4 5937.0 6022.8 6100.3 6144.1 6171.2 6075.9 6146.2 6271.0 6280.3 6281.3 5805.8 5839.7 5873.3 5885.2 5889.1 19:18:23 INFO - PROCESS | 1662 | 19:18:23 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:70497.53 Median:41355.54 stddev:153803.64 (371.9%) stddev-sans-first:154145.14 19:18:23 INFO - PROCESS | 1662 | Values: 435.0 478.7 520.8 531.5 572.9 38649.0 41130.6 41310.8 41371.0 41499.0 42186.6 42768.8 42775.0 42809.0 42876.6 9570.0 9747.0 9754.4 9768.0 9771.5 9609.8 9670.5 9694.3 9698.7 9701.8 9707.0 9717.1 9726.6 9731.8 9755.0 8996.6 9649.0 9688.5 9689.9 9729.1 7378.9 9245.2 9644.0 9657.7 9683.7 32994.7 39368.6 40054.8 40199.0 40288.6 3565.6 3590.5 3605.9 3692.5 4041.9 30980.1 31576.2 32151.8 32184.7 32300.0 3290.7 3366.4 3388.4 3446.3 3454.6 514257.0 519222.0 524823.0 526899.0 527465.0 63346.0 63613.7 63718.7 63749.4 63897.0 65647.7 65712.0 66097.7 66257.7 66600.7 16438.1 16698.5 16720.1 16758.8 16800.2 12806.7 12816.0 12878.0 12933.7 12934.0 15537.8 15832.1 17587.7 17780.5 17818.8 5496.0 6567.4 6782.9 7189.4 7216.9 810.0 936.6 992.5 1022.4 1043.3 30587.4 31132.0 31621.0 31942.4 32485.5 1000.6 1064.5 1083.6 1153.7 1182.1 15952.6 15954.3 15989.4 16077.9 16337.1 714532.0 719648.0 721099.0 721671.0 725046.0 62019.0 62136.0 62482.7 62510.7 62829.4 1353.3 1368.6 1410.2 1413.8 1417.2 29707.7 30853.7 31042.7 31508.8 31582.8 52191.0 52959.7 53178.5 53209.7 53358.9 445570.8 445635.8 445963.8 446108.0 447950.0 27253.0 27679.9 27780.3 27787.9 27842.9 48448.0 48929.5 49122.8 49508.8 50358.0 38645.8 39282.6 40946.0 42103.8 42177.8 41114.0 41270.0 41340.1 41619.0 41660.2 32794.0 37210.1 39064.0 39541.4 40858.6 35435.3 36375.6 36460.5 36738.4 37112.9 23223.8 26512.3 26542.5 26661.2 26684.3 19:18:23 INFO - PROCESS | 1662 | 19:18:23 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:35857.18 Median:1527.63 stddev:103658.82 (6785.6%) stddev-sans-first:103915.34 19:18:23 INFO - PROCESS | 1662 | Values: 362.0 374.7 375.9 377.5 390.3 16232.8 19733.6 20700.8 21309.0 21552.8 20369.5 20498.3 20902.4 20904.0 21379.3 5380.3 5960.1 6144.7 6212.7 6221.7 6094.2 6172.5 6206.8 6211.4 6211.9 5917.9 6058.5 6155.4 6183.1 6192.3 5889.3 6098.1 6124.7 6127.9 6155.0 5999.5 6040.2 6096.6 6135.4 6160.7 13192.7 13413.7 13456.3 13578.3 13799.2 2138.5 2340.2 2345.8 2584.7 2693.3 9615.4 10122.2 10201.6 10306.9 10649.0 1814.4 1898.6 1937.9 1947.1 1962.1 123146.0 136527.0 137274.3 137315.0 137865.3 11294.0 11611.0 11620.3 11764.3 11813.7 14379.5 14512.3 14513.6 14536.4 14554.6 8369.0 8500.7 8507.8 8555.4 8647.8 6943.4 8415.7 8536.6 8540.7 8668.4 4481.6 4486.8 4506.4 4532.4 4604.8 1905.3 1948.2 1952.9 1953.4 1956.1 775.3 782.9 872.7 941.0 1006.9 16962.7 20701.6 21691.2 21751.7 21883.6 885.4 921.9 953.3 955.8 976.8 10279.0 10871.9 11585.0 11657.9 11671.6 598774.0 610127.0 610537.0 634879.0 638689.0 76458.2 130906.0 133767.0 141891.0 142709.0 968.3 985.6 987.8 994.9 1002.4 18864.3 19145.3 19390.1 19445.5 19463.5 45889.5 54477.1 59535.7 60093.0 60246.3 73980.0 84712.2 85197.0 86536.0 88142.6 7970.3 8072.0 8200.1 8259.3 8387.7 9805.0 10931.9 12697.3 13010.5 13102.6 10597.0 10622.6 10749.7 11291.4 11493.8 8459.8 10104.7 10699.1 11075.4 11378.9 7349.6 10043.5 11039.6 11193.6 11251.8 8044.8 8053.2 8212.6 8222.5 8420.2 8053.3 10726.4 10937.8 10960.5 11598.9 19:18:23 INFO - PROCESS | 1662 | 19:18:23 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5620.80 Median:5103.48 stddev:3112.63 (61.0%) stddev-sans-first:3105.86 19:18:23 INFO - PROCESS | 1662 | Values: 1487.9 1529.0 1554.5 1719.8 1845.6 7733.9 7837.2 8312.6 8479.7 8567.9 7152.3 8665.4 8697.7 8706.4 8715.7 1944.7 2313.5 2358.0 2362.3 2364.5 2323.5 2346.8 2371.8 2384.8 2391.1 2361.4 2374.4 2374.5 2388.2 2395.6 2298.5 2339.3 2347.7 2348.8 2378.8 2352.8 2362.1 2366.7 2367.9 2368.3 8688.3 8832.8 8836.2 8854.6 8868.0 5156.6 5174.1 5198.9 5300.7 5322.0 2938.4 3559.8 3582.7 3605.4 3620.9 1029.5 1068.9 1083.1 1087.1 1093.2 10195.4 11613.4 11726.1 11729.0 11740.2 4534.8 4632.5 4794.3 4809.9 4811.1 9835.9 9941.2 9951.9 9960.3 9969.0 5342.7 5359.9 5361.8 5367.1 5370.9 3673.3 4744.2 4872.4 4931.3 4952.6 3892.6 3914.7 3921.4 4013.4 4036.7 1096.2 1259.5 1298.1 1298.2 1316.1 840.9 861.7 907.3 908.6 929.0 5709.5 5799.6 5911.7 6069.5 6132.7 844.9 951.6 956.2 971.0 1006.1 3960.2 3987.7 4011.5 4031.5 4081.2 8481.3 10298.4 10733.3 10758.5 10773.5 7735.9 10528.4 10575.2 10660.4 10760.7 6839.5 8065.0 8216.5 8283.0 8304.3 5387.0 5795.9 5910.8 6086.5 6189.7 8318.7 8623.6 9788.9 9974.7 10024.0 9888.7 10162.5 10165.7 10166.8 10256.1 6919.9 7317.6 7434.9 7487.6 7622.2 8351.2 8451.9 8505.9 8523.9 8534.6 6300.9 7438.4 7558.9 7690.1 7717.8 7214.0 7365.9 7418.9 7421.9 7447.6 6348.3 6721.6 6930.0 6959.7 7024.2 4643.3 5043.2 5044.7 5078.5 5135.1 4312.5 5063.5 5065.9 5128.5 5135.7 19:18:23 INFO - PROCESS | 1662 | 19:18:23 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:4477.84 Median:4797.60 stddev:1374.95 (28.7%) stddev-sans-first:1342.60 19:18:23 INFO - PROCESS | 1662 | Values: 301.5 306.2 312.6 315.7 318.4 5432.4 5518.9 5595.4 5685.4 5713.5 4738.4 5556.4 5590.1 5624.9 5664.8 3523.6 3772.0 4199.8 4312.8 4318.0 3470.3 4144.6 4226.5 4304.9 4335.2 4172.8 4186.7 4187.7 4201.2 4204.7 3586.5 4205.8 4216.9 4220.9 4262.6 3659.6 3660.8 3664.2 3673.0 3677.9 4527.5 5138.2 5266.7 5446.7 5450.7 4904.9 4918.3 4932.2 4941.2 4970.4 5638.6 5969.9 5970.6 5982.7 6018.2 3550.0 3996.2 4030.2 4042.2 4075.0 6192.0 6193.2 6212.3 6266.8 6299.5 3938.8 4087.6 4105.3 4116.3 4130.9 3316.6 4143.9 4164.2 4165.8 4171.2 4461.5 4885.9 4894.7 4907.4 4918.6 5509.4 5692.7 5834.3 5970.2 6045.8 1383.0 1387.3 1422.8 1424.7 1429.4 808.4 845.8 856.0 875.2 876.4 4406.7 4673.4 4783.0 4788.5 4790.8 4133.6 4568.8 4630.6 5033.9 5174.6 4046.2 4111.8 4217.6 4750.4 4791.9 2342.9 2391.5 2409.0 2422.0 2686.2 4367.6 4739.9 5300.9 5328.7 5361.8 4360.1 4750.4 5061.2 5262.6 5270.9 4701.0 4716.3 4824.2 5243.3 5271.3 4458.2 4777.8 4918.8 5149.0 5175.9 3689.7 4250.4 4749.9 5140.8 5155.3 4574.2 4630.0 4828.8 5305.7 5315.0 3287.4 3546.7 3841.1 3849.8 3962.7 4800.6 5077.1 5987.5 6035.6 6038.9 5510.2 5584.3 5847.3 5903.5 5905.4 5337.6 5579.6 5816.7 5855.3 5861.2 4794.6 5044.3 5732.3 5739.2 5744.4 4970.9 5658.8 5798.3 5869.0 5880.9 4400.5 5447.6 5554.6 5556.5 5589.8 19:18:23 INFO - PROCESS | 1662 | 19:18:23 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:23470.17 Median:4208.19 stddev:35862.70 (852.2%) stddev-sans-first:35922.49 19:18:23 INFO - PROCESS | 1662 | Values: 682.6 736.5 763.1 782.9 813.0 15411.8 16386.5 16428.8 16469.3 16472.8 14756.9 14872.4 14887.3 14895.4 14943.6 596.4 662.6 819.9 834.7 855.4 823.3 838.9 845.6 849.7 850.4 884.3 889.5 890.6 892.6 893.5 879.4 885.4 888.6 889.9 891.7 655.2 664.9 666.4 666.6 667.9 14665.9 14749.8 14770.3 14770.6 14806.6 14566.3 14615.4 14624.5 14691.5 14756.5 11933.6 12108.9 12349.5 12367.2 12493.2 3528.6 3844.7 4028.8 4077.4 4077.7 89920.0 93374.0 102788.0 125465.0 126070.4 10080.7 10524.6 10979.3 11145.3 11599.4 23104.4 23132.2 23161.5 23166.3 23213.1 7891.9 7939.2 8055.0 8158.9 8215.5 4463.7 4564.5 4609.6 4631.2 4727.6 3133.8 3516.8 3527.8 3610.8 3615.7 621.4 626.8 631.6 635.9 647.8 494.2 571.8 587.8 598.0 663.5 8862.2 9254.6 9397.2 9404.0 9502.1 583.5 613.2 636.5 648.0 665.3 4338.7 4385.0 4615.0 4632.8 4680.1 86388.0 124452.0 128403.0 128562.4 143709.9 94503.0 106126.9 106905.9 126627.0 130738.0 76880.8 78321.0 96484.0 112891.4 115748.0 9481.4 9766.3 9799.8 9875.5 9879.9 63226.7 63844.0 64258.0 64855.4 65642.7 93032.5 94122.0 94201.1 94322.0 96881.5 12898.5 12989.8 13083.9 13162.7 13329.4 14459.6 14746.6 14782.3 14850.3 15104.8 13476.4 13681.4 13730.4 13887.4 14183.1 13379.5 13440.7 13632.5 13746.2 13851.7 13454.6 13461.6 13753.9 13771.0 14038.9 10936.3 11261.2 11406.4 11437.5 11497.9 7633.1 9535.4 10065.5 10348.7 11684.2 19:18:23 INFO - PROCESS | 1662 | -------- Summary: end -------- 19:18:23 INFO - PROCESS | 1662 | 19:18:24 INFO - TEST-INFO | 1662: exit 0 19:18:24 INFO - TEST-OK | dromaeo_css | took 1113310ms 19:18:24 INFO - TEST-START | kraken 19:18:24 INFO - operating with platform_type : mac_ 19:18:24 INFO - Initialising browser for kraken test... 19:18:24 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmpZZ8NDk/profile http://localhost:49262/getInfo.html) 19:18:26 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 19:18:26 INFO - PROCESS | 1674 | colorDepth:24 19:18:26 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 19:18:26 INFO - PROCESS | 1674 | __metrics 19:18:26 ERROR - PROCESS | 1674 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 19:18:27 INFO - TEST-INFO | 1674: exit 0 19:18:27 INFO - Browser initialized. 19:18:27 INFO - Running cycle 1/1 for kraken test... 19:18:27 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmpZZ8NDk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:18:39 INFO - PROCESS | 1676 | RSS: Main: 239271936 19:18:39 INFO - PROCESS | 1676 | 19:18:42 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection) 19:18:43 INFO - PROCESS | 1676 | RSS: Main: 252088320 19:18:43 INFO - PROCESS | 1676 | 19:18:45 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-dft) 19:18:46 INFO - PROCESS | 1676 | RSS: Main: 260759552 19:18:46 INFO - PROCESS | 1676 | 19:18:49 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-fft) 19:18:50 INFO - PROCESS | 1676 | RSS: Main: 263626752 19:18:50 INFO - PROCESS | 1676 | 19:18:52 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator) 19:18:53 INFO - PROCESS | 1676 | RSS: Main: 264896512 19:18:53 INFO - PROCESS | 1676 | 19:18:55 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:18:55 INFO - PROCESS | 1676 | RSS: Main: 266670080 19:18:55 INFO - PROCESS | 1676 | 19:18:58 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom) 19:18:59 INFO - PROCESS | 1676 | RSS: Main: 266715136 19:18:59 INFO - PROCESS | 1676 | 19:19:02 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate) 19:19:03 INFO - PROCESS | 1676 | RSS: Main: 264286208 19:19:03 INFO - PROCESS | 1676 | 19:19:06 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial) 19:19:07 INFO - PROCESS | 1676 | RSS: Main: 265928704 19:19:07 INFO - PROCESS | 1676 | 19:19:08 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:19:09 INFO - PROCESS | 1676 | RSS: Main: 266203136 19:19:09 INFO - PROCESS | 1676 | 19:19:11 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:19:11 INFO - PROCESS | 1676 | RSS: Main: 266575872 19:19:11 INFO - PROCESS | 1676 | 19:19:14 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:19:14 INFO - PROCESS | 1676 | RSS: Main: 266600448 19:19:14 INFO - PROCESS | 1676 | 19:19:17 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:19:18 INFO - PROCESS | 1676 | RSS: Main: 266543104 19:19:18 INFO - PROCESS | 1676 | 19:19:21 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:19:21 INFO - PROCESS | 1676 | RSS: Main: 266625024 19:19:21 INFO - PROCESS | 1676 | 19:19:23 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49262/tests/kraken/driver.html?testName=ai-astar) 19:19:23 INFO - PROCESS | 1676 | RSS: Main: 267468800 19:19:23 INFO - PROCESS | 1676 | 19:19:23 INFO - PROCESS | 1676 | __start_tp_report 19:19:23 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 19:19:23 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 19:19:23 INFO - PROCESS | 1676 | |i|pagename|runs| 19:19:23 INFO - PROCESS | 1676 | |0;ai-astar;104;118;107;131;170;160;119;118;116;117 19:19:23 INFO - PROCESS | 1676 | |1;audio-beat-detection;145;110;129;154;109;132;128;110;162;122 19:19:23 INFO - PROCESS | 1676 | |2;audio-dft;194;199;200;210;256;275;230;203;181;190 19:19:23 INFO - PROCESS | 1676 | |3;audio-fft;62;73;92;135;74;80;78;53;135;52 19:19:23 INFO - PROCESS | 1676 | |4;audio-oscillator;70;73;118;78;100;82;130;57;67;130 19:19:23 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;92;131;123;114;136;86;106;98;89;73 19:19:23 INFO - PROCESS | 1676 | |6;imaging-darkroom;152;153;131;152;98;118;150;149;106;152 19:19:23 INFO - PROCESS | 1676 | |7;imaging-desaturate;92;94;91;91;96;98;92;120;118;92 19:19:23 INFO - PROCESS | 1676 | |8;json-parse-financial;52;55;58;56;57;58;56;55;64;81 19:19:23 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;66;63;68;76;79;75;72;67;67;68 19:19:23 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;87;111;113;92;87;86;90;87;85;89 19:19:23 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;138;139;136;140;136;174;151;144;152;140 19:19:23 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;216;242;185;170;170;167;171;172;169;168 19:19:23 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;68;71;68;70;70;72;87;87;89;73 19:19:23 INFO - PROCESS | 1676 | __end_tp_report 19:19:23 INFO - PROCESS | 1676 | __start_cc_report 19:19:23 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1092 19:19:23 INFO - PROCESS | 1676 | __end_cc_report 19:19:23 INFO - PROCESS | 1676 | __startTimestamp1471573163931__endTimestamp 19:19:23 INFO - PROCESS | 1676 | 19:19:23 INFO - PROCESS | 1676 | ------- Summary: start ------- 19:19:23 INFO - PROCESS | 1676 | Number of tests: 14 19:19:23 INFO - PROCESS | 1676 | 19:19:23 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:126.00 Median:118.50 stddev:21.91 (18.5%) stddev-sans-first:21.74 19:19:23 INFO - PROCESS | 1676 | Values: 104.0 118.0 107.0 131.0 170.0 160.0 119.0 118.0 116.0 117.0 19:19:23 INFO - PROCESS | 1676 | 19:19:23 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:130.10 Median:130.50 stddev:18.68 (14.3%) stddev-sans-first:19.01 19:19:23 INFO - PROCESS | 1676 | Values: 145.0 110.0 129.0 154.0 109.0 132.0 128.0 110.0 162.0 122.0 19:19:23 INFO - PROCESS | 1676 | 19:19:23 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:213.80 Median:206.50 stddev:30.48 (14.8%) stddev-sans-first:31.48 19:19:23 INFO - PROCESS | 1676 | Values: 194.0 199.0 200.0 210.0 256.0 275.0 230.0 203.0 181.0 190.0 19:19:23 INFO - PROCESS | 1676 | 19:19:23 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:83.40 Median:73.50 stddev:29.82 (40.6%) stddev-sans-first:30.61 19:19:23 INFO - PROCESS | 1676 | Values: 62.0 73.0 92.0 135.0 74.0 80.0 78.0 53.0 135.0 52.0 19:19:23 INFO - PROCESS | 1676 | 19:19:23 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:68.50 stddev:27.07 (39.5%) stddev-sans-first:27.68 19:19:23 INFO - PROCESS | 1676 | Values: 70.0 73.0 118.0 78.0 100.0 82.0 130.0 57.0 67.0 130.0 19:19:23 INFO - PROCESS | 1676 | 19:19:23 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:104.80 Median:79.50 stddev:20.82 (26.2%) stddev-sans-first:21.56 19:19:23 INFO - PROCESS | 1676 | Values: 92.0 131.0 123.0 114.0 136.0 86.0 106.0 98.0 89.0 73.0 19:19:23 INFO - PROCESS | 1676 | 19:19:23 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:136.10 Median:152.00 stddev:21.38 (14.1%) stddev-sans-first:21.89 19:19:23 INFO - PROCESS | 1676 | Values: 152.0 153.0 131.0 152.0 98.0 118.0 150.0 149.0 106.0 152.0 19:19:23 INFO - PROCESS | 1676 | 19:19:23 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:98.40 Median:92.00 stddev:11.10 (12.1%) stddev-sans-first:11.53 19:19:23 INFO - PROCESS | 1676 | Values: 92.0 94.0 91.0 91.0 96.0 98.0 92.0 120.0 118.0 92.0 19:19:23 INFO - PROCESS | 1676 | 19:19:23 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:59.20 Median:57.50 stddev:8.26 (14.4%) stddev-sans-first:8.34 19:19:23 INFO - PROCESS | 1676 | Values: 52.0 55.0 58.0 56.0 57.0 58.0 56.0 55.0 64.0 81.0 19:19:23 INFO - PROCESS | 1676 | 19:19:23 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.00 stddev:5.13 (7.3%) stddev-sans-first:5.22 19:19:23 INFO - PROCESS | 1676 | Values: 66.0 63.0 68.0 76.0 79.0 75.0 72.0 67.0 67.0 68.0 19:19:23 INFO - PROCESS | 1676 | 19:19:23 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:92.70 Median:87.00 stddev:10.38 (11.9%) stddev-sans-first:10.81 19:19:23 INFO - PROCESS | 1676 | Values: 87.0 111.0 113.0 92.0 87.0 86.0 90.0 87.0 85.0 89.0 19:19:23 INFO - PROCESS | 1676 | 19:19:23 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:145.00 Median:142.00 stddev:11.66 (8.2%) stddev-sans-first:12.09 19:19:23 INFO - PROCESS | 1676 | Values: 138.0 139.0 136.0 140.0 136.0 174.0 151.0 144.0 152.0 140.0 19:19:23 INFO - PROCESS | 1676 | 19:19:23 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.00 Median:171.50 stddev:25.50 (14.9%) stddev-sans-first:24.09 19:19:23 INFO - PROCESS | 1676 | Values: 216.0 242.0 185.0 170.0 170.0 167.0 171.0 172.0 169.0 168.0 19:19:23 INFO - PROCESS | 1676 | 19:19:23 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.50 Median:72.50 stddev:8.55 (11.8%) stddev-sans-first:8.63 19:19:23 INFO - PROCESS | 1676 | Values: 68.0 71.0 68.0 70.0 70.0 72.0 87.0 87.0 89.0 73.0 19:19:23 INFO - PROCESS | 1676 | -------- Summary: end -------- 19:19:23 INFO - PROCESS | 1676 | 19:19:24 INFO - TEST-INFO | 1676: exit 0 19:19:24 INFO - TEST-OK | kraken | took 60623ms 19:19:24 INFO - SUITE-END | took 1173s 19:19:25 INFO - Completed test suite (00:19:34) 19:19:25 INFO - javascript benchmark 19:19:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7326.071159668511, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3021.833799141047, 3255.625603055648, 3448.5172075909377, 3454.896353109406, 3455.9136021599475, 4696.248600223965, 5237.135872581024, 5761.107028410593, 5794.855128621786, 5822.243108395914, 4149.83400663973, 5328.786848526064, 5823.941760582404, 5830.82507524775, 5899.970500147493, 5267.420583735796, 5312.415634280226, 5379.220013098098, 5405.081136206834, 5466.34403871536, 5213.374395072597, 5250.8687282817855, 5364.785408583652, 5366.624336296461, 5387.757550910199, 5281.128613778722, 5314.840554783344, 5330.760115794798, 5344.225087362311, 5346.6524675896335, 5303.416624171338, 5323.467653234684, 5326.973365133188, 5341.985022845685, 5402.91895621566, 5141.562967147797, 5210.817621383271, 5314.0700377433795, 5318.1225097858805, 5356.517913387775, 4488.865334039951, 5782.56630752691, 5844.853878653025, 5851.385604511507, 5914.556408269354, 6289.905651415233, 6319.873602527924, 6327.683615819236, 6341.080543321239, 6383.39357761012, 6248.625082495065, 6295.968520157416, 6355.396237357444, 6355.586886852339, 6365.713542890581, 4742.383490146293, 5896.410358964069, 5905.704714764331, 5936.465718085393, 5961.8807623847715, 6325.715342809584, 6362.141110950055, 6374.808755737336, 6396.5202609804455, 6416.903746443807, 5790.61025353912, 6125.724342404603, 6267.4986001119805, 6296.590721603081, 6303.6217826929615, 5242.554382877422, 5519.806806761744, 6349.396807303298, 6350.0792385103905, 6353.555251132377, 4680.976595117071, 4865.416150061945, 5203.19350500673, 5585.9107474042985, 6284.685765711696, 4737.38414006177, 5956.52347812174, 6153.230846144232, 6366.236051673736, 6366.745330186741, 4211.957880421218, 4221.0, 4405.471343438744, 4470.2177119004045, 4962.950370496321, 4465.151621191963, 4467.642588592905, 4478.41780568524, 4481.775911204492, 4490.438695163105, 4706.811727530929, 4934.950650493521, 5016.2224855147515, 6002.249718785152, 6023.765128148719, 4954.331165292711, 6299.716512756937, 6301.306856245809, 6313.0, 6336.89104406727, 4597.287420449836, 5367.731613419313, 5918.467337939606, 6067.969660151671, 6083.209182806207, 5398.13629819227, 5454.072807622713, 5456.727163641802, 5512.173174023848, 5538.280023596906, 6367.522435817332, 6479.708413121421, 6489.610623362708, 6507.609543427409, 6530.47756179495, 6290.654014029273, 6312.621242725451, 6313.589616674902, 6340.556161068681, 6415.58298710601, 6290.779822706183, 6424.4860411166055, 6472.320406357453, 6482.740690372332, 6483.675816209265, 6245.812625621057, 6246.750129994749, 6297.0, 6310.5898116622275, 6343.0, 6338.207724034496, 6341.746330146742, 6344.619322840645, 6347.365263473615, 6371.904421433775, 6043.607165534227, 6074.058520929263, 6098.976888192089, 6180.907286390798, 6259.280182778856, 6144.03390914903, 6244.625322480666, 6249.812505624838, 6252.187215661935, 6291.402316779899, 5937.025796661477, 6022.759089636541, 6100.298465676504, 6144.078388241799, 6171.1668924694595, 6075.939240607538, 6146.200993870768, 6270.968645156745, 6280.340564240689, 6281.277653069956, 5805.767769289181, 5839.708014599338, 5873.324567674601, 5885.205497257815, 5889.146073819358], "value": 5658.483761342007, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.9739015659061, 478.7127723365981, 520.7553946068895, 531.4897698209719, 572.9054705973515, 38649.0, 41130.58869411305, 41310.79344603277, 41371.0, 41499.0, 42186.578134218646, 42768.786156069174, 42775.0, 42809.0, 42876.57123428772, 9570.042995700443, 9746.951265243699, 9754.365966212174, 9768.023197680246, 9771.462569558671, 9609.80780384392, 9670.468124253162, 9694.272929530278, 9698.709038728814, 9701.805963880719, 9706.951465242664, 9717.125458708715, 9726.562304696306, 9731.75670608237, 9754.951225243864, 8996.640134394616, 9649.0, 9688.46713430761, 9689.90310096897, 9729.124378805942, 7378.926210737931, 9245.167934885825, 9643.951780241125, 9657.71026869195, 9683.661071862522, 32994.67005329964, 39368.62209822643, 40054.79972600118, 40199.0, 40288.59711402878, 3565.625609311011, 3590.5152804371337, 3605.9098522536883, 3692.538432695913, 4041.8787436376956, 30980.0705978821, 31576.210594735086, 32151.83924080388, 32184.678153218403, 32300.0, 3290.7038366546885, 3366.360391525602, 3388.3731509670542, 3446.327966046622, 3454.5509083818943, 514257.0, 519222.0, 524823.0, 526899.0, 527465.0, 63346.0, 63613.68193159004, 63718.72562548723, 63749.36250637527, 63897.04154437687, 65647.67176164089, 65712.0, 66097.66951165213, 66257.6687116571, 66600.6669966647, 16438.095904725356, 16698.499045028668, 16720.08039557836, 16758.832411675972, 16800.24398902028, 12806.743865122646, 12816.0, 12878.0, 12933.676658083436, 12933.965282777355, 15537.84462155364, 15832.129232892301, 17587.73618395725, 17780.46658600244, 17818.821811781974, 5496.038193316153, 6567.376099270562, 6782.93217067823, 7189.388901943394, 7216.8917466238045, 809.951402915827, 936.6253498600614, 992.4640694025146, 1022.3870948492869, 1043.2540733375672, 30587.388252234832, 31132.0, 31621.0, 31942.361152776815, 32485.5381507828, 1000.6197644895038, 1064.5103252503934, 1083.631565267797, 1153.7404084081015, 1182.066167727503, 15952.601184970468, 15954.28205730745, 15989.440369587008, 16077.919610402107, 16337.101459419608, 714532.0, 719648.0, 721099.0, 721671.0, 725046.0, 62019.0, 62136.0, 62482.68758656178, 62510.68744656248, 62829.371706283266, 1353.2557093598482, 1368.5962641020724, 1410.2173293822232, 1413.7596608576566, 1417.1709549913417, 29707.702922970493, 30853.69146308508, 31042.68957310398, 31508.849115089226, 31582.842085789423, 52191.0, 52959.73520132375, 53178.543394679225, 53209.733951329996, 53358.93282134413, 445570.7721461372, 445635.7718211388, 445963.77018116, 446108.0, 447950.0, 27253.0, 27679.861600691867, 27780.305492362044, 27787.888484460396, 27842.860785695942, 48448.0, 48929.5107048925, 49122.75438622784, 49508.762280943265, 50358.0, 38645.806770965966, 39282.60717392789, 40945.952702364164, 42103.7894810524, 42177.78911105425, 41113.97215069647, 41270.0, 41340.08151565384, 41618.95952601088, 41660.16679666329, 32794.0, 37210.06974825651, 39064.023399415244, 39541.40687889742, 40858.591414086666, 35435.29129417449, 36375.63624363722, 36460.45309320309, 36738.38528186175, 37112.88661340164, 23223.767762322837, 26512.337191570365, 26542.5401602906, 26661.200163995112, 26684.332891677863], "value": 20294.042208061997, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.9746617736758, 374.6590602551678, 375.92293579816123, 377.5054678371333, 390.2818813383374, 16232.756508652365, 19733.63440172648, 20700.792992070114, 21309.041093150827, 21552.784472155272, 20369.4907627309, 20498.282560110398, 20902.37292881212, 20904.0, 21379.25172618959, 5380.300560927074, 5960.135780311853, 6144.692765361714, 6212.65830379329, 6221.688915554227, 6094.238220222473, 6172.506199504029, 6206.813795586117, 6211.378862113797, 6211.90682139766, 5917.852053698649, 6058.515318774509, 6155.415235552616, 6183.1034499997695, 6192.349803270659, 5889.293284805808, 6098.14625952367, 6124.663143527104, 6127.877442451148, 6154.984427569446, 5999.490043346321, 6040.214772079602, 6096.573239873211, 6135.447809697104, 6160.691965401712, 13192.6701832454, 13413.731725365438, 13456.327183640877, 13578.25319607431, 13799.172049677052, 2138.518833262519, 2340.2277248507953, 2345.82406319525, 2584.7286034966432, 2693.2862791360303, 9615.375000624937, 10122.1657885949, 10201.642942497052, 10306.89693103067, 10649.0, 1814.355903654197, 1898.6107847891149, 1937.8740381875134, 1947.0751393088312, 1962.1464662871554, 123146.0, 136527.0, 137274.31362843222, 137315.0, 137865.310673446, 11294.0, 11611.0, 11620.302781832948, 11764.294142351486, 11813.704657383461, 14379.496717614833, 14512.274386280855, 14513.637159071108, 14536.418543258364, 14554.563363099123, 8368.958155209306, 8500.702475413455, 8507.829843403097, 8555.443896146731, 8647.827043459096, 6943.444524438033, 8415.747527574182, 8536.573171341408, 8540.74377768668, 8668.356151373891, 4481.641468682497, 4486.842960496367, 4506.436695413074, 4532.410786597788, 4604.7927843247135, 1905.266472408105, 1948.1622902151928, 1952.863299569045, 1953.4139758072522, 1956.090417955629, 775.3138472451808, 782.9295363417319, 872.7432497204132, 940.9555393513195, 1006.9345492542961, 16962.660746784994, 20701.58596828055, 21691.240806571695, 21751.67372489414, 21883.562328753655, 885.420049867338, 921.9400738951947, 953.3183773601769, 955.81361634482, 976.8437050071955, 10279.0, 10871.891281087246, 11585.0, 11657.883421165849, 11671.649850504498, 598774.0183897245, 610127.0, 610537.0, 634879.0, 638689.0, 76458.2354176451, 130906.0, 133767.0, 141891.0, 142709.0, 968.3463662028103, 985.6353149334792, 987.7530617345664, 994.9205112453069, 1002.4386343647435, 18864.33974810875, 19145.32991345352, 19390.127444265323, 19445.51386215356, 19463.513412164244, 45889.54110458853, 54477.09330173425, 59535.70232148811, 60093.0, 60246.28891699796, 73980.0, 84712.15287847289, 85197.0, 86536.0, 88142.55928720316, 7970.322522585645, 8071.959640201996, 8200.05699344559, 8259.256666900008, 8387.664493420194, 9804.950975245078, 10931.945340273247, 12697.301648409426, 13010.544630937871, 13102.606921792361, 10596.993285637853, 10622.628208012682, 10749.731256718645, 11291.378974156172, 11493.770124597628, 8459.83080338402, 10104.747381315527, 10699.14406847466, 11075.380497742903, 11378.943105284421, 7349.595772232578, 10043.497825108861, 11039.558417663204, 11193.608223712132, 11251.7749645005, 8044.758657240292, 8053.1946805319, 8212.58937053133, 8222.465539739898, 8420.15798420153, 8053.31546818527, 10726.410047447465, 10937.83593246118, 10960.506777195205, 11598.94200528992], "value": 9479.833189886118, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1487.9330430130647, 1529.0137861079604, 1554.4559404208535, 1719.7678313427691, 1845.6124213915068, 7733.917251584782, 7837.177096404881, 8312.625931833067, 8479.703210387637, 8567.871481927768, 7152.320529549697, 8665.436746611482, 8697.739067827975, 8706.3905526613, 8715.651373945035, 1944.6888497840348, 2313.479467119897, 2357.95284094318, 2362.3031205794246, 2364.538914911593, 2323.453988312745, 2346.8239882008834, 2371.8339716219784, 2384.7615238476187, 2391.0913852735935, 2361.445060410802, 2374.442006128558, 2374.5488357212075, 2388.164142550102, 2395.6047252203366, 2298.494331247123, 2339.251439539348, 2347.730011048726, 2348.7686697637314, 2378.8096952243777, 2352.788249057593, 2362.11420717231, 2366.7396586375485, 2367.893444794988, 2368.2539999899977, 8688.261497772697, 8832.779180520474, 8836.204741573225, 8854.601542930584, 8868.02451730309, 5156.561692256163, 5174.068667639824, 5198.948010519922, 5300.681959082467, 5321.973390133063, 2938.44169607776, 3559.804210768407, 3582.6954708849516, 3605.441156620728, 3620.945685814715, 1029.4543891737317, 1068.8663917010374, 1083.101026148303, 1087.12486448409, 1093.240198062347, 10195.4392508412, 11613.361265130414, 11726.061915046861, 11729.0, 11740.178187526877, 4534.750588717652, 4632.513586073481, 4794.256890182028, 4809.927851082237, 4811.109944660179, 9835.901640983642, 9941.204703623838, 9951.900480995242, 9960.302778805413, 9968.950155249177, 5342.679439233659, 5359.892802144013, 5361.8123365682795, 5367.087595108841, 5370.865728356823, 3673.3387990162028, 4744.169770290186, 4872.3909511311085, 4931.334269873521, 4952.5542701157065, 3892.630200130983, 3914.745541539791, 3921.3725803871243, 4013.4381186633896, 4036.6972477064337, 1096.2490693874722, 1259.4647274908127, 1298.0978220137104, 1298.1886321049344, 1316.085320702122, 840.9152193670219, 861.6940985950023, 907.2605826251715, 908.6183802802839, 928.9767755806024, 5709.457601527848, 5799.594028417971, 5911.728978269607, 6069.484093851984, 6132.6933653317155, 844.8859403980507, 951.6336210558985, 956.168133723651, 970.9757256068655, 1006.094514936563, 3960.2277555876326, 3987.7208595398624, 4011.478507793968, 4031.4759081319826, 4081.1837632473625, 8481.279091277187, 10298.382097074049, 10733.302335348177, 10758.515866786014, 10773.461326933622, 7735.883961740578, 10528.368297901998, 10575.20685948557, 10660.360378377321, 10760.677179684622, 6839.452843772487, 8064.959675201587, 8216.507009579325, 8282.958585207036, 8304.252617264354, 5387.0, 5795.94204057954, 5910.7931222407005, 6086.452219300284, 6189.659568723763, 8318.667253310043, 8623.611937462954, 9788.874279457954, 9974.700758977242, 10024.047715467019, 9888.653897113567, 10162.491875406347, 10165.695029149138, 10166.796664066826, 10256.128229100312, 6919.930800691928, 7317.597532135784, 7434.925650743639, 7487.588182650006, 7622.16156222804, 8351.164883511843, 8451.8732219018, 8505.91494085076, 8523.91476085256, 8534.615942282488, 6300.873982520416, 7438.442116841366, 7558.886616700864, 7690.077190737147, 7717.845643086995, 7214.0, 7365.926340736524, 7418.851622967619, 7421.925780742339, 7447.5531468112085, 6348.269948955929, 6721.630310332783, 6929.965350173217, 6959.7216111357, 7024.192217895007, 4643.326717625993, 5043.193089105725, 5044.722540260321, 5078.466760990191, 5135.05001574695, 4312.482502099768, 5063.468335824833, 5065.924011139762, 5128.487151284841, 5135.6918584885025], "value": 4541.693982811161, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.520582274184, 306.199288859632, 312.6404634670129, 315.66854802457414, 318.4300102815958, 5432.375276843164, 5518.889622207554, 5595.440455954407, 5685.431456854318, 5713.5143512801405, 4738.360321356616, 5556.416576259495, 5590.133529302954, 5624.943750562493, 5664.830055098354, 3523.5947865995354, 3772.0, 4199.7690127043, 4312.792418122931, 4317.978410107945, 3470.3406352793013, 4144.611555129035, 4226.519888917742, 4304.935425968597, 4335.1979883721615, 4172.769033135232, 4186.697316475941, 4187.7277976931555, 4201.180769749884, 4204.726692764976, 3586.4799604057525, 4205.780323706122, 4216.894577635569, 4220.85227017053, 4262.637675797561, 3659.6157403472516, 3660.816959152032, 3664.212194378195, 3672.9632703672887, 3677.9080522986874, 4527.547245275479, 5138.229265610151, 5266.7366631668265, 5446.700431476267, 5450.656217826333, 4904.852854414337, 4918.311436398907, 4932.235503496964, 4941.20940649498, 4970.378702662168, 5638.577106717013, 5969.940300597025, 5970.552208584373, 5982.73077711504, 6018.21763170785, 3549.982250088759, 3996.18078293949, 4030.2342554914767, 4042.2319759245647, 4074.979625101885, 6192.049504406143, 6193.225846769154, 6212.254529456449, 6266.78066267683, 6299.464545513637, 3938.8030598469963, 4087.550369459357, 4105.322621767435, 4116.320807066801, 4130.938035929404, 3316.5522654441825, 4143.881152088919, 4164.1879833432795, 4165.770882601425, 4171.20747058058, 4461.4569695273385, 4885.926711099336, 4894.681845680019, 4907.411110666742, 4918.606511479073, 5509.449055094458, 5692.719138193873, 5834.329052159056, 5970.194023806817, 6045.818625441244, 1382.9515966941108, 1387.2924808347816, 1422.8434872164053, 1424.7391058912729, 1429.399652146101, 808.4462143431768, 845.8308338332358, 855.9657613695507, 875.1665261277614, 876.4259410086404, 4406.735595864258, 4673.439187297478, 4782.95217047832, 4788.467690339058, 4790.784414701347, 4133.648639865585, 4568.840090596813, 4630.606398456169, 5033.874153146201, 5174.558918319351, 4046.2109888571445, 4111.794410279534, 4217.599328063829, 4750.406199225097, 4791.915516750225, 2342.906283748631, 2391.4725779475134, 2408.9759102409103, 2422.0, 2686.200245835295, 4367.606915377632, 4739.857804265877, 5300.946990530046, 5328.653637513549, 5361.79359644077, 4360.05696155094, 4750.382450281441, 5061.240813877947, 5262.60530460217, 5270.868228294324, 4700.989287303246, 4716.339712440261, 4824.228123500223, 5243.292155559027, 5271.288376069181, 4458.175237581057, 4777.757782976381, 4918.778654960463, 5149.0, 5175.92236116451, 3689.741718079816, 4250.426192464101, 4749.928751068667, 5140.794368225229, 5155.2782610435315, 4574.232589283436, 4629.95825939161, 4828.782704778364, 5305.734713264244, 5315.0, 3287.391832510993, 3546.680798728127, 3841.1357444575865, 3849.844087311115, 3962.722609417313, 4800.639952003544, 5077.060743762416, 5987.491063259672, 6035.6076855004285, 6038.9396106038375, 5510.173473978935, 5584.268876648252, 5847.327557330791, 5903.483834866416, 5905.379935106752, 5337.57299416038, 5579.609427340048, 5816.680082595498, 5855.3266374367495, 5861.238039054895, 4794.568488836021, 5044.319016932667, 5732.254806875079, 5739.24079727779, 5744.396838331915, 4970.9254361183885, 5658.783361577281, 5798.333191682842, 5868.970655146697, 5880.882382352243, 4400.493943196573, 5447.64590301645, 5554.611177217556, 5556.527695145958, 5589.776408943597], "value": 4044.6756768123028, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [682.6245564939285, 736.4660621049738, 763.1147868472573, 782.8747400415934, 812.991870081299, 15411.845881541181, 16386.50840474785, 16428.83571164288, 16469.341226350945, 16472.752908706378, 14756.926215368934, 14872.405103795834, 14887.25563721815, 14895.404183832661, 14943.551693449186, 596.3648714119471, 662.6156829039157, 819.9262066414021, 834.7078522517131, 855.3670283989834, 823.259066839843, 838.9412741108125, 845.6110189312924, 849.6856163219618, 850.3792231670884, 884.3102380143498, 889.5418859287472, 890.5502721125822, 892.6429428228728, 893.4549924546021, 879.4283715584857, 885.4200498673347, 888.564603344363, 889.884315039044, 891.6700820696319, 655.203927228415, 664.8603793203384, 666.3569655282627, 666.6000399760154, 667.8897981832991, 14665.926670366687, 14749.77875331871, 14770.26148692561, 14770.630734231623, 14806.555803325917, 14566.344514496874, 14615.415383384652, 14624.488142914946, 14691.485797997126, 14756.48352307664, 11933.641990740292, 12108.939455302667, 12349.5060197592, 12367.196132251374, 12493.18794278369, 3528.606200550768, 3844.6539811417106, 4028.7784171870535, 4077.3883917412327, 4077.7145599808027, 89920.0, 93374.0, 102787.97212027859, 125465.0, 126070.36964815209, 10080.689510363605, 10524.631637892637, 10979.28634638746, 11145.275557088764, 11599.362035087983, 23104.4223894404, 23132.190373337187, 23161.536769264858, 23166.3050108497, 23213.071477140726, 7891.921080789233, 7939.166387529226, 8055.033395992401, 8158.918410815934, 8215.465994710325, 4463.687541872103, 4564.497905230422, 4609.631229501631, 4631.235846085426, 4727.57451829337, 3133.827639479805, 3516.8065756383135, 3527.8059706716376, 3610.7833529988284, 3615.680276698986, 621.3910367839543, 626.8307556959595, 631.643121636274, 635.9300476947532, 647.8121344810047, 494.21173228700167, 571.8084441712073, 587.7707693999344, 597.9760809567568, 663.4559661077966, 8862.20240178387, 9254.583543740548, 9397.154256116983, 9404.012578679278, 9502.144806967406, 583.5069366385397, 613.187526527353, 636.4558302651259, 647.970841312142, 665.3413121010165, 4338.674599405057, 4385.0133719912765, 4614.97692511542, 4632.821606606939, 4680.110778951988, 86388.0, 124452.0, 128403.0, 128562.35718821346, 143709.88061671375, 94503.0, 106126.93873061326, 106905.8618827619, 126627.0, 130738.0, 76880.84678729823, 78321.0, 96483.9999999986, 112891.43554282175, 115748.0, 9481.383710058824, 9766.267529935141, 9799.755006124904, 9875.506224688881, 9879.901200987899, 63226.735465289516, 63844.042339364016, 64258.0, 64855.37861553499, 65642.67178664076, 93032.53483732538, 94122.0, 94201.05798941923, 94322.0, 96881.51559242158, 12898.48406063747, 12989.805152922903, 13083.934580327037, 13162.670933226746, 13329.400176992252, 14459.566213013626, 14746.63133421673, 14782.260886955824, 14850.331735072165, 15104.848951510345, 13476.427142942035, 13681.384337705027, 13730.382132803848, 13887.388570381128, 14183.14901105937, 13379.53171638988, 13440.728907585393, 13632.454701811816, 13746.175229486264, 13851.722965540432, 13454.646533837678, 13461.596152115451, 13753.931230343784, 13771.0, 14038.929805351316, 10936.289141205796, 11261.211715180187, 11406.429678515875, 11437.542498299976, 11497.885021149681, 7633.091727068233, 9535.38020028696, 10065.483629092727, 10348.741281468023, 11684.18210725241], "value": 7730.515442495254, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1608.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 118.0, 107.0, 131.0, 170.0, 160.0, 119.0, 118.0, 116.0, 117.0], "value": 126.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 110.0, 129.0, 154.0, 109.0, 132.0, 128.0, 110.0, 162.0, 122.0], "value": 130.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 199.0, 200.0, 210.0, 256.0, 275.0, 230.0, 203.0, 181.0, 190.0], "value": 213.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 73.0, 92.0, 135.0, 74.0, 80.0, 78.0, 53.0, 135.0, 52.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 118.0, 78.0, 100.0, 82.0, 130.0, 57.0, 67.0, 130.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 131.0, 123.0, 114.0, 136.0, 86.0, 106.0, 98.0, 89.0, 73.0], "value": 104.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 153.0, 131.0, 152.0, 98.0, 118.0, 150.0, 149.0, 106.0, 152.0], "value": 136.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 91.0, 91.0, 96.0, 98.0, 92.0, 120.0, 118.0, 92.0], "value": 98.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 55.0, 58.0, 56.0, 57.0, 58.0, 56.0, 55.0, 64.0, 81.0], "value": 59.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 68.0, 76.0, 79.0, 75.0, 72.0, 67.0, 67.0, 68.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 111.0, 113.0, 92.0, 87.0, 86.0, 90.0, 87.0, 85.0, 89.0], "value": 92.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 139.0, 136.0, 140.0, 136.0, 174.0, 151.0, 144.0, 152.0, 140.0], "value": 145.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [216.0, 242.0, 185.0, 170.0, 170.0, 167.0, 171.0, 172.0, 169.0, 168.0], "value": 183.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 68.0, 70.0, 70.0, 72.0, 87.0, 87.0, 89.0, 73.0], "value": 75.5, "unit": "score"}]}]} 19:19:25 INFO - Return code: 0 19:19:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:19:25 ERROR - # TBPL SUCCESS # 19:19:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:19:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:19:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:19:25 INFO - 2016-08-18 19:19:25.252 screenresolution[1681:10394] starting screenresolution argv=screenresolution get 19:19:25 INFO - 2016-08-18 19:19:25.257 screenresolution[1681:10394] Display 0: 1600x1200x32@60 19:19:25 INFO - 2016-08-18 19:19:25.263 screenresolution[1682:10397] starting screenresolution argv=screenresolution list 19:19:25 INFO - Available Modes on Display 0 19:19:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:19:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:19:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:19:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:19:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:19:25 INFO - Intel Iris: 19:19:25 INFO - Chipset Model: Intel Iris 19:19:25 INFO - Type: GPU 19:19:25 INFO - Bus: Built-In 19:19:25 INFO - VRAM (Dynamic, Max): 1536 MB 19:19:25 INFO - Vendor: Intel (0x8086) 19:19:25 INFO - Device ID: 0x0a2e 19:19:25 INFO - Revision ID: 0x0009 19:19:25 INFO - Displays: 19:19:25 INFO - Display: 19:19:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:19:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:19:25 INFO - Display Serial Number: 1600x1200 60 19:19:25 INFO - Main Display: Yes 19:19:25 INFO - Mirror: Off 19:19:25 INFO - Online: Yes 19:19:25 INFO - Rotation: Supported 19:19:25 INFO - Return code: 0 19:19:25 INFO - Running post-action listener: _resource_record_post_action 19:19:25 INFO - [mozharness: 2016-08-19 02:19:25.501723Z] Finished run-tests step (success) 19:19:25 INFO - Running post-run listener: _resource_record_post_run 19:19:25 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 36795392; Write bytes: 705113600; Read time: 235; Write time: 1983 19:19:25 INFO - TinderboxPrint: CPU usage
54.6% 19:19:25 INFO - TinderboxPrint: I/O read bytes / time
36,795,392 / 235 19:19:25 INFO - TinderboxPrint: I/O write bytes / time
705,113,600 / 1,983 19:19:25 INFO - TinderboxPrint: CPU idle
2,196.9 (45.4%) 19:19:25 INFO - TinderboxPrint: CPU system
979.7 (20.3%) 19:19:25 INFO - TinderboxPrint: CPU user
1,661.0 (34.3%) 19:19:25 INFO - TinderboxPrint: Swap in / out
442,449,920 / 0 19:19:25 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 398907904; Write bytes: 392726528; Read time: 29592; Write time: 795 19:19:25 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 34718720; Write bytes: 296330752; Read time: 214; Write time: 1140 19:19:25 INFO - Running post-run listener: _upload_blobber_files 19:19:25 INFO - Blob upload gear active. 19:19:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:19:25 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:19:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:19:26 INFO - (blobuploader) - INFO - Open directory for files ... 19:19:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:19:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:19:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:19:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:19:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:19:27 INFO - (blobuploader) - INFO - Done attempting. 19:19:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:19:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:19:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:19:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:19:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:19:28 INFO - (blobuploader) - INFO - Done attempting. 19:19:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:19:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:19:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:19:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:19:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:19:31 INFO - (blobuploader) - INFO - Done attempting. 19:19:31 INFO - (blobuploader) - INFO - Iteration through files over. 19:19:31 INFO - Return code: 0 19:19:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:19:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:19:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/700afac2f3e565e6ddab6989c6846e02ffb99475940e51afb76a43fdcfcd65f7f15ecd4549d572add005d8b7fd50d322dc217b4e8c201be1fc56f23d1b05bee7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9663e2d5cb33f437d74cf310fd5ead5c3338ee2c40dd8e5338099d8dce54edcc01de65216d7f8b2d8d50a32095eedc4c50b0461135ecc708b12eb15b9539bf24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e533e1cad77fcec2f886d2b80d80285e7aa384c07aff5b046c0b66b8c184197d03624d005bd57521c1642b07a62568752db68f9665126dfc478ae6383ef1041"} 19:19:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:19:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:19:31 INFO - Contents: 19:19:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/700afac2f3e565e6ddab6989c6846e02ffb99475940e51afb76a43fdcfcd65f7f15ecd4549d572add005d8b7fd50d322dc217b4e8c201be1fc56f23d1b05bee7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9663e2d5cb33f437d74cf310fd5ead5c3338ee2c40dd8e5338099d8dce54edcc01de65216d7f8b2d8d50a32095eedc4c50b0461135ecc708b12eb15b9539bf24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e533e1cad77fcec2f886d2b80d80285e7aa384c07aff5b046c0b66b8c184197d03624d005bd57521c1642b07a62568752db68f9665126dfc478ae6383ef1041"} 19:19:31 INFO - Running post-run listener: copy_logs_to_upload_dir 19:19:31 INFO - Copying logs to upload dir... 19:19:31 INFO - mkdir: /builds/slave/test/build/upload/logs 19:19:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.805753 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-08-18 19:19:31.130017) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 19:19:31.134022) ========= 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.Q4wsyPIoCt/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.NjwraM89de/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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/700afac2f3e565e6ddab6989c6846e02ffb99475940e51afb76a43fdcfcd65f7f15ecd4549d572add005d8b7fd50d322dc217b4e8c201be1fc56f23d1b05bee7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9663e2d5cb33f437d74cf310fd5ead5c3338ee2c40dd8e5338099d8dce54edcc01de65216d7f8b2d8d50a32095eedc4c50b0461135ecc708b12eb15b9539bf24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e533e1cad77fcec2f886d2b80d80285e7aa384c07aff5b046c0b66b8c184197d03624d005bd57521c1642b07a62568752db68f9665126dfc478ae6383ef1041"} build_url:https://queue.taskcluster.net/v1/task/Y3t-DEPxT2OQRUstt15QLQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011175 build_url: 'https://queue.taskcluster.net/v1/task/Y3t-DEPxT2OQRUstt15QLQ/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/700afac2f3e565e6ddab6989c6846e02ffb99475940e51afb76a43fdcfcd65f7f15ecd4549d572add005d8b7fd50d322dc217b4e8c201be1fc56f23d1b05bee7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9663e2d5cb33f437d74cf310fd5ead5c3338ee2c40dd8e5338099d8dce54edcc01de65216d7f8b2d8d50a32095eedc4c50b0461135ecc708b12eb15b9539bf24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e533e1cad77fcec2f886d2b80d80285e7aa384c07aff5b046c0b66b8c184197d03624d005bd57521c1642b07a62568752db68f9665126dfc478ae6383ef1041"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 19:19:31.168070) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 19:19:31.168395) ========= 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.Q4wsyPIoCt/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.NjwraM89de/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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.005217 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 19:19:31.216747) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 19:19:31.217056) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 19:19:31.217366) ========= ========= Total master_lag: 0.17 =========