builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0337 starttime: 1472856655.84 results: success (0) buildid: 20160902133349 builduid: 6a6036702fa040ac87f0a4823cdb26ae revision: d0830980ffdb36a10855d02a588b4869cad6707e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 15:50:55.836517) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 15:50:55.837014) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 15:50:55.837289) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 15:50:55.862611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 15:50:55.862996) ========= 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.USaz5zP99U/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.FMlTO3qnoW/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-02 15:50:55-- 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% 165M=0s 2016-09-02 15:50:55 (165 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093047 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 15:50:55.980500) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 15:50:55.980990) ========= 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.USaz5zP99U/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.FMlTO3qnoW/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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.025328 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 15:50:56.030532) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-02 15:50:56.030922) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d0830980ffdb36a10855d02a588b4869cad6707e --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 d0830980ffdb36a10855d02a588b4869cad6707e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.USaz5zP99U/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.FMlTO3qnoW/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-02 15:50:56,119 truncating revision to first 12 chars 2016-09-02 15:50:56,119 Setting DEBUG logging. 2016-09-02 15:50:56,120 attempt 1/10 2016-09-02 15:50:56,120 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d0830980ffdb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-02 15:50:58,209 unpacking tar archive at: mozilla-central-d0830980ffdb/testing/mozharness/ program finished with exit code 0 elapsedTime=2.370351 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-02 15:50:58.425951) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 15:50:58.426275) ========= script_repo_revision: d0830980ffdb36a10855d02a588b4869cad6707e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 15:50:58.426697) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 15:50:58.426975) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 15:50:58.446469) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-09-02 15:50:58.446877) ========= /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.USaz5zP99U/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.FMlTO3qnoW/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 15:50:58 INFO - MultiFileLogger online at 20160902 15:50:58 in /builds/slave/test 15:50:58 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 15:50:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:50:58 INFO - {'append_to_log': False, 15:50:58 INFO - 'base_work_dir': '/builds/slave/test', 15:50:58 INFO - 'blob_upload_branch': 'Firefox', 15:50:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:50:58 INFO - 'branch': 'Firefox', 15:50:58 INFO - 'buildbot_json_path': 'buildprops.json', 15:50:58 INFO - 'config_files': ('talos/mac_config.py',), 15:50:58 INFO - 'default_actions': ('clobber', 15:50:58 INFO - 'read-buildbot-config', 15:50:58 INFO - 'download-and-extract', 15:50:58 INFO - 'populate-webroot', 15:50:58 INFO - 'create-virtualenv', 15:50:58 INFO - 'install', 15:50:58 INFO - 'run-tests'), 15:50:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:50:58 INFO - 'download_minidump_stackwalk': True, 15:50:58 INFO - 'download_symbols': 'ondemand', 15:50:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:50:58 INFO - 'tooltool.py': '/tools/tooltool.py', 15:50:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:50:58 INFO - '/tools/misc-python/virtualenv.py')}, 15:50:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:50:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:50:58 INFO - 'installer_path': 'installer.exe', 15:50:58 INFO - 'log_level': 'info', 15:50:58 INFO - 'log_name': 'talos', 15:50:58 INFO - 'log_to_console': True, 15:50:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:50:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:50:58 INFO - 'opt_config_files': (), 15:50:58 INFO - 'pip_index': False, 15:50:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:50:58 INFO - 'cmd': ('bash', 15:50:58 INFO - '-c', 15:50:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:50:58 INFO - 'enabled': True, 15:50:58 INFO - 'halt_on_failure': False, 15:50:58 INFO - 'name': 'check_screen_resolution'},), 15:50:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:50:58 INFO - 'cmd': ('bash', 15:50:58 INFO - '-c', 15:50:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:50:58 INFO - 'enabled': True, 15:50:58 INFO - 'halt_on_failure': False, 15:50:58 INFO - 'name': 'check_screen_resolution'},), 15:50:58 INFO - 'run_cmd_checks_enabled': True, 15:50:58 INFO - 'sps_profile': False, 15:50:58 INFO - 'sps_profile_interval': 0, 15:50:58 INFO - 'suite': 'dromaeojs-e10s', 15:50:58 INFO - 'system_bits': '32', 15:50:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:50:58 INFO - 'title': 't-yosemite-r7-0337', 15:50:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:50:58 INFO - 'use_talos_json': True, 15:50:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:50:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:50:58 INFO - 'work_dir': 'build'} 15:50:58 INFO - [mozharness: 2016-09-02 22:50:58.657702Z] Running clobber step. 15:50:58 INFO - Running pre-action listener: _resource_record_pre_action 15:50:58 INFO - Running main action method: clobber 15:50:58 INFO - rmtree: /builds/slave/test/build 15:50:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:51:00 INFO - Running post-action listener: _resource_record_post_action 15:51:00 INFO - [mozharness: 2016-09-02 22:51:00.802407Z] Finished clobber step (success) 15:51:00 INFO - [mozharness: 2016-09-02 22:51:00.802632Z] Running read-buildbot-config step. 15:51:00 INFO - Running pre-action listener: _resource_record_pre_action 15:51:00 INFO - Running main action method: read_buildbot_config 15:51:00 INFO - Using buildbot properties: 15:51:00 INFO - { 15:51:00 INFO - "project": "", 15:51:00 INFO - "product": "firefox", 15:51:00 INFO - "script_repo_revision": "production", 15:51:00 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 15:51:00 INFO - "repository": "", 15:51:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 15:51:00 INFO - "buildid": "20160902133349", 15:51:00 INFO - "pgo_build": "False", 15:51:00 INFO - "basedir": "/builds/slave/test", 15:51:00 INFO - "buildnumber": 19, 15:51:00 INFO - "slavename": "t-yosemite-r7-0337", 15:51:00 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 15:51:00 INFO - "platform": "yosemite_r7", 15:51:00 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:51:00 INFO - "branch": "mozilla-central", 15:51:00 INFO - "repo_path": "mozilla-central", 15:51:00 INFO - "revision": "d0830980ffdb36a10855d02a588b4869cad6707e", 15:51:00 INFO - "stage_platform": "macosx64", 15:51:00 INFO - "builduid": "6a6036702fa040ac87f0a4823cdb26ae", 15:51:00 INFO - "slavebuilddir": "test" 15:51:00 INFO - } 15:51:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/L8LmHO6mSFGTmFh1kM0wRA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 15:51:00 INFO - Running post-action listener: _resource_record_post_action 15:51:00 INFO - [mozharness: 2016-09-02 22:51:00.810047Z] Finished read-buildbot-config step (success) 15:51:00 INFO - [mozharness: 2016-09-02 22:51:00.810229Z] Running download-and-extract step. 15:51:00 INFO - Running pre-action listener: _resource_record_pre_action 15:51:00 INFO - Running main action method: download_and_extract 15:51:00 INFO - mkdir: /builds/slave/test/build/tests 15:51: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')]} 15:51:00 INFO - trying https://queue.taskcluster.net/v1/task/L8LmHO6mSFGTmFh1kM0wRA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 15:51:00 INFO - Downloading https://queue.taskcluster.net/v1/task/L8LmHO6mSFGTmFh1kM0wRA/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 15:51:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L8LmHO6mSFGTmFh1kM0wRA/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 15:51:01 INFO - Downloaded 1199 bytes. 15:51:01 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 15:51:01 INFO - Using the following test package requirements: 15:51:01 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 15:51:01 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:51:01 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 15:51:01 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:51:01 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 15:51:01 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:51:01 INFO - u'jsshell-mac.zip'], 15:51:01 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:51:01 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 15:51:01 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 15:51:01 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:51:01 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 15:51:01 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:51:01 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 15:51:01 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:51:01 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 15:51:01 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:51:01 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 15:51:01 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:01 INFO - trying https://queue.taskcluster.net/v1/task/L8LmHO6mSFGTmFh1kM0wRA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 15:51:01 INFO - Downloading https://queue.taskcluster.net/v1/task/L8LmHO6mSFGTmFh1kM0wRA/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 15:51:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L8LmHO6mSFGTmFh1kM0wRA/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 15:51:02 INFO - Downloaded 16399944 bytes. 15:51:02 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 15:51:09 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 15:51:09 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')]} 15:51:09 INFO - trying https://queue.taskcluster.net/v1/task/L8LmHO6mSFGTmFh1kM0wRA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 15:51:09 INFO - Downloading https://queue.taskcluster.net/v1/task/L8LmHO6mSFGTmFh1kM0wRA/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 15:51:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L8LmHO6mSFGTmFh1kM0wRA/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 15:51:10 INFO - Downloaded 16399944 bytes. 15:51:10 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 15:51:17 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')]} 15:51:17 INFO - trying https://queue.taskcluster.net/v1/task/L8LmHO6mSFGTmFh1kM0wRA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 15:51:17 INFO - Downloading https://queue.taskcluster.net/v1/task/L8LmHO6mSFGTmFh1kM0wRA/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 15:51:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L8LmHO6mSFGTmFh1kM0wRA/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 15:51:18 INFO - Downloaded 14413998 bytes. 15:51:18 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 15:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:18 INFO - trying https://queue.taskcluster.net/v1/task/L8LmHO6mSFGTmFh1kM0wRA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 15:51:18 INFO - Downloading https://queue.taskcluster.net/v1/task/L8LmHO6mSFGTmFh1kM0wRA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 15:51:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L8LmHO6mSFGTmFh1kM0wRA/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 15:51:21 INFO - Downloaded 111485906 bytes. 15:51:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L8LmHO6mSFGTmFh1kM0wRA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 15:51:21 INFO - mkdir: /builds/slave/test/properties 15:51:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:51:21 INFO - Writing to file /builds/slave/test/properties/build_url 15:51:21 INFO - Contents: 15:51:21 INFO - build_url:https://queue.taskcluster.net/v1/task/L8LmHO6mSFGTmFh1kM0wRA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 15:51:22 INFO - Running post-action listener: _resource_record_post_action 15:51:22 INFO - Running post-action listener: set_extra_try_arguments 15:51:22 INFO - [mozharness: 2016-09-02 22:51:22.415735Z] Finished download-and-extract step (success) 15:51:22 INFO - [mozharness: 2016-09-02 22:51:22.415863Z] Running populate-webroot step. 15:51:22 INFO - Running pre-action listener: _resource_record_pre_action 15:51:22 INFO - Running main action method: populate_webroot 15:51:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:51:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:51:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:51:22 INFO - '--tppagecycles', 15:51:22 INFO - '7'], 15:51:22 INFO - 'tests': ['tsvgm']}}, 15:51:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:51:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:51:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:51:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:51:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:51:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:51:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:22 INFO - 'talos_options': ['--disable-e10s'], 15:51:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:22 INFO - 'talos_options': ['--disable-e10s'], 15:51:22 INFO - 'tests': ['damp', 'tps']}, 15:51:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:22 INFO - 'tests': ['damp', 'tps']}, 15:51:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:51:22 INFO - 'tests': ['dromaeo_dom']}, 15:51:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:51:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:51:22 INFO - 'tests': ['basic_compositor_video']}, 15:51:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:51:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:51:22 INFO - 'tests': ['a11yr', 15:51:22 INFO - 'ts_paint', 15:51:22 INFO - 'tpaint', 15:51:22 INFO - 'sessionrestore', 15:51:22 INFO - 'sessionrestore_no_auto_restore', 15:51:22 INFO - 'tabpaint']}, 15:51:22 INFO - 'other-e10s': {'tests': ['a11yr', 15:51:22 INFO - 'ts_paint', 15:51:22 INFO - 'tpaint', 15:51:22 INFO - 'sessionrestore', 15:51:22 INFO - 'sessionrestore_no_auto_restore', 15:51:22 INFO - 'tabpaint']}, 15:51:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:51:22 INFO - 'ts_paint', 15:51:22 INFO - 'tpaint', 15:51:22 INFO - 'sessionrestore', 15:51:22 INFO - 'sessionrestore_no_auto_restore', 15:51:22 INFO - 'tabpaint']}, 15:51:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:51:22 INFO - 'ts_paint', 15:51:22 INFO - 'tpaint', 15:51:22 INFO - 'sessionrestore', 15:51:22 INFO - 'sessionrestore_no_auto_restore', 15:51:22 INFO - 'tabpaint']}, 15:51:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:51:22 INFO - 'tests': ['a11yr', 15:51:22 INFO - 'ts_paint', 15:51:22 INFO - 'tpaint', 15:51:22 INFO - 'sessionrestore', 15:51:22 INFO - 'sessionrestore_no_auto_restore', 15:51:22 INFO - 'tabpaint']}, 15:51:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:51:22 INFO - 'tests': ['a11yr', 15:51:22 INFO - 'ts_paint', 15:51:22 INFO - 'tpaint', 15:51:22 INFO - 'sessionrestore', 15:51:22 INFO - 'sessionrestore_no_auto_restore', 15:51:22 INFO - 'tabpaint']}, 15:51:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:51:22 INFO - 'tests': ['tsvgx', 15:51:22 INFO - 'tsvgr_opacity', 15:51:22 INFO - 'tart', 15:51:22 INFO - 'tscrollx', 15:51:22 INFO - 'cart']}, 15:51:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:51:22 INFO - 'tsvgr_opacity', 15:51:22 INFO - 'tart', 15:51:22 INFO - 'tscrollx', 15:51:22 INFO - 'cart']}, 15:51:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:22 INFO - 'talos_options': ['--disable-e10s'], 15:51:22 INFO - 'tests': ['tp5o']}, 15:51:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:22 INFO - 'tests': ['tp5o']}, 15:51:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:22 INFO - 'talos_options': ['--disable-e10s', 15:51:22 INFO - '--xperf_path', 15:51:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:22 INFO - 'tests': ['tp5n']}, 15:51:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:22 INFO - 'talos_options': ['--xperf_path', 15:51:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:22 INFO - 'tests': ['tp5n']}}, 15:51:22 INFO - 'talos.zip': {'path': '', 15:51:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:51:22 INFO - Running post-action listener: _resource_record_post_action 15:51:22 INFO - [mozharness: 2016-09-02 22:51:22.434225Z] Finished populate-webroot step (success) 15:51:22 INFO - [mozharness: 2016-09-02 22:51:22.434364Z] Running create-virtualenv step. 15:51:22 INFO - Running pre-action listener: _resource_record_pre_action 15:51:22 INFO - Running main action method: create_virtualenv 15:51:22 INFO - Creating virtualenv /builds/slave/test/build/venv 15:51:22 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 15:51:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:51:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:51:22 INFO - Using real prefix '/tools/python27' 15:51:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:51:23 INFO - Installing distribute.............................................................................................................................................................................................done. 15:51:26 INFO - Installing pip.................done. 15:51:26 INFO - Return code: 0 15:51:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:51:26 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')]} 15:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:26 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')]} 15:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:26 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 0x10abf7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac8c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee63591540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5bd30>, '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 0x10a8c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab53b20>, '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.USaz5zP99U/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.FMlTO3qnoW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 15:51:26 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 15:51:26 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 15:51:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.USaz5zP99U/Render', 15:51:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:26 INFO - 'HOME': '/Users/cltbld', 15:51:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:26 INFO - 'LOGNAME': 'cltbld', 15:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:26 INFO - 'MOZ_NO_REMOTE': '1', 15:51:26 INFO - 'NO_EM_RESTART': '1', 15:51:26 INFO - 'PAGER': '/bin/cat', 15:51:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:26 INFO - 'PWD': '/builds/slave/test', 15:51:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:26 INFO - 'SHELL': '/bin/bash', 15:51:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FMlTO3qnoW/Listeners', 15:51:26 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 15:51:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:26 INFO - 'USER': 'cltbld', 15:51:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:26 INFO - 'XPC_FLAGS': '0x0', 15:51:26 INFO - 'XPC_SERVICE_NAME': '0', 15:51:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:26 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 15:51:26 INFO - Cleaning up... 15:51:26 INFO - Return code: 0 15:51:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:51:26 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')]} 15:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:26 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')]} 15:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:26 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 0x10abf7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac8c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee63591540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5bd30>, '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 0x10a8c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab53b20>, '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.USaz5zP99U/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.FMlTO3qnoW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 15:51:26 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 15:51:26 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 15:51:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.USaz5zP99U/Render', 15:51:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:26 INFO - 'HOME': '/Users/cltbld', 15:51:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:26 INFO - 'LOGNAME': 'cltbld', 15:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:26 INFO - 'MOZ_NO_REMOTE': '1', 15:51:26 INFO - 'NO_EM_RESTART': '1', 15:51:26 INFO - 'PAGER': '/bin/cat', 15:51:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:26 INFO - 'PWD': '/builds/slave/test', 15:51:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:26 INFO - 'SHELL': '/bin/bash', 15:51:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FMlTO3qnoW/Listeners', 15:51:26 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 15:51:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:26 INFO - 'USER': 'cltbld', 15:51:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:26 INFO - 'XPC_FLAGS': '0x0', 15:51:26 INFO - 'XPC_SERVICE_NAME': '0', 15:51:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:26 INFO - Downloading/unpacking psutil>=3.1.1 15:51:26 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 15:51:26 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 15:51:26 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 15:51:26 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 15:51:26 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 15:51:26 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 15:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:51:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:29 INFO - Installing collected packages: psutil 15:51:29 INFO - Running setup.py install for psutil 15:51:29 INFO - building 'psutil._psutil_osx' extension 15:51:29 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 15:51:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:51:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:51:30 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 15:51:30 INFO - building 'psutil._psutil_posix' extension 15:51:30 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 15:51:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:51:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:51:30 INFO - ^ 15:51:30 INFO - 1 warning generated. 15:51:30 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 15:51:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:30 INFO - Successfully installed psutil 15:51:30 INFO - Cleaning up... 15:51:30 INFO - Return code: 0 15:51:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:30 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 0x10abf7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac8c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee63591540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5bd30>, '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 0x10a8c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab53b20>, '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.USaz5zP99U/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.FMlTO3qnoW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 15:51:30 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 15:51:30 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 15:51:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.USaz5zP99U/Render', 15:51:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:30 INFO - 'HOME': '/Users/cltbld', 15:51:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:30 INFO - 'LOGNAME': 'cltbld', 15:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:30 INFO - 'MOZ_NO_REMOTE': '1', 15:51:30 INFO - 'NO_EM_RESTART': '1', 15:51:30 INFO - 'PAGER': '/bin/cat', 15:51:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:30 INFO - 'PWD': '/builds/slave/test', 15:51:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:30 INFO - 'SHELL': '/bin/bash', 15:51:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FMlTO3qnoW/Listeners', 15:51:30 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 15:51:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:30 INFO - 'USER': 'cltbld', 15:51:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:30 INFO - 'XPC_FLAGS': '0x0', 15:51:30 INFO - 'XPC_SERVICE_NAME': '0', 15:51:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:51:33 INFO - Installing collected packages: mozsystemmonitor 15:51:33 INFO - Running setup.py install for mozsystemmonitor 15:51:33 INFO - Successfully installed mozsystemmonitor 15:51:33 INFO - Cleaning up... 15:51:33 INFO - Return code: 0 15:51:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10abf7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac8c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee63591540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5bd30>, '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 0x10a8c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab53b20>, '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.USaz5zP99U/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.FMlTO3qnoW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 15:51:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:51:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.USaz5zP99U/Render', 15:51:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:34 INFO - 'HOME': '/Users/cltbld', 15:51:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:34 INFO - 'LOGNAME': 'cltbld', 15:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:34 INFO - 'MOZ_NO_REMOTE': '1', 15:51:34 INFO - 'NO_EM_RESTART': '1', 15:51:34 INFO - 'PAGER': '/bin/cat', 15:51:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:34 INFO - 'PWD': '/builds/slave/test', 15:51:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:34 INFO - 'SHELL': '/bin/bash', 15:51:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FMlTO3qnoW/Listeners', 15:51:34 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 15:51:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:34 INFO - 'USER': 'cltbld', 15:51:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:34 INFO - 'XPC_FLAGS': '0x0', 15:51:34 INFO - 'XPC_SERVICE_NAME': '0', 15:51:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:34 INFO - Downloading/unpacking jsonschema==2.5.1 15:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:51:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:51:36 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 15:51:36 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 15:51:36 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 15:51:36 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 15:51:36 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 15:51:36 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 15:51:37 INFO - Downloading functools32-3.2.3-2.tar.gz 15:51:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:51:37 INFO - warning: no files found matching '*.txt' 15:51:37 INFO - no previously-included directories found matching 'build' 15:51:37 INFO - no previously-included directories found matching 'dist' 15:51:37 INFO - no previously-included directories found matching '.git*' 15:51:37 INFO - Installing collected packages: jsonschema, functools32 15:51:37 INFO - Running setup.py install for functools32 15:51:37 INFO - warning: no files found matching '*.txt' 15:51:37 INFO - no previously-included directories found matching 'build' 15:51:37 INFO - no previously-included directories found matching 'dist' 15:51:37 INFO - no previously-included directories found matching '.git*' 15:51:37 INFO - Successfully installed jsonschema functools32 15:51:37 INFO - Cleaning up... 15:51:37 INFO - Return code: 0 15:51:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:51:37 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')]} 15:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:37 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')]} 15:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:37 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 0x10abf7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac8c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee63591540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5bd30>, '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 0x10a8c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab53b20>, '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.USaz5zP99U/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.FMlTO3qnoW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 15:51:37 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 15:51:37 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 15:51:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.USaz5zP99U/Render', 15:51:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:37 INFO - 'HOME': '/Users/cltbld', 15:51:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:37 INFO - 'LOGNAME': 'cltbld', 15:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:37 INFO - 'MOZ_NO_REMOTE': '1', 15:51:37 INFO - 'NO_EM_RESTART': '1', 15:51:37 INFO - 'PAGER': '/bin/cat', 15:51:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:37 INFO - 'PWD': '/builds/slave/test', 15:51:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:37 INFO - 'SHELL': '/bin/bash', 15:51:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FMlTO3qnoW/Listeners', 15:51:37 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 15:51:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:37 INFO - 'USER': 'cltbld', 15:51:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:37 INFO - 'XPC_FLAGS': '0x0', 15:51:37 INFO - 'XPC_SERVICE_NAME': '0', 15:51:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:51:37 INFO - Cleaning up... 15:51:37 INFO - Return code: 0 15:51:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:51:37 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')]} 15:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:37 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')]} 15:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:37 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 0x10abf7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac8c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee63591540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5bd30>, '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 0x10a8c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab53b20>, '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.USaz5zP99U/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.FMlTO3qnoW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 15:51:37 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 15:51:37 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 15:51:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.USaz5zP99U/Render', 15:51:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:37 INFO - 'HOME': '/Users/cltbld', 15:51:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:37 INFO - 'LOGNAME': 'cltbld', 15:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:37 INFO - 'MOZ_NO_REMOTE': '1', 15:51:37 INFO - 'NO_EM_RESTART': '1', 15:51:37 INFO - 'PAGER': '/bin/cat', 15:51:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:37 INFO - 'PWD': '/builds/slave/test', 15:51:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:37 INFO - 'SHELL': '/bin/bash', 15:51:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FMlTO3qnoW/Listeners', 15:51:37 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 15:51:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:37 INFO - 'USER': 'cltbld', 15:51:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:37 INFO - 'XPC_FLAGS': '0x0', 15:51:37 INFO - 'XPC_SERVICE_NAME': '0', 15:51:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:38 INFO - Downloading/unpacking blobuploader==1.2.4 15:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:40 INFO - Downloading blobuploader-1.2.4.tar.gz 15:51:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:51:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:51:40 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 15:51:40 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 15:51:40 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 15:51:40 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 15:51:40 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 15:51:40 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 15:51:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:51:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:41 INFO - Downloading docopt-0.6.1.tar.gz 15:51:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:51:41 INFO - Installing collected packages: blobuploader, requests, docopt 15:51:41 INFO - Running setup.py install for blobuploader 15:51:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:51:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:51:41 INFO - Running setup.py install for requests 15:51:42 INFO - Running setup.py install for docopt 15:51:42 INFO - Successfully installed blobuploader requests docopt 15:51:42 INFO - Cleaning up... 15:51:42 INFO - Return code: 0 15:51:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:42 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 0x10abf7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac8c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee63591540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5bd30>, '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 0x10a8c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab53b20>, '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.USaz5zP99U/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.FMlTO3qnoW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 15:51:42 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 15:51:42 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 15:51:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.USaz5zP99U/Render', 15:51:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:42 INFO - 'HOME': '/Users/cltbld', 15:51:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:42 INFO - 'LOGNAME': 'cltbld', 15:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:42 INFO - 'MOZ_NO_REMOTE': '1', 15:51:42 INFO - 'NO_EM_RESTART': '1', 15:51:42 INFO - 'PAGER': '/bin/cat', 15:51:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:42 INFO - 'PWD': '/builds/slave/test', 15:51:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:42 INFO - 'SHELL': '/bin/bash', 15:51:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FMlTO3qnoW/Listeners', 15:51:42 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 15:51:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:42 INFO - 'USER': 'cltbld', 15:51:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:42 INFO - 'XPC_FLAGS': '0x0', 15:51:42 INFO - 'XPC_SERVICE_NAME': '0', 15:51:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:42 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-sfHR8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:43 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-PPTPmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:43 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-GGzm5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:43 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-yn_Ud6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:43 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-gEBUWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:43 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-39Nb6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:43 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-XT8Psk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:43 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-pi7WgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:43 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-d8cLCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:43 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-WW2bMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:43 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-Nr7n5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:44 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-4moGmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:44 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-uBMvqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:44 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-9iM4II-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:44 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-M6Vy2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:44 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-wasIJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:44 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-RFK7Hq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:51:44 INFO - Running setup.py install for manifestparser 15:51:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:51:44 INFO - Running setup.py install for mozcrash 15:51:45 INFO - Running setup.py install for mozdebug 15:51:45 INFO - Running setup.py install for mozdevice 15:51:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:51:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:51:45 INFO - Running setup.py install for mozfile 15:51:45 INFO - Running setup.py install for mozhttpd 15:51:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:51:45 INFO - Running setup.py install for mozinfo 15:51:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:51:45 INFO - Running setup.py install for mozInstall 15:51:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:51:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:51:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:51:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:51:45 INFO - Running setup.py install for mozleak 15:51:46 INFO - Running setup.py install for mozlog 15:51:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:51:46 INFO - Running setup.py install for moznetwork 15:51:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:51:46 INFO - Running setup.py install for mozprocess 15:51:46 INFO - Running setup.py install for mozprofile 15:51:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:51:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:51:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:51:46 INFO - Running setup.py install for mozrunner 15:51:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:51:46 INFO - Running setup.py install for mozscreenshot 15:51:46 INFO - Running setup.py install for moztest 15:51:47 INFO - Running setup.py install for mozversion 15:51:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:51:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:51:47 INFO - Cleaning up... 15:51:47 INFO - Return code: 0 15:51:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:47 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')]} 15:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:47 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')]} 15:51:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:47 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 0x10abf7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac8c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee63591540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5bd30>, '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 0x10a8c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab53b20>, '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.USaz5zP99U/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.FMlTO3qnoW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 15:51:47 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 15:51:47 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 15:51:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.USaz5zP99U/Render', 15:51:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:47 INFO - 'HOME': '/Users/cltbld', 15:51:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:47 INFO - 'LOGNAME': 'cltbld', 15:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:47 INFO - 'MOZ_NO_REMOTE': '1', 15:51:47 INFO - 'NO_EM_RESTART': '1', 15:51:47 INFO - 'PAGER': '/bin/cat', 15:51:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:47 INFO - 'PWD': '/builds/slave/test', 15:51:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:47 INFO - 'SHELL': '/bin/bash', 15:51:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FMlTO3qnoW/Listeners', 15:51:47 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 15:51:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:47 INFO - 'USER': 'cltbld', 15:51:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:47 INFO - 'XPC_FLAGS': '0x0', 15:51:47 INFO - 'XPC_SERVICE_NAME': '0', 15:51:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:47 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-WZx4UN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:47 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)) 15:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:47 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-3tBuK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:47 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)) 15:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:47 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-ZlAFgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:47 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)) 15:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:47 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-qALgLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:47 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)) 15:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:47 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-noJQw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:48 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)) 15:51:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:48 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-rnAzb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:48 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)) 15:51:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:48 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-_7SWlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:48 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)) 15:51:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:48 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-5gshi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:48 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)) 15:51:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:48 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-dkgis4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:48 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)) 15:51:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:48 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-xrExab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:48 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)) 15:51:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:48 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-dCxZ9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:48 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)) 15:51:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:48 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-FzRSlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:48 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)) 15:51:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:48 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-Lrj3Nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:48 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)) 15:51:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:48 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-FkfwvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:49 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)) 15:51:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:49 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-VZPjMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:49 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)) 15:51:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:49 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-CWYYvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:49 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)) 15:51:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:49 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-ZsIpl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:49 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)) 15:51:49 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)) 15:51:49 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)) 15:51:49 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)) 15:51:49 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)) 15:51:49 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)) 15:51:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51:51 INFO - Downloading blessings-1.6.tar.gz 15:51:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:51:51 INFO - Installing collected packages: blessings 15:51:51 INFO - Running setup.py install for blessings 15:51:52 INFO - Successfully installed blessings 15:51:52 INFO - Cleaning up... 15:51:52 INFO - Return code: 0 15:51:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:51:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:52 INFO - Reading from file tmpfile_stdout 15:51:52 INFO - Current package versions: 15:51:52 INFO - blessings == 1.6 15:51:52 INFO - blobuploader == 1.2.4 15:51:52 INFO - docopt == 0.6.1 15:51:52 INFO - functools32 == 3.2.3-2 15:51:52 INFO - jsonschema == 2.5.1 15:51:52 INFO - manifestparser == 1.1 15:51:52 INFO - mozInstall == 1.12 15:51:52 INFO - mozcrash == 0.17 15:51:52 INFO - mozdebug == 0.1 15:51:52 INFO - mozdevice == 0.48 15:51:52 INFO - mozfile == 1.2 15:51:52 INFO - mozhttpd == 0.7 15:51:52 INFO - mozinfo == 0.9 15:51:52 INFO - mozleak == 0.1 15:51:52 INFO - mozlog == 3.3 15:51:52 INFO - moznetwork == 0.27 15:51:52 INFO - mozprocess == 0.23 15:51:52 INFO - mozprofile == 0.28 15:51:52 INFO - mozrunner == 6.12 15:51:52 INFO - mozscreenshot == 0.1 15:51:52 INFO - mozsystemmonitor == 0.3 15:51:52 INFO - moztest == 0.7 15:51:52 INFO - mozversion == 1.4 15:51:52 INFO - psutil == 3.1.1 15:51:52 INFO - requests == 1.2.3 15:51:52 INFO - wsgiref == 0.1.2 15:51:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:52 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')]} 15:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:52 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')]} 15:51:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:52 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 0x10abf7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac8c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee63591540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5bd30>, '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 0x10a8c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab53b20>, '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.USaz5zP99U/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.FMlTO3qnoW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 15:51:52 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 15:51:52 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 15:51:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.USaz5zP99U/Render', 15:51:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:52 INFO - 'HOME': '/Users/cltbld', 15:51:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:52 INFO - 'LOGNAME': 'cltbld', 15:51:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:52 INFO - 'MOZ_NO_REMOTE': '1', 15:51:52 INFO - 'NO_EM_RESTART': '1', 15:51:52 INFO - 'PAGER': '/bin/cat', 15:51:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:52 INFO - 'PWD': '/builds/slave/test', 15:51:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:52 INFO - 'SHELL': '/bin/bash', 15:51:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FMlTO3qnoW/Listeners', 15:51:52 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 15:51:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:52 INFO - 'USER': 'cltbld', 15:51:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:52 INFO - 'XPC_FLAGS': '0x0', 15:51:52 INFO - 'XPC_SERVICE_NAME': '0', 15:51:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:53 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)) 15:51:53 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)) 15:51:53 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)) 15:51:53 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)) 15:51:53 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)) 15:51:53 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)) 15:51:53 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)) 15:51:53 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)) 15:51:53 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)) 15:51:53 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)) 15:51:53 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)) 15:51:53 INFO - Cleaning up... 15:51:53 INFO - Return code: 0 15:51:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10abf7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac8c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee63591540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5bd30>, '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 0x10a8c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab53b20>, '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.USaz5zP99U/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.FMlTO3qnoW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 15:51: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', 'jsonschema'] in /builds/slave/test/build 15:51: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 jsonschema 15:51:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.USaz5zP99U/Render', 15:51:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:53 INFO - 'HOME': '/Users/cltbld', 15:51:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:53 INFO - 'LOGNAME': 'cltbld', 15:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:53 INFO - 'MOZ_NO_REMOTE': '1', 15:51:53 INFO - 'NO_EM_RESTART': '1', 15:51:53 INFO - 'PAGER': '/bin/cat', 15:51:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:53 INFO - 'PWD': '/builds/slave/test', 15:51:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:53 INFO - 'SHELL': '/bin/bash', 15:51:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FMlTO3qnoW/Listeners', 15:51:53 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 15:51:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:53 INFO - 'USER': 'cltbld', 15:51:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:53 INFO - 'XPC_FLAGS': '0x0', 15:51:53 INFO - 'XPC_SERVICE_NAME': '0', 15:51:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:51:53 INFO - Cleaning up... 15:51:53 INFO - Return code: 0 15:51:53 INFO - Running post-action listener: _resource_record_post_action 15:51:53 INFO - Running post-action listener: _start_resource_monitoring 15:51:53 INFO - Starting resource monitoring. 15:51:53 INFO - [mozharness: 2016-09-02 22:51:53.419145Z] Finished create-virtualenv step (success) 15:51:53 INFO - [mozharness: 2016-09-02 22:51:53.420109Z] Running install step. 15:51:53 INFO - Running pre-action listener: _resource_record_pre_action 15:51:53 INFO - Running main action method: install 15:51:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:53 INFO - Reading from file tmpfile_stdout 15:51:53 INFO - Detecting whether we're running mozinstall >=1.0... 15:51:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:51:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:51:53 INFO - Reading from file tmpfile_stdout 15:51:53 INFO - Output received: 15:51:53 INFO - Usage: mozinstall [options] installer 15:51:53 INFO - Options: 15:51:53 INFO - -h, --help show this help message and exit 15:51:53 INFO - -d DEST, --destination=DEST 15:51:53 INFO - Directory to install application into. [default: 15:51:53 INFO - "/builds/slave/test"] 15:51:53 INFO - --app=APP Application being installed. [default: firefox] 15:51:53 INFO - mkdir: /builds/slave/test/build/application 15:51:53 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'] 15:51:53 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 15:52:28 INFO - Reading from file tmpfile_stdout 15:52:28 INFO - Output received: 15:52:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:52:28 INFO - Running post-action listener: _resource_record_post_action 15:52:28 INFO - [mozharness: 2016-09-02 22:52:28.085293Z] Finished install step (success) 15:52:28 INFO - [mozharness: 2016-09-02 22:52:28.085412Z] Running run-tests step. 15:52:28 INFO - Running pre-action listener: _resource_record_pre_action 15:52:28 INFO - Running main action method: run_tests 15:52:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:52:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:52:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:52:28 INFO - 2016-09-02 15:52:28.098 screenresolution[1634:7270] starting screenresolution argv=screenresolution get 15:52:28 INFO - 2016-09-02 15:52:28.100 screenresolution[1634:7270] Display 0: 1600x1200x32@60 15:52:28 INFO - 2016-09-02 15:52:28.105 screenresolution[1635:7272] starting screenresolution argv=screenresolution list 15:52:28 INFO - Available Modes on Display 0 15:52:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:52:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:52:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:52:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:52:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:52:28 INFO - Intel Iris: 15:52:28 INFO - Chipset Model: Intel Iris 15:52:28 INFO - Type: GPU 15:52:28 INFO - Bus: Built-In 15:52:28 INFO - VRAM (Dynamic, Max): 1536 MB 15:52:28 INFO - Vendor: Intel (0x8086) 15:52:28 INFO - Device ID: 0x0a2e 15:52:28 INFO - Revision ID: 0x0009 15:52:28 INFO - Displays: 15:52:28 INFO - Display: 15:52:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:52:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:52:28 INFO - Display Serial Number: 1600x1200 60 15:52:28 INFO - Main Display: Yes 15:52:28 INFO - Mirror: Off 15:52:28 INFO - Online: Yes 15:52:28 INFO - Rotation: Supported 15:52:28 INFO - Return code: 0 15:52:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:52:28 INFO - Python 2.7.3 15:52:28 INFO - Return code: 0 15:52:28 INFO - grabbing minidump binary from tooltool 15:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:52:28 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5bd30>, '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 0x10a8c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab53b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:52:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:52:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 15:52:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:52:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:52:28 INFO - Return code: 0 15:52:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:52:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:52:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:52:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:52:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:52:28 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/L8LmHO6mSFGTmFh1kM0wRA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0337', '--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 15:52:28 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/L8LmHO6mSFGTmFh1kM0wRA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0337 --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 15:52:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.USaz5zP99U/Render', 15:52:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:52:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:52:28 INFO - 'HOME': '/Users/cltbld', 15:52:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:52:28 INFO - 'LOGNAME': 'cltbld', 15:52:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:52:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:28 INFO - 'MOZ_NO_REMOTE': '1', 15:52:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:52:28 INFO - 'NO_EM_RESTART': '1', 15:52:28 INFO - 'PAGER': '/bin/cat', 15:52:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:28 INFO - 'PWD': '/builds/slave/test', 15:52:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:52:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:52:28 INFO - 'SHELL': '/bin/bash', 15:52:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FMlTO3qnoW/Listeners', 15:52:28 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 15:52:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:52:28 INFO - 'USER': 'cltbld', 15:52:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:52:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:28 INFO - 'XPC_FLAGS': '0x0', 15:52:28 INFO - 'XPC_SERVICE_NAME': '0', 15:52:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:52:28 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/L8LmHO6mSFGTmFh1kM0wRA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0337', '--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 15:52:28 INFO - mozversion application_buildid: 20160902133349 15:52:28 INFO - mozversion application_changeset: d0830980ffdb36a10855d02a588b4869cad6707e 15:52:28 INFO - mozversion application_display_name: Nightly 15:52:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:52:28 INFO - mozversion application_name: Firefox 15:52:28 INFO - mozversion application_remotingname: firefox 15:52:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:52:28 INFO - mozversion application_vendor: Mozilla 15:52:28 INFO - mozversion application_version: 51.0a1 15:52:28 INFO - mozversion platform_buildid: 20160902133349 15:52:28 INFO - mozversion platform_changeset: d0830980ffdb36a10855d02a588b4869cad6707e 15:52:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:52:28 INFO - mozversion platform_version: 51.0a1 15:52:28 INFO - using testdate: 1472856748 15:52:28 INFO - actual date: 1472856748 15:52:28 INFO - starting webserver on 'localhost:49266' 15:52:28 INFO - SUITE-START | Running 2 tests 15:52:28 INFO - TEST-START | dromaeo_css 15:52:28 INFO - operating with platform_type : mac_ 15:52:28 INFO - Initialising browser for dromaeo_css test... 15:52:28 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmp2LrpPd/profile http://localhost:49266/getInfo.html) 15:52:31 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 15:52:31 INFO - PROCESS | 1645 | colorDepth:24 15:52:31 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 15:52:31 INFO - PROCESS | 1645 | __metrics 15:52:31 ERROR - PROCESS | 1645 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 15:52:32 INFO - TEST-INFO | 1645: exit 0 15:52:32 INFO - Browser initialized. 15:52:32 INFO - Running cycle 1/1 for dromaeo_css test... 15:52:32 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmp2LrpPd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:52:44 INFO - PROCESS | 1648 | RSS: Main: 245284864 15:52:44 INFO - PROCESS | 1648 | 15:53:33 INFO - PROCESS | 1648 | 1472856813870 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] 15:55:45 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 15:55:47 INFO - PROCESS | 1648 | RSS: Main: 263200768 15:55:47 INFO - PROCESS | 1648 | 15:58:49 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 15:58:50 INFO - PROCESS | 1648 | RSS: Main: 267538432 15:58:50 INFO - PROCESS | 1648 | 16:01:52 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 16:01:52 INFO - PROCESS | 1648 | RSS: Main: 273170432 16:01:52 INFO - PROCESS | 1648 | 16:04:54 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 16:04:55 INFO - PROCESS | 1648 | RSS: Main: 269426688 16:04:55 INFO - PROCESS | 1648 | 16:07:57 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 16:07:58 INFO - PROCESS | 1648 | RSS: Main: 275021824 16:07:58 INFO - PROCESS | 1648 | 16:11:01 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 16:11:01 INFO - PROCESS | 1648 | RSS: Main: 277884928 16:11:01 INFO - PROCESS | 1648 | 16:11:01 INFO - PROCESS | 1648 | __start_tp_report 16:11:01 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 16:11:01 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 16:11:01 INFO - PROCESS | 1648 | |i|pagename|runs| 16:11:01 INFO - PROCESS | 1648 | |0;dojo.html;3370.730341572674;3373.2578832656836;3383.3571621391934;3401.5748031496064;3421.1447138215444;4659.277811939155;4910.803567857286;5549.890021995602;5730.283714535678;5757.366689664133;5566.721663916808;5612.522935550483;5709.143628455734;5766.913496297559;5849.327327357355;3834.5973672764376;5149.30484384608;5171.4311425743135;5329.094054010808;5374.516293533581;5119.129747942859;5345.09133447313;5404.729763511828;5405.594580406466;5414.566834653238;4132.29750942339;5067.518585734386;5179.792808287664;5272.868178295574;5312.2828418163635;5122.180451127839;5156.74216289184;5157.767900444452;5183.663061901002;5213.478652134794;5217.6608520446425;5229.895402091975;5248.343957005374;5255.343082114736;5259.447757985395;4933.55597996182;5624;5688.97598432282;5745.913811292834;5765.855853603652;6158.9692051539905;6212.1303017577575;6238.656873871935;6247.9062814057825;6257.87484250317;6280.811575652738;6300.527460440485;6311.147995020705;6318.620882747004;6319.462845658125;5732.226149469851;5810.796622118206;5860.853478663025;5873.471387575053;5882.529397648178;6333.714982825784;6335.714892829834;6341.587796793194;6350.33321501245;6376.840578985562;6148.1392605035335;6169.691515424211;6194.659293738798;6196.411340922605;6230.501559875199;6121.788327166048;6179.28938172116;6204.627722336674;6233.065040244;6290.937090629127;5754.798582049608;6091.329953705089;6123.632582045003;6123.801220575414;6206.844828879314;6166.167567378347;6190.969045154836;6202.81391558254;6208.068789681584;6215;4902.950970490321;4928.852134435972;4929.728864912393;4934.284528743384;4972.0801651694555;4387.5393083726385;4445.799939002753;4446.177457170434;4497.145542346943;4537.342085397665;5537.529310008614;5625.943740562542;5745;5763.6541807491685;5764.279465066867;4881.780319885543;6154.661493617805;6178.783742568989;6284.308726040132;6296.43332100104;5740.282464691913;5773.076307790733;5796.594238403356;5806.332271788714;5883.294004719375;5433.185022246695;5433.538149257279;5446.972765136228;5453.809116680897;5485.780568777204;6172.475339596005;6274.717637706405;6412.871742565123;6451.161349024596;6481.449076828522;6188.2883468399905;6259.280182778856;6268.310485846462;6270.4670103039925;6291.119243306032;6343.143675603919;6378.425941665087;6382.138411314413;6388.840278993062;6410.0705397718;6107.206063211754;6144.2488890665945;6163.075538669235;6235.158253635701;6253.7185826637;6213.254409470893;6262.624242545462;6273.592216505913;6291.339409361951;6292.27638821523;6122.418370254819;6193.628382297076;6198.132261483306;6209.223847019122;6230.937690623217;6014.759409623566;6033.245844269466;6062.514998800174;6223.657698826608;6230.6884655767935;5000.549950504472;5783.94216057834;5957.434043765836;6046.939530604814;6050.576459647782;6068.332483426731;6115.877682446415;6126.111713801563;6150.753969841336;6151.569390142647;5864.208331875142;5920.319163296276;5979.1031345296815;5982.222311099529;5984.820455386345 16:11:01 INFO - PROCESS | 1648 | |1;ext.html;505.1286530734481;507.92635067915154;508.99491005089914;520.8073012985195;548.8847342058168;31136.221594460123;41017.38473922894;41091.767246982636;41137.58862411375;41199.382009269844;41643;42296.577034229646;42304.365434518506;42317;42412.36381454273;9728.70813875583;9740.366876153063;9897.752556186117;9898.851517227247;9916.454594997273;9729.540568914685;9818.509074546244;9854.704358869245;9868.062534059252;9892.109710126088;9798.706038818847;9870.309078364517;9918.454485003322;9933.3543319684;9982.401055936667;8154.714584989497;9797.559109840075;9859.063388978035;9898.703038908845;9901.405915645013;9702.369345992558;9753.21974242059;9788.363756355886;9802.460864652441;9816.214702823758;40256.396154057715;40485.79757101225;40582.78251652455;40712.592874071175;40712.796436017925;3335.799852008863;3350.932981340384;3368.0401085690705;3389.57630296213;3399.847006884696;28751.856240718662;31277.530837037462;31309;32028.679713202804;32619.67380326214;3200.3439294944715;3220.72623826975;3225.7580681448985;3243.497257925025;3307.558217494314;474064;479733;481544;481729;482458.5877070627;48100.27849582259;57056.42943570511;57451;57453.71273143608;57633;33761.66238337585;34703.65296347004;34992.30015399729;62919;63081.36918630847;16508.009519428873;16656.41702540405;16694.91652541754;16727.498175054767;16973.811833171807;12829.743405131845;12854.871451285555;12915.612531624067;12949.158304710352;12952.546660866825;19226.519337016685;19289.421317360502;19346.80653193478;19357.806421935882;19433.708494372597;7853.371730261565;7984;8005.279524842792;8007.0391553014015;8043.305492660024;822.284612387227;917.202034230224;1007.1539906478594;1036.7149034015556;1038.8285932821152;28615.85692071526;29801;30305.545416818764;30343.848280758455;30543.541846872315;952.6570434643522;1002.7292630989592;1026.3174988632625;1075.370908018802;1100.6202860013443;15190;15631.3747450103;15798.526044218692;15860.20698965047;16268.837311626732;607043;612621;613355;613673;615532;42285.57714422878;57594.7120264396;58539.41460585425;58820.4117958815;58825.705871471226;1330.8203392542077;1342.2684636872928;1374.4433504430722;1375.5735721926035;1385.4942945824903;28583.713732881653;29184.854075729487;29294.56058159172;29404.558931615615;30296.394072117993;46661.533384665716;50928.23607645814;51050.48949510457;51105.48894511156;51284.48715512797;457963;538561;544540;545322;545936;24718.876405617855;26285.737142629096;26615.46769064569;26991.325216869736;27005.59491607667;44796;47060.52939470561;47180.29229561628;48189.03621927472;48603.756981214865;39196.608033920435;39209.82370528889;39510.80244598874;40693;40776.79611601923;39353.60646393499;39550;39778.2044359117;39819.88548151213;40774.38838417367;34207.14482137867;37973.620263797005;38214.6178538211;38433.615663843004;38565.22869542537;32975.835120824246;33128.33743325168;33201.833990830855;34929.825350873085;35201.82399087988;22467.550648987257;25372;25886.741132589188;25948.610770838073;26353.20940371792 16:11:01 INFO - PROCESS | 1648 | |2;jquery.html;357.94093974494206;363.86355116831186;364.9708023358132;373.3447799112557;390.2078780076446;19825.306114286002;20088.799112008877;21038.263660771878;21211.787882121193;21433.785662143375;20302.492437689067;20756;20764.48088797777;20809.479763005933;21143.259985900495;5780.913286300709;5833.504152147073;5865.648061116347;5985.670788106652;6136.877262454748;6163.691815409234;6202.255729312489;6202.875942481148;6203.875922481548;6205.81382558524;5992.280926288851;6141.969290153543;6175.814725558218;6176.444120029197;6189.814305570818;5908.911366329508;6134.38656134383;6178.629282243057;6179.38206179383;6255.030470277115;5773.076307790775;5911.408859114097;5934.1692163097205;5999.400059993965;6001.12983617373;13136.60590182296;13279.73440531184;23278.185263515697;24345;24365.390865228335;2328.092044102801;2334.395471727985;2349.835511514195;2386.2841147655636;2948.8967886123883;8859.955700221522;9627.855582166203;9916.504174791304;10033.698989030341;10444.79110417795;1838.6414649143424;1840.55826601616;1870.1397357215697;1877.0333278361518;1894.943151705451;97680;102342;112214.43892780565;118879.4056029723;120294.3911682651;9273.536323183815;9635.710928672152;9702.51487425626;9926.15627671656;10110;12118.636440906786;12243.326617035971;12275.693107672201;12350.567730129402;12364.505419783289;7915.485493442908;8041.718539851077;8061.919380806117;8145.167337349049;8173.959130204311;8398.328133749286;8414.453060551044;8470.872936905951;8562.400631955703;8571.52856592881;3246.983765081207;3439.7420193485586;3818.5608655004476;3856.8650097246464;3942.329803933338;1887.8489720822301;1919.8080191980969;1928.1034319041432;1930.3629802165533;1933.7969513201192;820.335528222142;855.8104235113198;913.4747520175926;941.5904081724472;946.186279799372;20772.1691132353;21710.891445542988;21876.343709688736;21923.890380548313;21930;751.8609057324412;813.4021494201875;835.995820020896;837.2130197614223;913.9360244782802;8059.798505037421;10819.567217311376;11339;11377.431128443544;11387.811412804427;531900;539921;541512;551196;551967;72938;102813;126956;127494.36252818862;128350;939.7979434421633;944.8299306124826;975.9414435133915;980;980.1472718734747;15615.921920390325;19048.904755476135;19198.8480691159;19208.903955480135;19262.614747704687;51530.96938061293;51761;52358.73820630873;52552;53865;50106.74946625243;75513.05060766048;76731.46537069339;78003;78586.6070669643;7682.884756728542;7853.37173026168;7903.209679032051;7975.960120199362;8029.1167971524255;6146.907796383147;7505.6997720090585;11295.830562541403;11656.650300491;12565.371731413576;6528.988006858945;7213.9278607213255;10000.799984000134;10141.695749127539;10425.957404259514;9416.387934784218;10035.24735644815;10208.672872526524;10310.226732994905;10409.803794535219;9826.459544725109;10106.242031847494;10598.629047983284;10716.35701857891;10850.782984340427;7674.424418168772;7732.536047837148;7878.566678832719;7892;7979.760607181794;10130.594776208869;10166.593336266467;10347.327423717434;10682.305650132717;10791.514381852678 16:11:01 INFO - PROCESS | 1648 | |3;mootools.html;1465.4358072142225;1501.737195990702;1720.9655806883864;1845.234227795465;1888.3579582941807;7654.770356889288;8006.119326874039;8502.659893604248;9091.318151138667;9093.181613654779;8681.21869031787;8900.243479304267;8937.285017198625;8947.06055864133;8968.596413161407;2379.3100000999734;2397.25685037638;2397.844140130886;2415.6738840256517;2418.7823095921362;2326.2323433267065;2334.11303704592;2413.746556611557;2417.6857008588945;2419.0565679385054;2389.689340385756;2396.101461951768;2396.688430504032;2406.109739396426;2407.458321877581;2352.3648614873887;2363.83453158279;2364.4443555764383;2375.2517956843626;2383.4875501767115;2033.4103110098054;2356.8232382571377;2372.6678265042906;2391.1630929174826;2406.4946361264156;8899.73300800977;8994.145556172152;8998.730038098802;9024.187823095886;9045.412048216911;5225.686458812484;5398.217258497496;5398.514133727944;5418.106012507931;5419.864503387407;3662.377395842713;3689.760165589228;3697.4638677391895;3739.3456145174487;3744.6068162843053;1084.8806631270554;1092.19177808422;1092.3882625729616;1096.369587487198;1107.0866535108487;11533.538658453652;11678.299302041905;11694.298342099417;11730.17888747788;11831.585894493737;4004.5795191505053;4601.976990115028;4699.483056863743;4875.098106850173;4880.219164933594;8666.176713212235;9537.14165725088;10040.397576145455;10066.748331291776;10235.897641023643;4629.837955671603;5343.145096784496;5350.250964864922;5362.302900622894;5378.408375078739;4459.732416055047;4763.404574428197;4898.608111351084;4905.043516514245;4931.7040977541465;3360.9245041586946;3863.1307955710304;4010.27814993304;4017.6384125428854;4019.9196016079513;1113.6269349767917;1294.5986744109357;1296.1056870759146;1314.18520517278;1317.1899281941537;825.5954582254652;889.4612320685251;892.7946572288411;909.6452383570413;959.1751094059103;5914.8817023659285;5946.910796338058;6063.151158837766;6096.847578810565;6188.783392581238;938.4697645830084;963.633819148733;967.5259123029665;979.4417182206074;1013.6806905824642;3902.453656488094;3947.9013024674614;4010.1378203685763;4024.859129930497;4099.487564054493;10364.222683298784;10738.35569865795;10740.624078157227;10769.515371808287;10783.460826958777;10043.296969212084;10343.689689309333;10595.523201455953;10763.3541987481;10818.67543973682;7779.844403112019;8035.955325807725;8098.190180981973;8297.709580164665;8355.122712115262;5363.570914326922;5961.91057134152;6020.65131056387;6033.577649564489;6269.749210031548;9837.803243935225;9940.204783617148;10009.199264058712;10155.492225388552;10211.642592509226;9960.701178964642;10129.797404051731;10184.439855808001;10275.948620256851;10294.3823370598;6458.967705161632;7418.072740907387;7568;7572.734954276574;7610;8101.432899696964;8214.301784348398;8270.131636178356;8274.13121622221;8289.461185022954;7388.630568471447;7503.5497870127965;7518.887216691644;7607.163212046781;7664.693412263447;7222.458315626454;7342.6695798688115;7371.963140184479;7412.9992451018425;7539.246075392417;6861.416779573592;6993.125859267591;6998.055262539492;7005.684744186422;7020.157581090098;4812.614990800657;4977.552020318189;5032.748362581783;5070.41690205631;5083.847484575469;5038.370203724535;5071.54356107952;5101.362329708786;5169.715665638276;5170.71561064145 16:11:01 INFO - PROCESS | 1648 | |4;prototype.html;255.37051168868734;283.46926596379546;293.608033275577;296.023123691817;308.66509836827044;5417.918731219035;5599.832005039845;5702.68635225063;5749.533868863439;5787.768489260435;4828.975855120728;5107.821226257081;5261.184516399964;5652.123920792274;5681.573881958849;3568.107973006748;4288.935665965005;4302.225599392108;4309.31051031835;4325.437693099892;3545.530988771818;3906.2187562487616;4266.978665106686;4355.912881742363;4358.782060896959;3464.873915977305;3688.3360995020885;4080.9183816323657;4215.124269699984;4222.725522841021;3740.775553466787;3986.800659967019;4024.102646094807;4267.8020819277945;4282.250606143913;3245.4482737934372;3694.390425579776;3694.9445758313645;3705.8702945397054;3712.573054098786;4678.672492925497;5055.646104772667;5464.316960379952;5491.835244942658;5561.860953476155;4629.444466664022;4898.853034408973;4916.164252077156;4931.80272789088;4944.777485013183;5034.4713805050305;5817.767289308423;6005.819825405245;6007.8632768982325;6075.726592303357;3862.613738626143;3994.400839874042;4007.458993035932;4052.4124002019544;4053;5363.704996225206;5561.944380556223;6217.595876247472;6313;6386.776462823826;3589.7307701921936;4089.20260549196;4100.405441211067;4105.938410923838;4109.404136400205;3927.6857851371824;4114.547399786021;4153.7300075495605;4157.23317590023;4161.521425036099;4258.1689873354135;4755.500672429414;4878.951025529528;4918.877028074256;4934.136526107916;5920.822375328747;5985.623306639497;6034.616326550988;6110.7861224856915;6118.877622447526;1356.2743931996336;1400.8879289656802;1411.1533080151826;1418.2908545727137;1418.5672470804354;761.4251240313639;772.1776308231715;842.8819965204876;862.8835107260566;884.6019291318804;4354.455693038371;4667.95332046682;4684.098036474067;4728.267118596623;4751.52484751529;4873.707577545359;5100.730175072132;5138.974305128525;5197.621545995134;5211.661242019257;4036.979815100906;4132.297509423405;4239.198340705188;4323.762193079411;4517.661175411791;2561;2995.5955945947017;3245.993741940006;3274.590676165479;3282.3763484937786;5681.431856814368;5964.284285885635;6126.989046807316;6454.774082907075;6456.8676047329745;4936.111499930047;5125.64120511568;6352.809415717536;6361.713722882481;6374.936250637527;5401.918971215435;5863.355030946593;6482.67586620667;6487.2215334159255;6498.220213574401;5419.891602168013;5821.505172060422;5889.911651325147;5961.330827368344;6277.18396608438;6080.604760690541;6171.814845554641;6190.969045154746;6215.751369945152;6227.875442491216;5781.566382521243;6213.813585592439;6426.7827599478105;6468.514861385321;6491.805245842632;3484.1986343141725;3692.157039079947;3972.8609498667406;4014.919701605893;4021.3565829467143;5408.8377348679605;6129.295131059806;6184.257889053342;6192.442680158807;6202.782902598387;5149.974250128876;5485.451454854642;5569.693666848362;6039.245094363205;6112.541559383153;4477.037436951071;4767.785449654843;5920.79277225295;5940.762369505172;5963.91054134197;5756.712164391847;5835.0080486318275;5844;5884.941150588439;5903.468687818117;5531.640443371168;5699.1451282306325;5901.380355062656;5944.762209511571;5958.76164953397;5321.787128514971;5797.4782269595935;5800.013997620499;5819.912701309399;5897.587168898136 16:11:01 INFO - PROCESS | 1648 | |5;yui.html;648;653.7711800869695;722.0396872160028;759.7986533568609;801.4990630855715;14668.633284167901;15832.604184895383;15849.366025358971;15861.048337099783;15898;14253.65039215786;14283.357248923798;14623.926880365583;14716.411343546271;14783.778243326358;855.4225897519166;859.7162936231028;870.5125129927229;871.485823364215;872.9519876406795;711.6192836832296;871.9302455803552;891.3404080980093;893.0756666849812;894.5035505294559;902.5442151713376;933.6778811310121;935.3172184305461;937.7374335186158;938.249400479617;933.4959122074072;934.8270569944548;938.2775263047415;938.7043081429327;939.2767568971922;672.1866541484809;689.7896141676787;690.7858563845174;691.4364792693939;692.0760784352894;14573.635659108608;14604.269786510738;15003.399864005427;15042;15049.774253386207;13626.318684065756;14221.63248734982;14258.144511329354;14321.283935803169;14554;11850.88149118515;11873.10951678619;11885.168038237327;12079.275243485332;12091.576794812227;3713.1459764254105;3794.354959656865;3814.7329686921926;3826.9234615307814;3933.0560665440375;109024;109336;110764.4461777686;112052.43973780079;112106;11021.944890275498;11027.724306892393;11035.83446248307;11057.612983545538;11197.49611267495;22454.438639034153;22556.436089097577;22663.773362266496;22727.431814204447;22761.544769104526;7943.761687149395;7946.6424010919645;8076.27313541784;8139.226773456512;8158.184181581794;4342.131573685276;4457.442819647544;4469.709468884512;4558.065596552765;4639.164950308977;3540.2742437800703;3573.5175751273764;3673.44898265257;3674;3688.2992231475932;636.5416899832113;638.3393188050345;642.5566359212222;647.8542327976168;669.0399277037467;560.8317504748559;576.3717398973472;578.6383510306059;631.8072987738692;652.2466551133449;7688.846223075507;8517.659293628185;8870.73387798367;9308.58621360088;9638.228941684649;608.2397003745318;611.3092205807409;649.0361812708124;665.2117241069349;678.8268991407258;4493.078918821634;4730.195866702668;4738.549837765407;4763.04739052191;4792.305115758196;91300.5434972821;113699.43150284195;122916;133957;148499.25750371395;122939.3853030747;132432.33783831212;133629;136676.31661841628;140001;103343;113255;113791.43104284425;114348;115425;8269.586520673822;8783.472991620523;9174.128457796498;9188.127127922837;9209.677661281823;42718.78640606777;60102.699486502286;60795.08807367981;61259.69370153121;61723.382766171766;76045.85931211147;83046.58476707578;90353;98097.29168538611;99023.50488247801;11787.172988186845;11906.285622862655;11947.823742892533;11952.880471195525;12053.939730301643;13133.82793907083;13225.735485290048;13334.866651333363;13351.399187036412;13752.587422377344;12116.394180290774;12308.26150430977;12400.75198496043;12717.109802314118;12724.491020359083;10693.251472396858;12204.450799713857;12215.75568488643;12338.321392323509;12846.67883302925;11863.169578129447;12282.938585307016;12288.324142172267;12327.137100403244;12602.36988150607;10342.638007669695;10404.58381664725;10586.523606437882;10941.726456838644;11027.503762330874;9360.859587106062;9875.851862222216;9882.209423246266;10750.46247687628;10768.784624307627 16:11:01 INFO - PROCESS | 1648 | __end_tp_report 16:11:01 INFO - PROCESS | 1648 | __start_cc_report 16:11:01 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,387 16:11:01 INFO - PROCESS | 1648 | __end_cc_report 16:11:01 INFO - PROCESS | 1648 | __startTimestamp1472857861659__endTimestamp 16:11:01 INFO - PROCESS | 1648 | 16:11:01 INFO - PROCESS | 1648 | ------- Summary: start ------- 16:11:01 INFO - PROCESS | 1648 | Number of tests: 6 16:11:01 INFO - PROCESS | 1648 | 16:11:01 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5724.56 Median:5979.10 stddev:679.28 (11.4%) stddev-sans-first:655.78 16:11:01 INFO - PROCESS | 1648 | Values: 3370.7 3373.3 3383.4 3401.6 3421.1 4659.3 4910.8 5549.9 5730.3 5757.4 5566.7 5612.5 5709.1 5766.9 5849.3 3834.6 5149.3 5171.4 5329.1 5374.5 5119.1 5345.1 5404.7 5405.6 5414.6 4132.3 5067.5 5179.8 5272.9 5312.3 5122.2 5156.7 5157.8 5183.7 5213.5 5217.7 5229.9 5248.3 5255.3 5259.4 4933.6 5624.0 5689.0 5745.9 5765.9 6159.0 6212.1 6238.7 6247.9 6257.9 6280.8 6300.5 6311.1 6318.6 6319.5 5732.2 5810.8 5860.9 5873.5 5882.5 6333.7 6335.7 6341.6 6350.3 6376.8 6148.1 6169.7 6194.7 6196.4 6230.5 6121.8 6179.3 6204.6 6233.1 6290.9 5754.8 6091.3 6123.6 6123.8 6206.8 6166.2 6191.0 6202.8 6208.1 6215.0 4903.0 4928.9 4929.7 4934.3 4972.1 4387.5 4445.8 4446.2 4497.1 4537.3 5537.5 5625.9 5745.0 5763.7 5764.3 4881.8 6154.7 6178.8 6284.3 6296.4 5740.3 5773.1 5796.6 5806.3 5883.3 5433.2 5433.5 5447.0 5453.8 5485.8 6172.5 6274.7 6412.9 6451.2 6481.4 6188.3 6259.3 6268.3 6270.5 6291.1 6343.1 6378.4 6382.1 6388.8 6410.1 6107.2 6144.2 6163.1 6235.2 6253.7 6213.3 6262.6 6273.6 6291.3 6292.3 6122.4 6193.6 6198.1 6209.2 6230.9 6014.8 6033.2 6062.5 6223.7 6230.7 5000.5 5783.9 5957.4 6046.9 6050.6 6068.3 6115.9 6126.1 6150.8 6151.6 5864.2 5920.3 5979.1 5982.2 5984.8 16:11:01 INFO - PROCESS | 1648 | 16:11:01 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:67217.02 Median:40637.89 stddev:144812.95 (356.3%) stddev-sans-first:145132.56 16:11:01 INFO - PROCESS | 1648 | Values: 505.1 507.9 509.0 520.8 548.9 31136.2 41017.4 41091.8 41137.6 41199.4 41643.0 42296.6 42304.4 42317.0 42412.4 9728.7 9740.4 9897.8 9898.9 9916.5 9729.5 9818.5 9854.7 9868.1 9892.1 9798.7 9870.3 9918.5 9933.4 9982.4 8154.7 9797.6 9859.1 9898.7 9901.4 9702.4 9753.2 9788.4 9802.5 9816.2 40256.4 40485.8 40582.8 40712.6 40712.8 3335.8 3350.9 3368.0 3389.6 3399.8 28751.9 31277.5 31309.0 32028.7 32619.7 3200.3 3220.7 3225.8 3243.5 3307.6 474064.0 479733.0 481544.0 481729.0 482458.6 48100.3 57056.4 57451.0 57453.7 57633.0 33761.7 34703.7 34992.3 62919.0 63081.4 16508.0 16656.4 16694.9 16727.5 16973.8 12829.7 12854.9 12915.6 12949.2 12952.5 19226.5 19289.4 19346.8 19357.8 19433.7 7853.4 7984.0 8005.3 8007.0 8043.3 822.3 917.2 1007.2 1036.7 1038.8 28615.9 29801.0 30305.5 30343.8 30543.5 952.7 1002.7 1026.3 1075.4 1100.6 15190.0 15631.4 15798.5 15860.2 16268.8 607043.0 612621.0 613355.0 613673.0 615532.0 42285.6 57594.7 58539.4 58820.4 58825.7 1330.8 1342.3 1374.4 1375.6 1385.5 28583.7 29184.9 29294.6 29404.6 30296.4 46661.5 50928.2 51050.5 51105.5 51284.5 457963.0 538561.0 544540.0 545322.0 545936.0 24718.9 26285.7 26615.5 26991.3 27005.6 44796.0 47060.5 47180.3 48189.0 48603.8 39196.6 39209.8 39510.8 40693.0 40776.8 39353.6 39550.0 39778.2 39819.9 40774.4 34207.1 37973.6 38214.6 38433.6 38565.2 32975.8 33128.3 33201.8 34929.8 35201.8 22467.6 25372.0 25886.7 25948.6 26353.2 16:11:01 INFO - PROCESS | 1648 | 16:11:01 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:32175.02 Median:51645.98 stddev:90728.22 (175.7%) stddev-sans-first:90951.28 16:11:01 INFO - PROCESS | 1648 | Values: 357.9 363.9 365.0 373.3 390.2 19825.3 20088.8 21038.3 21211.8 21433.8 20302.5 20756.0 20764.5 20809.5 21143.3 5780.9 5833.5 5865.6 5985.7 6136.9 6163.7 6202.3 6202.9 6203.9 6205.8 5992.3 6142.0 6175.8 6176.4 6189.8 5908.9 6134.4 6178.6 6179.4 6255.0 5773.1 5911.4 5934.2 5999.4 6001.1 13136.6 13279.7 23278.2 24345.0 24365.4 2328.1 2334.4 2349.8 2386.3 2948.9 8860.0 9627.9 9916.5 10033.7 10444.8 1838.6 1840.6 1870.1 1877.0 1894.9 97680.0 102342.0 112214.4 118879.4 120294.4 9273.5 9635.7 9702.5 9926.2 10110.0 12118.6 12243.3 12275.7 12350.6 12364.5 7915.5 8041.7 8061.9 8145.2 8174.0 8398.3 8414.5 8470.9 8562.4 8571.5 3247.0 3439.7 3818.6 3856.9 3942.3 1887.8 1919.8 1928.1 1930.4 1933.8 820.3 855.8 913.5 941.6 946.2 20772.2 21710.9 21876.3 21923.9 21930.0 751.9 813.4 836.0 837.2 913.9 8059.8 10819.6 11339.0 11377.4 11387.8 531900.0 539921.0 541512.0 551196.0 551967.0 72938.0 102813.0 126956.0 127494.4 128350.0 939.8 944.8 975.9 980.0 980.1 15615.9 19048.9 19198.8 19208.9 19262.6 51531.0 51761.0 52358.7 52552.0 53865.0 50106.7 75513.1 76731.5 78003.0 78586.6 7682.9 7853.4 7903.2 7976.0 8029.1 6146.9 7505.7 11295.8 11656.7 12565.4 6529.0 7213.9 10000.8 10141.7 10426.0 9416.4 10035.2 10208.7 10310.2 10409.8 9826.5 10106.2 10598.6 10716.4 10850.8 7674.4 7732.5 7878.6 7892.0 7979.8 10130.6 10166.6 10347.3 10682.3 10791.5 16:11:01 INFO - PROCESS | 1648 | 16:11:01 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:5725.13 Median:4901.83 stddev:3184.24 (65.0%) stddev-sans-first:3177.08 16:11:01 INFO - PROCESS | 1648 | Values: 1465.4 1501.7 1721.0 1845.2 1888.4 7654.8 8006.1 8502.7 9091.3 9093.2 8681.2 8900.2 8937.3 8947.1 8968.6 2379.3 2397.3 2397.8 2415.7 2418.8 2326.2 2334.1 2413.7 2417.7 2419.1 2389.7 2396.1 2396.7 2406.1 2407.5 2352.4 2363.8 2364.4 2375.3 2383.5 2033.4 2356.8 2372.7 2391.2 2406.5 8899.7 8994.1 8998.7 9024.2 9045.4 5225.7 5398.2 5398.5 5418.1 5419.9 3662.4 3689.8 3697.5 3739.3 3744.6 1084.9 1092.2 1092.4 1096.4 1107.1 11533.5 11678.3 11694.3 11730.2 11831.6 4004.6 4602.0 4699.5 4875.1 4880.2 8666.2 9537.1 10040.4 10066.7 10235.9 4629.8 5343.1 5350.3 5362.3 5378.4 4459.7 4763.4 4898.6 4905.0 4931.7 3360.9 3863.1 4010.3 4017.6 4019.9 1113.6 1294.6 1296.1 1314.2 1317.2 825.6 889.5 892.8 909.6 959.2 5914.9 5946.9 6063.2 6096.8 6188.8 938.5 963.6 967.5 979.4 1013.7 3902.5 3947.9 4010.1 4024.9 4099.5 10364.2 10738.4 10740.6 10769.5 10783.5 10043.3 10343.7 10595.5 10763.4 10818.7 7779.8 8036.0 8098.2 8297.7 8355.1 5363.6 5961.9 6020.7 6033.6 6269.7 9837.8 9940.2 10009.2 10155.5 10211.6 9960.7 10129.8 10184.4 10275.9 10294.4 6459.0 7418.1 7568.0 7572.7 7610.0 8101.4 8214.3 8270.1 8274.1 8289.5 7388.6 7503.5 7518.9 7607.2 7664.7 7222.5 7342.7 7372.0 7413.0 7539.2 6861.4 6993.1 6998.1 7005.7 7020.2 4812.6 4977.6 5032.7 5070.4 5083.8 5038.4 5071.5 5101.4 5169.7 5170.7 16:11:01 INFO - PROCESS | 1648 | 16:11:01 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4719.54 Median:5132.31 stddev:1500.58 (29.2%) stddev-sans-first:1466.90 16:11:01 INFO - PROCESS | 1648 | Values: 255.4 283.5 293.6 296.0 308.7 5417.9 5599.8 5702.7 5749.5 5787.8 4829.0 5107.8 5261.2 5652.1 5681.6 3568.1 4288.9 4302.2 4309.3 4325.4 3545.5 3906.2 4267.0 4355.9 4358.8 3464.9 3688.3 4080.9 4215.1 4222.7 3740.8 3986.8 4024.1 4267.8 4282.3 3245.4 3694.4 3694.9 3705.9 3712.6 4678.7 5055.6 5464.3 5491.8 5561.9 4629.4 4898.9 4916.2 4931.8 4944.8 5034.5 5817.8 6005.8 6007.9 6075.7 3862.6 3994.4 4007.5 4052.4 4053.0 5363.7 5561.9 6217.6 6313.0 6386.8 3589.7 4089.2 4100.4 4105.9 4109.4 3927.7 4114.5 4153.7 4157.2 4161.5 4258.2 4755.5 4879.0 4918.9 4934.1 5920.8 5985.6 6034.6 6110.8 6118.9 1356.3 1400.9 1411.2 1418.3 1418.6 761.4 772.2 842.9 862.9 884.6 4354.5 4668.0 4684.1 4728.3 4751.5 4873.7 5100.7 5139.0 5197.6 5211.7 4037.0 4132.3 4239.2 4323.8 4517.7 2561.0 2995.6 3246.0 3274.6 3282.4 5681.4 5964.3 6127.0 6454.8 6456.9 4936.1 5125.6 6352.8 6361.7 6374.9 5401.9 5863.4 6482.7 6487.2 6498.2 5419.9 5821.5 5889.9 5961.3 6277.2 6080.6 6171.8 6191.0 6215.8 6227.9 5781.6 6213.8 6426.8 6468.5 6491.8 3484.2 3692.2 3972.9 4014.9 4021.4 5408.8 6129.3 6184.3 6192.4 6202.8 5150.0 5485.5 5569.7 6039.2 6112.5 4477.0 4767.8 5920.8 5940.8 5963.9 5756.7 5835.0 5844.0 5884.9 5903.5 5531.6 5699.1 5901.4 5944.8 5958.8 5321.8 5797.5 5800.0 5819.9 5897.6 16:11:01 INFO - PROCESS | 1648 | 16:11:01 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:23932.28 Median:3700.72 stddev:37952.56 (1025.5%) stddev-sans-first:38018.76 16:11:01 INFO - PROCESS | 1648 | Values: 648.0 653.8 722.0 759.8 801.5 14668.6 15832.6 15849.4 15861.0 15898.0 14253.7 14283.4 14623.9 14716.4 14783.8 855.4 859.7 870.5 871.5 873.0 711.6 871.9 891.3 893.1 894.5 902.5 933.7 935.3 937.7 938.2 933.5 934.8 938.3 938.7 939.3 672.2 689.8 690.8 691.4 692.1 14573.6 14604.3 15003.4 15042.0 15049.8 13626.3 14221.6 14258.1 14321.3 14554.0 11850.9 11873.1 11885.2 12079.3 12091.6 3713.1 3794.4 3814.7 3826.9 3933.1 109024.0 109336.0 110764.4 112052.4 112106.0 11021.9 11027.7 11035.8 11057.6 11197.5 22454.4 22556.4 22663.8 22727.4 22761.5 7943.8 7946.6 8076.3 8139.2 8158.2 4342.1 4457.4 4469.7 4558.1 4639.2 3540.3 3573.5 3673.4 3674.0 3688.3 636.5 638.3 642.6 647.9 669.0 560.8 576.4 578.6 631.8 652.2 7688.8 8517.7 8870.7 9308.6 9638.2 608.2 611.3 649.0 665.2 678.8 4493.1 4730.2 4738.5 4763.0 4792.3 91300.5 113699.4 122916.0 133957.0 148499.3 122939.4 132432.3 133629.0 136676.3 140001.0 103343.0 113255.0 113791.4 114348.0 115425.0 8269.6 8783.5 9174.1 9188.1 9209.7 42718.8 60102.7 60795.1 61259.7 61723.4 76045.9 83046.6 90353.0 98097.3 99023.5 11787.2 11906.3 11947.8 11952.9 12053.9 13133.8 13225.7 13334.9 13351.4 13752.6 12116.4 12308.3 12400.8 12717.1 12724.5 10693.3 12204.5 12215.8 12338.3 12846.7 11863.2 12282.9 12288.3 12327.1 12602.4 10342.6 10404.6 10586.5 10941.7 11027.5 9360.9 9875.9 9882.2 10750.5 10768.8 16:11:01 INFO - PROCESS | 1648 | -------- Summary: end -------- 16:11:01 INFO - PROCESS | 1648 | 16:11:02 INFO - TEST-INFO | 1648: exit 0 16:11:02 INFO - TEST-OK | dromaeo_css | took 1113567ms 16:11:02 INFO - TEST-START | kraken 16:11:02 INFO - operating with platform_type : mac_ 16:11:02 INFO - Initialising browser for kraken test... 16:11:02 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpFpHMqm/profile http://localhost:49266/getInfo.html) 16:11:04 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 16:11:04 INFO - PROCESS | 1658 | colorDepth:24 16:11:04 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 16:11:04 INFO - PROCESS | 1658 | __metrics 16:11:04 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 16:11:05 INFO - TEST-INFO | 1658: exit 0 16:11:05 INFO - Browser initialized. 16:11:05 INFO - Running cycle 1/1 for kraken test... 16:11:05 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpFpHMqm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:11:17 INFO - PROCESS | 1660 | RSS: Main: 245465088 16:11:17 INFO - PROCESS | 1660 | 16:11:20 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 16:11:21 INFO - PROCESS | 1660 | RSS: Main: 257945600 16:11:21 INFO - PROCESS | 1660 | 16:11:23 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 16:11:24 INFO - PROCESS | 1660 | RSS: Main: 266788864 16:11:24 INFO - PROCESS | 1660 | 16:11:27 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 16:11:28 INFO - PROCESS | 1660 | RSS: Main: 265437184 16:11:28 INFO - PROCESS | 1660 | 16:11:30 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 16:11:31 INFO - PROCESS | 1660 | RSS: Main: 267902976 16:11:31 INFO - PROCESS | 1660 | 16:11:33 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:11:33 INFO - PROCESS | 1660 | RSS: Main: 268361728 16:11:33 INFO - PROCESS | 1660 | 16:11:36 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 16:11:37 INFO - PROCESS | 1660 | RSS: Main: 269271040 16:11:37 INFO - PROCESS | 1660 | 16:11:40 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 16:11:41 INFO - PROCESS | 1660 | RSS: Main: 269438976 16:11:41 INFO - PROCESS | 1660 | 16:11:44 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 16:11:44 INFO - PROCESS | 1660 | RSS: Main: 269774848 16:11:44 INFO - PROCESS | 1660 | 16:11:46 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:11:47 INFO - PROCESS | 1660 | RSS: Main: 269205504 16:11:47 INFO - PROCESS | 1660 | 16:11:48 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:11:49 INFO - PROCESS | 1660 | RSS: Main: 268664832 16:11:49 INFO - PROCESS | 1660 | 16:11:51 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:11:52 INFO - PROCESS | 1660 | RSS: Main: 268988416 16:11:52 INFO - PROCESS | 1660 | 16:11:55 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:11:55 INFO - PROCESS | 1660 | RSS: Main: 269029376 16:11:55 INFO - PROCESS | 1660 | 16:11:58 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:11:59 INFO - PROCESS | 1660 | RSS: Main: 269348864 16:11:59 INFO - PROCESS | 1660 | 16:12:01 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 16:12:01 INFO - PROCESS | 1660 | RSS: Main: 271568896 16:12:01 INFO - PROCESS | 1660 | 16:12:01 INFO - PROCESS | 1660 | __start_tp_report 16:12:01 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 16:12:01 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 16:12:01 INFO - PROCESS | 1660 | |i|pagename|runs| 16:12:01 INFO - PROCESS | 1660 | |0;ai-astar;117;111;117;118;115;118;117;114;126;118 16:12:01 INFO - PROCESS | 1660 | |1;audio-beat-detection;148;110;134;152;111;157;159;98;216;140 16:12:01 INFO - PROCESS | 1660 | |2;audio-dft;195;199;211;225;197;202;267;194;196;197 16:12:01 INFO - PROCESS | 1660 | |3;audio-fft;73;103;104;168;59;58;56;63;141;73 16:12:01 INFO - PROCESS | 1660 | |4;audio-oscillator;69;73;112;59;73;105;105;95;99;144 16:12:01 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;89;89;91;88;92;89;93;89;91;90 16:12:01 INFO - PROCESS | 1660 | |6;imaging-darkroom;98;97;144;98;151;103;138;151;97;103 16:12:01 INFO - PROCESS | 1660 | |7;imaging-desaturate;91;91;79;141;152;91;138;89;144;77 16:12:01 INFO - PROCESS | 1660 | |8;json-parse-financial;56;60;58;56;58;60;60;59;58;57 16:12:01 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;65;75;90;75;78;80;74;69;68;70 16:12:01 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;90;78;103;82;83;86;89;86;88;84 16:12:01 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;139;139;137;157;158;143;153;156;180;139 16:12:01 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;194;174;170;172;172;172;170;173;172;176 16:12:01 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;69;67;70;67;68;67;70;69;67;69 16:12:01 INFO - PROCESS | 1660 | __end_tp_report 16:12:01 INFO - PROCESS | 1660 | __start_cc_report 16:12:01 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,951 16:12:01 INFO - PROCESS | 1660 | __end_cc_report 16:12:01 INFO - PROCESS | 1660 | __startTimestamp1472857921448__endTimestamp 16:12:01 INFO - PROCESS | 1660 | 16:12:01 INFO - PROCESS | 1660 | ------- Summary: start ------- 16:12:01 INFO - PROCESS | 1660 | Number of tests: 14 16:12:01 INFO - PROCESS | 1660 | 16:12:01 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:117.10 Median:117.50 stddev:3.84 (3.3%) stddev-sans-first:4.08 16:12:01 INFO - PROCESS | 1660 | Values: 117.0 111.0 117.0 118.0 115.0 118.0 117.0 114.0 126.0 118.0 16:12:01 INFO - PROCESS | 1660 | 16:12:01 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:154.50 stddev:33.52 (21.7%) stddev-sans-first:35.49 16:12:01 INFO - PROCESS | 1660 | Values: 148.0 110.0 134.0 152.0 111.0 157.0 159.0 98.0 216.0 140.0 16:12:01 INFO - PROCESS | 1660 | 16:12:01 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:208.30 Median:200.50 stddev:22.72 (11.3%) stddev-sans-first:23.58 16:12:01 INFO - PROCESS | 1660 | Values: 195.0 199.0 211.0 225.0 197.0 202.0 267.0 194.0 196.0 197.0 16:12:01 INFO - PROCESS | 1660 | 16:12:01 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:89.80 Median:58.50 stddev:38.73 (66.2%) stddev-sans-first:40.60 16:12:01 INFO - PROCESS | 1660 | Values: 73.0 103.0 104.0 168.0 59.0 58.0 56.0 63.0 141.0 73.0 16:12:01 INFO - PROCESS | 1660 | 16:12:01 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:71.00 stddev:25.43 (35.8%) stddev-sans-first:25.39 16:12:01 INFO - PROCESS | 1660 | Values: 69.0 73.0 112.0 59.0 73.0 105.0 105.0 95.0 99.0 144.0 16:12:01 INFO - PROCESS | 1660 | 16:12:01 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:90.10 Median:90.50 stddev:1.60 (1.8%) stddev-sans-first:1.64 16:12:01 INFO - PROCESS | 1660 | Values: 89.0 89.0 91.0 88.0 92.0 89.0 93.0 89.0 91.0 90.0 16:12:01 INFO - PROCESS | 1660 | 16:12:01 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:118.00 Median:124.00 stddev:24.46 (19.7%) stddev-sans-first:24.85 16:12:01 INFO - PROCESS | 1660 | Values: 98.0 97.0 144.0 98.0 151.0 103.0 138.0 151.0 97.0 103.0 16:12:01 INFO - PROCESS | 1660 | 16:12:01 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:109.30 Median:84.00 stddev:30.25 (36.0%) stddev-sans-first:31.35 16:12:01 INFO - PROCESS | 1660 | Values: 91.0 91.0 79.0 141.0 152.0 91.0 138.0 89.0 144.0 77.0 16:12:01 INFO - PROCESS | 1660 | 16:12:01 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.50 stddev:1.55 (2.6%) stddev-sans-first:1.42 16:12:01 INFO - PROCESS | 1660 | Values: 56.0 60.0 58.0 56.0 58.0 60.0 60.0 59.0 58.0 57.0 16:12:01 INFO - PROCESS | 1660 | 16:12:01 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:74.40 Median:75.00 stddev:7.20 (9.6%) stddev-sans-first:6.78 16:12:01 INFO - PROCESS | 1660 | Values: 65.0 75.0 90.0 75.0 78.0 80.0 74.0 69.0 68.0 70.0 16:12:01 INFO - PROCESS | 1660 | 16:12:01 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:86.00 stddev:6.69 (7.8%) stddev-sans-first:7.00 16:12:01 INFO - PROCESS | 1660 | Values: 90.0 78.0 103.0 82.0 83.0 86.0 89.0 86.0 88.0 84.0 16:12:01 INFO - PROCESS | 1660 | 16:12:01 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:150.10 Median:154.50 stddev:13.49 (8.7%) stddev-sans-first:13.70 16:12:01 INFO - PROCESS | 1660 | Values: 139.0 139.0 137.0 157.0 158.0 143.0 153.0 156.0 180.0 139.0 16:12:01 INFO - PROCESS | 1660 | 16:12:01 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.50 Median:172.50 stddev:7.07 (4.1%) stddev-sans-first:1.87 16:12:01 INFO - PROCESS | 1660 | Values: 194.0 174.0 170.0 172.0 172.0 172.0 170.0 173.0 172.0 176.0 16:12:01 INFO - PROCESS | 1660 | 16:12:01 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:69.00 stddev:1.25 (1.8%) stddev-sans-first:1.30 16:12:01 INFO - PROCESS | 1660 | Values: 69.0 67.0 70.0 67.0 68.0 67.0 70.0 69.0 67.0 69.0 16:12:01 INFO - PROCESS | 1660 | -------- Summary: end -------- 16:12:01 INFO - PROCESS | 1660 | 16:12:02 INFO - TEST-INFO | 1660: exit 0 16:12:02 INFO - TEST-OK | kraken | took 60030ms 16:12:02 INFO - SUITE-END | took 1173s 16:12:02 INFO - Completed test suite (00:19:33) 16:12:02 INFO - javascript benchmark 16:12:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7309.32386356488, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3370.730341572674, 3373.2578832656836, 3383.3571621391934, 3401.5748031496064, 3421.1447138215444, 4659.277811939155, 4910.803567857286, 5549.890021995602, 5730.283714535678, 5757.366689664133, 5566.721663916808, 5612.522935550483, 5709.143628455734, 5766.913496297559, 5849.327327357355, 3834.5973672764376, 5149.30484384608, 5171.4311425743135, 5329.094054010808, 5374.516293533581, 5119.129747942859, 5345.09133447313, 5404.729763511828, 5405.594580406466, 5414.566834653238, 4132.29750942339, 5067.518585734386, 5179.792808287664, 5272.868178295574, 5312.2828418163635, 5122.180451127839, 5156.74216289184, 5157.767900444452, 5183.663061901002, 5213.478652134794, 5217.6608520446425, 5229.895402091975, 5248.343957005374, 5255.343082114736, 5259.447757985395, 4933.55597996182, 5624.0, 5688.97598432282, 5745.913811292834, 5765.855853603652, 6158.9692051539905, 6212.1303017577575, 6238.656873871935, 6247.9062814057825, 6257.87484250317, 6280.811575652738, 6300.527460440485, 6311.147995020705, 6318.620882747004, 6319.462845658125, 5732.226149469851, 5810.796622118206, 5860.853478663025, 5873.471387575053, 5882.529397648178, 6333.714982825784, 6335.714892829834, 6341.587796793194, 6350.33321501245, 6376.840578985562, 6148.1392605035335, 6169.691515424211, 6194.659293738798, 6196.411340922605, 6230.501559875199, 6121.788327166048, 6179.28938172116, 6204.627722336674, 6233.065040244, 6290.937090629127, 5754.798582049608, 6091.329953705089, 6123.632582045003, 6123.801220575414, 6206.844828879314, 6166.167567378347, 6190.969045154836, 6202.81391558254, 6208.068789681584, 6215.0, 4902.950970490321, 4928.852134435972, 4929.728864912393, 4934.284528743384, 4972.0801651694555, 4387.5393083726385, 4445.799939002753, 4446.177457170434, 4497.145542346943, 4537.342085397665, 5537.529310008614, 5625.943740562542, 5745.0, 5763.6541807491685, 5764.279465066867, 4881.780319885543, 6154.661493617805, 6178.783742568989, 6284.308726040132, 6296.43332100104, 5740.282464691913, 5773.076307790733, 5796.594238403356, 5806.332271788714, 5883.294004719375, 5433.185022246695, 5433.538149257279, 5446.972765136228, 5453.809116680897, 5485.780568777204, 6172.475339596005, 6274.717637706405, 6412.871742565123, 6451.161349024596, 6481.449076828522, 6188.2883468399905, 6259.280182778856, 6268.310485846462, 6270.4670103039925, 6291.119243306032, 6343.143675603919, 6378.425941665087, 6382.138411314413, 6388.840278993062, 6410.0705397718, 6107.206063211754, 6144.2488890665945, 6163.075538669235, 6235.158253635701, 6253.7185826637, 6213.254409470893, 6262.624242545462, 6273.592216505913, 6291.339409361951, 6292.27638821523, 6122.418370254819, 6193.628382297076, 6198.132261483306, 6209.223847019122, 6230.937690623217, 6014.759409623566, 6033.245844269466, 6062.514998800174, 6223.657698826608, 6230.6884655767935, 5000.549950504472, 5783.94216057834, 5957.434043765836, 6046.939530604814, 6050.576459647782, 6068.332483426731, 6115.877682446415, 6126.111713801563, 6150.753969841336, 6151.569390142647, 5864.208331875142, 5920.319163296276, 5979.1031345296815, 5982.222311099529, 5984.820455386345], "value": 5681.87770360376, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.1286530734481, 507.92635067915154, 508.99491005089914, 520.8073012985195, 548.8847342058168, 31136.221594460123, 41017.38473922894, 41091.767246982636, 41137.58862411375, 41199.382009269844, 41643.0, 42296.577034229646, 42304.365434518506, 42317.0, 42412.36381454273, 9728.70813875583, 9740.366876153063, 9897.752556186117, 9898.851517227247, 9916.454594997273, 9729.540568914685, 9818.509074546244, 9854.704358869245, 9868.062534059252, 9892.109710126088, 9798.706038818847, 9870.309078364517, 9918.454485003322, 9933.3543319684, 9982.401055936667, 8154.714584989497, 9797.559109840075, 9859.063388978035, 9898.703038908845, 9901.405915645013, 9702.369345992558, 9753.21974242059, 9788.363756355886, 9802.460864652441, 9816.214702823758, 40256.396154057715, 40485.79757101225, 40582.78251652455, 40712.592874071175, 40712.796436017925, 3335.799852008863, 3350.932981340384, 3368.0401085690705, 3389.57630296213, 3399.847006884696, 28751.856240718662, 31277.530837037462, 31309.0, 32028.679713202804, 32619.67380326214, 3200.3439294944715, 3220.72623826975, 3225.7580681448985, 3243.497257925025, 3307.558217494314, 474064.0, 479733.0, 481544.0, 481729.0, 482458.5877070627, 48100.27849582259, 57056.42943570511, 57451.0, 57453.71273143608, 57633.0, 33761.66238337585, 34703.65296347004, 34992.30015399729, 62919.0, 63081.36918630847, 16508.009519428873, 16656.41702540405, 16694.91652541754, 16727.498175054767, 16973.811833171807, 12829.743405131845, 12854.871451285555, 12915.612531624067, 12949.158304710352, 12952.546660866825, 19226.519337016685, 19289.421317360502, 19346.80653193478, 19357.806421935882, 19433.708494372597, 7853.371730261565, 7984.0, 8005.279524842792, 8007.0391553014015, 8043.305492660024, 822.284612387227, 917.202034230224, 1007.1539906478594, 1036.7149034015556, 1038.8285932821152, 28615.85692071526, 29801.0, 30305.545416818764, 30343.848280758455, 30543.541846872315, 952.6570434643522, 1002.7292630989592, 1026.3174988632625, 1075.370908018802, 1100.6202860013443, 15190.0, 15631.3747450103, 15798.526044218692, 15860.20698965047, 16268.837311626732, 607043.0, 612621.0, 613355.0, 613673.0, 615532.0, 42285.57714422878, 57594.7120264396, 58539.41460585425, 58820.4117958815, 58825.705871471226, 1330.8203392542077, 1342.2684636872928, 1374.4433504430722, 1375.5735721926035, 1385.4942945824903, 28583.713732881653, 29184.854075729487, 29294.56058159172, 29404.558931615615, 30296.394072117993, 46661.533384665716, 50928.23607645814, 51050.48949510457, 51105.48894511156, 51284.48715512797, 457963.0, 538561.0, 544540.0, 545322.0, 545936.0, 24718.876405617855, 26285.737142629096, 26615.46769064569, 26991.325216869736, 27005.59491607667, 44796.0, 47060.52939470561, 47180.29229561628, 48189.03621927472, 48603.756981214865, 39196.608033920435, 39209.82370528889, 39510.80244598874, 40693.0, 40776.79611601923, 39353.60646393499, 39550.0, 39778.2044359117, 39819.88548151213, 40774.38838417367, 34207.14482137867, 37973.620263797005, 38214.6178538211, 38433.615663843004, 38565.22869542537, 32975.835120824246, 33128.33743325168, 33201.833990830855, 34929.825350873085, 35201.82399087988, 22467.550648987257, 25372.0, 25886.741132589188, 25948.610770838073, 26353.20940371792], "value": 19772.377745404956, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.94093974494206, 363.86355116831186, 364.9708023358132, 373.3447799112557, 390.2078780076446, 19825.306114286002, 20088.799112008877, 21038.263660771878, 21211.787882121193, 21433.785662143375, 20302.492437689067, 20756.0, 20764.48088797777, 20809.479763005933, 21143.259985900495, 5780.913286300709, 5833.504152147073, 5865.648061116347, 5985.670788106652, 6136.877262454748, 6163.691815409234, 6202.255729312489, 6202.875942481148, 6203.875922481548, 6205.81382558524, 5992.280926288851, 6141.969290153543, 6175.814725558218, 6176.444120029197, 6189.814305570818, 5908.911366329508, 6134.38656134383, 6178.629282243057, 6179.38206179383, 6255.030470277115, 5773.076307790775, 5911.408859114097, 5934.1692163097205, 5999.400059993965, 6001.12983617373, 13136.60590182296, 13279.73440531184, 23278.185263515697, 24345.0, 24365.390865228335, 2328.092044102801, 2334.395471727985, 2349.835511514195, 2386.2841147655636, 2948.8967886123883, 8859.955700221522, 9627.855582166203, 9916.504174791304, 10033.698989030341, 10444.79110417795, 1838.6414649143424, 1840.55826601616, 1870.1397357215697, 1877.0333278361518, 1894.943151705451, 97680.0, 102342.0, 112214.43892780565, 118879.4056029723, 120294.3911682651, 9273.536323183815, 9635.710928672152, 9702.51487425626, 9926.15627671656, 10110.0, 12118.636440906786, 12243.326617035971, 12275.693107672201, 12350.567730129402, 12364.505419783289, 7915.485493442908, 8041.718539851077, 8061.919380806117, 8145.167337349049, 8173.959130204311, 8398.328133749286, 8414.453060551044, 8470.872936905951, 8562.400631955703, 8571.52856592881, 3246.983765081207, 3439.7420193485586, 3818.5608655004476, 3856.8650097246464, 3942.329803933338, 1887.8489720822301, 1919.8080191980969, 1928.1034319041432, 1930.3629802165533, 1933.7969513201192, 820.335528222142, 855.8104235113198, 913.4747520175926, 941.5904081724472, 946.186279799372, 20772.1691132353, 21710.891445542988, 21876.343709688736, 21923.890380548313, 21930.0, 751.8609057324412, 813.4021494201875, 835.995820020896, 837.2130197614223, 913.9360244782802, 8059.798505037421, 10819.567217311376, 11339.0, 11377.431128443544, 11387.811412804427, 531900.0, 539921.0, 541512.0, 551196.0, 551967.0, 72938.0, 102813.0, 126956.0, 127494.36252818862, 128350.0, 939.7979434421633, 944.8299306124826, 975.9414435133915, 980.0, 980.1472718734747, 15615.921920390325, 19048.904755476135, 19198.8480691159, 19208.903955480135, 19262.614747704687, 51530.96938061293, 51761.0, 52358.73820630873, 52552.0, 53865.0, 50106.74946625243, 75513.05060766048, 76731.46537069339, 78003.0, 78586.6070669643, 7682.884756728542, 7853.37173026168, 7903.209679032051, 7975.960120199362, 8029.1167971524255, 6146.907796383147, 7505.6997720090585, 11295.830562541403, 11656.650300491, 12565.371731413576, 6528.988006858945, 7213.9278607213255, 10000.799984000134, 10141.695749127539, 10425.957404259514, 9416.387934784218, 10035.24735644815, 10208.672872526524, 10310.226732994905, 10409.803794535219, 9826.459544725109, 10106.242031847494, 10598.629047983284, 10716.35701857891, 10850.782984340427, 7674.424418168772, 7732.536047837148, 7878.566678832719, 7892.0, 7979.760607181794, 10130.594776208869, 10166.593336266467, 10347.327423717434, 10682.305650132717, 10791.514381852678], "value": 9072.013649804805, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1465.4358072142225, 1501.737195990702, 1720.9655806883864, 1845.234227795465, 1888.3579582941807, 7654.770356889288, 8006.119326874039, 8502.659893604248, 9091.318151138667, 9093.181613654779, 8681.21869031787, 8900.243479304267, 8937.285017198625, 8947.06055864133, 8968.596413161407, 2379.3100000999734, 2397.25685037638, 2397.844140130886, 2415.6738840256517, 2418.7823095921362, 2326.2323433267065, 2334.11303704592, 2413.746556611557, 2417.6857008588945, 2419.0565679385054, 2389.689340385756, 2396.101461951768, 2396.688430504032, 2406.109739396426, 2407.458321877581, 2352.3648614873887, 2363.83453158279, 2364.4443555764383, 2375.2517956843626, 2383.4875501767115, 2033.4103110098054, 2356.8232382571377, 2372.6678265042906, 2391.1630929174826, 2406.4946361264156, 8899.73300800977, 8994.145556172152, 8998.730038098802, 9024.187823095886, 9045.412048216911, 5225.686458812484, 5398.217258497496, 5398.514133727944, 5418.106012507931, 5419.864503387407, 3662.377395842713, 3689.760165589228, 3697.4638677391895, 3739.3456145174487, 3744.6068162843053, 1084.8806631270554, 1092.19177808422, 1092.3882625729616, 1096.369587487198, 1107.0866535108487, 11533.538658453652, 11678.299302041905, 11694.298342099417, 11730.17888747788, 11831.585894493737, 4004.5795191505053, 4601.976990115028, 4699.483056863743, 4875.098106850173, 4880.219164933594, 8666.176713212235, 9537.14165725088, 10040.397576145455, 10066.748331291776, 10235.897641023643, 4629.837955671603, 5343.145096784496, 5350.250964864922, 5362.302900622894, 5378.408375078739, 4459.732416055047, 4763.404574428197, 4898.608111351084, 4905.043516514245, 4931.7040977541465, 3360.9245041586946, 3863.1307955710304, 4010.27814993304, 4017.6384125428854, 4019.9196016079513, 1113.6269349767917, 1294.5986744109357, 1296.1056870759146, 1314.18520517278, 1317.1899281941537, 825.5954582254652, 889.4612320685251, 892.7946572288411, 909.6452383570413, 959.1751094059103, 5914.8817023659285, 5946.910796338058, 6063.151158837766, 6096.847578810565, 6188.783392581238, 938.4697645830084, 963.633819148733, 967.5259123029665, 979.4417182206074, 1013.6806905824642, 3902.453656488094, 3947.9013024674614, 4010.1378203685763, 4024.859129930497, 4099.487564054493, 10364.222683298784, 10738.35569865795, 10740.624078157227, 10769.515371808287, 10783.460826958777, 10043.296969212084, 10343.689689309333, 10595.523201455953, 10763.3541987481, 10818.67543973682, 7779.844403112019, 8035.955325807725, 8098.190180981973, 8297.709580164665, 8355.122712115262, 5363.570914326922, 5961.91057134152, 6020.65131056387, 6033.577649564489, 6269.749210031548, 9837.803243935225, 9940.204783617148, 10009.199264058712, 10155.492225388552, 10211.642592509226, 9960.701178964642, 10129.797404051731, 10184.439855808001, 10275.948620256851, 10294.3823370598, 6458.967705161632, 7418.072740907387, 7568.0, 7572.734954276574, 7610.0, 8101.432899696964, 8214.301784348398, 8270.131636178356, 8274.13121622221, 8289.461185022954, 7388.630568471447, 7503.5497870127965, 7518.887216691644, 7607.163212046781, 7664.693412263447, 7222.458315626454, 7342.6695798688115, 7371.963140184479, 7412.9992451018425, 7539.246075392417, 6861.416779573592, 6993.125859267591, 6998.055262539492, 7005.684744186422, 7020.157581090098, 4812.614990800657, 4977.552020318189, 5032.748362581783, 5070.41690205631, 5083.847484575469, 5038.370203724535, 5071.54356107952, 5101.362329708786, 5169.715665638276, 5170.71561064145], "value": 4617.2292237654265, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [255.37051168868734, 283.46926596379546, 293.608033275577, 296.023123691817, 308.66509836827044, 5417.918731219035, 5599.832005039845, 5702.68635225063, 5749.533868863439, 5787.768489260435, 4828.975855120728, 5107.821226257081, 5261.184516399964, 5652.123920792274, 5681.573881958849, 3568.107973006748, 4288.935665965005, 4302.225599392108, 4309.31051031835, 4325.437693099892, 3545.530988771818, 3906.2187562487616, 4266.978665106686, 4355.912881742363, 4358.782060896959, 3464.873915977305, 3688.3360995020885, 4080.9183816323657, 4215.124269699984, 4222.725522841021, 3740.775553466787, 3986.800659967019, 4024.102646094807, 4267.8020819277945, 4282.250606143913, 3245.4482737934372, 3694.390425579776, 3694.9445758313645, 3705.8702945397054, 3712.573054098786, 4678.672492925497, 5055.646104772667, 5464.316960379952, 5491.835244942658, 5561.860953476155, 4629.444466664022, 4898.853034408973, 4916.164252077156, 4931.80272789088, 4944.777485013183, 5034.4713805050305, 5817.767289308423, 6005.819825405245, 6007.8632768982325, 6075.726592303357, 3862.613738626143, 3994.400839874042, 4007.458993035932, 4052.4124002019544, 4053.0, 5363.704996225206, 5561.944380556223, 6217.595876247472, 6313.0, 6386.776462823826, 3589.7307701921936, 4089.20260549196, 4100.405441211067, 4105.938410923838, 4109.404136400205, 3927.6857851371824, 4114.547399786021, 4153.7300075495605, 4157.23317590023, 4161.521425036099, 4258.1689873354135, 4755.500672429414, 4878.951025529528, 4918.877028074256, 4934.136526107916, 5920.822375328747, 5985.623306639497, 6034.616326550988, 6110.7861224856915, 6118.877622447526, 1356.2743931996336, 1400.8879289656802, 1411.1533080151826, 1418.2908545727137, 1418.5672470804354, 761.4251240313639, 772.1776308231715, 842.8819965204876, 862.8835107260566, 884.6019291318804, 4354.455693038371, 4667.95332046682, 4684.098036474067, 4728.267118596623, 4751.52484751529, 4873.707577545359, 5100.730175072132, 5138.974305128525, 5197.621545995134, 5211.661242019257, 4036.979815100906, 4132.297509423405, 4239.198340705188, 4323.762193079411, 4517.661175411791, 2561.0, 2995.5955945947017, 3245.993741940006, 3274.590676165479, 3282.3763484937786, 5681.431856814368, 5964.284285885635, 6126.989046807316, 6454.774082907075, 6456.8676047329745, 4936.111499930047, 5125.64120511568, 6352.809415717536, 6361.713722882481, 6374.936250637527, 5401.918971215435, 5863.355030946593, 6482.67586620667, 6487.2215334159255, 6498.220213574401, 5419.891602168013, 5821.505172060422, 5889.911651325147, 5961.330827368344, 6277.18396608438, 6080.604760690541, 6171.814845554641, 6190.969045154746, 6215.751369945152, 6227.875442491216, 5781.566382521243, 6213.813585592439, 6426.7827599478105, 6468.514861385321, 6491.805245842632, 3484.1986343141725, 3692.157039079947, 3972.8609498667406, 4014.919701605893, 4021.3565829467143, 5408.8377348679605, 6129.295131059806, 6184.257889053342, 6192.442680158807, 6202.782902598387, 5149.974250128876, 5485.451454854642, 5569.693666848362, 6039.245094363205, 6112.541559383153, 4477.037436951071, 4767.785449654843, 5920.79277225295, 5940.762369505172, 5963.91054134197, 5756.712164391847, 5835.0080486318275, 5844.0, 5884.941150588439, 5903.468687818117, 5531.640443371168, 5699.1451282306325, 5901.380355062656, 5944.762209511571, 5958.76164953397, 5321.787128514971, 5797.4782269595935, 5800.013997620499, 5819.912701309399, 5897.587168898136], "value": 4227.777083719596, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.0, 653.7711800869695, 722.0396872160028, 759.7986533568609, 801.4990630855715, 14668.633284167901, 15832.604184895383, 15849.366025358971, 15861.048337099783, 15898.0, 14253.65039215786, 14283.357248923798, 14623.926880365583, 14716.411343546271, 14783.778243326358, 855.4225897519166, 859.7162936231028, 870.5125129927229, 871.485823364215, 872.9519876406795, 711.6192836832296, 871.9302455803552, 891.3404080980093, 893.0756666849812, 894.5035505294559, 902.5442151713376, 933.6778811310121, 935.3172184305461, 937.7374335186158, 938.249400479617, 933.4959122074072, 934.8270569944548, 938.2775263047415, 938.7043081429327, 939.2767568971922, 672.1866541484809, 689.7896141676787, 690.7858563845174, 691.4364792693939, 692.0760784352894, 14573.635659108608, 14604.269786510738, 15003.399864005427, 15042.0, 15049.774253386207, 13626.318684065756, 14221.63248734982, 14258.144511329354, 14321.283935803169, 14554.0, 11850.88149118515, 11873.10951678619, 11885.168038237327, 12079.275243485332, 12091.576794812227, 3713.1459764254105, 3794.354959656865, 3814.7329686921926, 3826.9234615307814, 3933.0560665440375, 109024.0, 109336.0, 110764.4461777686, 112052.43973780079, 112106.0, 11021.944890275498, 11027.724306892393, 11035.83446248307, 11057.612983545538, 11197.49611267495, 22454.438639034153, 22556.436089097577, 22663.773362266496, 22727.431814204447, 22761.544769104526, 7943.761687149395, 7946.6424010919645, 8076.27313541784, 8139.226773456512, 8158.184181581794, 4342.131573685276, 4457.442819647544, 4469.709468884512, 4558.065596552765, 4639.164950308977, 3540.2742437800703, 3573.5175751273764, 3673.44898265257, 3674.0, 3688.2992231475932, 636.5416899832113, 638.3393188050345, 642.5566359212222, 647.8542327976168, 669.0399277037467, 560.8317504748559, 576.3717398973472, 578.6383510306059, 631.8072987738692, 652.2466551133449, 7688.846223075507, 8517.659293628185, 8870.73387798367, 9308.58621360088, 9638.228941684649, 608.2397003745318, 611.3092205807409, 649.0361812708124, 665.2117241069349, 678.8268991407258, 4493.078918821634, 4730.195866702668, 4738.549837765407, 4763.04739052191, 4792.305115758196, 91300.5434972821, 113699.43150284195, 122916.0, 133957.0, 148499.25750371395, 122939.3853030747, 132432.33783831212, 133629.0, 136676.31661841628, 140001.0, 103343.0, 113255.0, 113791.43104284425, 114348.0, 115425.0, 8269.586520673822, 8783.472991620523, 9174.128457796498, 9188.127127922837, 9209.677661281823, 42718.78640606777, 60102.699486502286, 60795.08807367981, 61259.69370153121, 61723.382766171766, 76045.85931211147, 83046.58476707578, 90353.0, 98097.29168538611, 99023.50488247801, 11787.172988186845, 11906.285622862655, 11947.823742892533, 11952.880471195525, 12053.939730301643, 13133.82793907083, 13225.735485290048, 13334.866651333363, 13351.399187036412, 13752.587422377344, 12116.394180290774, 12308.26150430977, 12400.75198496043, 12717.109802314118, 12724.491020359083, 10693.251472396858, 12204.450799713857, 12215.75568488643, 12338.321392323509, 12846.67883302925, 11863.169578129447, 12282.938585307016, 12288.324142172267, 12327.137100403244, 12602.36988150607, 10342.638007669695, 10404.58381664725, 10586.523606437882, 10941.726456838644, 11027.503762330874, 9360.859587106062, 9875.851862222216, 9882.209423246266, 10750.46247687628, 10768.784624307627], "value": 7664.291775981855, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1580.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 111.0, 117.0, 118.0, 115.0, 118.0, 117.0, 114.0, 126.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 110.0, 134.0, 152.0, 111.0, 157.0, 159.0, 98.0, 216.0, 140.0], "value": 142.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 199.0, 211.0, 225.0, 197.0, 202.0, 267.0, 194.0, 196.0, 197.0], "value": 208.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 103.0, 104.0, 168.0, 59.0, 58.0, 56.0, 63.0, 141.0, 73.0], "value": 89.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 112.0, 59.0, 73.0, 105.0, 105.0, 95.0, 99.0, 144.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 91.0, 88.0, 92.0, 89.0, 93.0, 89.0, 91.0, 90.0], "value": 90.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 97.0, 144.0, 98.0, 151.0, 103.0, 138.0, 151.0, 97.0, 103.0], "value": 118.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 79.0, 141.0, 152.0, 91.0, 138.0, 89.0, 144.0, 77.0], "value": 109.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 60.0, 58.0, 56.0, 58.0, 60.0, 60.0, 59.0, 58.0, 57.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 75.0, 90.0, 75.0, 78.0, 80.0, 74.0, 69.0, 68.0, 70.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 78.0, 103.0, 82.0, 83.0, 86.0, 89.0, 86.0, 88.0, 84.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 139.0, 137.0, 157.0, 158.0, 143.0, 153.0, 156.0, 180.0, 139.0], "value": 150.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 174.0, 170.0, 172.0, 172.0, 172.0, 170.0, 173.0, 172.0, 176.0], "value": 174.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 70.0, 67.0, 68.0, 67.0, 70.0, 69.0, 67.0, 69.0], "value": 68.3, "unit": "score"}]}]} 16:12:02 INFO - Return code: 0 16:12:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:12:02 ERROR - # TBPL SUCCESS # 16:12:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:12:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:12:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:12:02 INFO - 2016-09-02 16:12:02.787 screenresolution[1665:10256] starting screenresolution argv=screenresolution get 16:12:02 INFO - 2016-09-02 16:12:02.789 screenresolution[1665:10256] Display 0: 1600x1200x32@60 16:12:02 INFO - 2016-09-02 16:12:02.795 screenresolution[1666:10259] starting screenresolution argv=screenresolution list 16:12:02 INFO - Available Modes on Display 0 16:12:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:12:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:12:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:12:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:12:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:12:03 INFO - Intel Iris: 16:12:03 INFO - Chipset Model: Intel Iris 16:12:03 INFO - Type: GPU 16:12:03 INFO - Bus: Built-In 16:12:03 INFO - VRAM (Dynamic, Max): 1536 MB 16:12:03 INFO - Vendor: Intel (0x8086) 16:12:03 INFO - Device ID: 0x0a2e 16:12:03 INFO - Revision ID: 0x0009 16:12:03 INFO - Displays: 16:12:03 INFO - Display: 16:12:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:12:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:12:03 INFO - Display Serial Number: 1600x1200 60 16:12:03 INFO - Main Display: Yes 16:12:03 INFO - Mirror: Off 16:12:03 INFO - Online: Yes 16:12:03 INFO - Rotation: Supported 16:12:03 INFO - Return code: 0 16:12:03 INFO - Running post-action listener: _resource_record_post_action 16:12:03 INFO - [mozharness: 2016-09-02 23:12:03.031466Z] Finished run-tests step (success) 16:12:03 INFO - Running post-run listener: _resource_record_post_run 16:12:03 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 36951040; Write bytes: 704658944; Read time: 240; Write time: 2016 16:12:03 INFO - TinderboxPrint: CPU usage
54.6% 16:12:03 INFO - TinderboxPrint: I/O read bytes / time
36,951,040 / 240 16:12:03 INFO - TinderboxPrint: I/O write bytes / time
704,658,944 / 2,016 16:12:03 INFO - TinderboxPrint: CPU idle
2,195.1 (45.4%) 16:12:03 INFO - TinderboxPrint: CPU system
979.5 (20.2%) 16:12:03 INFO - TinderboxPrint: CPU user
1,663.1 (34.4%) 16:12:03 INFO - TinderboxPrint: Swap in / out
442,224,640 / 0 16:12:03 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 394091008; Write bytes: 388642304; Read time: 29387; Write time: 794 16:12:03 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 35070976; Write bytes: 295225344; Read time: 222; Write time: 1170 16:12:03 INFO - Running post-run listener: _upload_blobber_files 16:12:03 INFO - Blob upload gear active. 16:12:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:12:03 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 16:12:03 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'] 16:12:03 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 16:12:03 INFO - (blobuploader) - INFO - Open directory for files ... 16:12:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:12:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:12:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:04 INFO - (blobuploader) - INFO - Done attempting. 16:12:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:12:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:12:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:05 INFO - (blobuploader) - INFO - Done attempting. 16:12:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:12:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:12:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:08 INFO - (blobuploader) - INFO - Done attempting. 16:12:08 INFO - (blobuploader) - INFO - Iteration through files over. 16:12:08 INFO - Return code: 0 16:12:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:12:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:12:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a52270b9aaced445b73965aa59cb0e3aaf8c648d300008eabdf436a91bfd18eca0947b53f5dac57df2756ff15940210c5b0fdbb1c77e6a4291b96cb4bf390f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83eb8461c8f8ee8a8dd7c9d98ca4ecd50477f9fbfbf3061ccd20fc636fbaf219d4dc8715728753a40dd7db37599c267feba750c8b3258b5711af776be80aa485", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1f6dca3ca92dfa97f7fed7ba7ddfea804ecca7a2c247d51666ff380f7154cd1c8deade01bd09e575809f39111ec6e779bcd6e3db10c1c0dbac7176bfe306c0e"} 16:12:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:12:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:12:08 INFO - Contents: 16:12:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a52270b9aaced445b73965aa59cb0e3aaf8c648d300008eabdf436a91bfd18eca0947b53f5dac57df2756ff15940210c5b0fdbb1c77e6a4291b96cb4bf390f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83eb8461c8f8ee8a8dd7c9d98ca4ecd50477f9fbfbf3061ccd20fc636fbaf219d4dc8715728753a40dd7db37599c267feba750c8b3258b5711af776be80aa485", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1f6dca3ca92dfa97f7fed7ba7ddfea804ecca7a2c247d51666ff380f7154cd1c8deade01bd09e575809f39111ec6e779bcd6e3db10c1c0dbac7176bfe306c0e"} 16:12:08 INFO - Running post-run listener: copy_logs_to_upload_dir 16:12:08 INFO - Copying logs to upload dir... 16:12:08 INFO - mkdir: /builds/slave/test/build/upload/logs 16:12:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.068121 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-09-02 16:12:08.556650) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 16:12:08.560207) ========= 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.USaz5zP99U/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.FMlTO3qnoW/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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/8a52270b9aaced445b73965aa59cb0e3aaf8c648d300008eabdf436a91bfd18eca0947b53f5dac57df2756ff15940210c5b0fdbb1c77e6a4291b96cb4bf390f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83eb8461c8f8ee8a8dd7c9d98ca4ecd50477f9fbfbf3061ccd20fc636fbaf219d4dc8715728753a40dd7db37599c267feba750c8b3258b5711af776be80aa485", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1f6dca3ca92dfa97f7fed7ba7ddfea804ecca7a2c247d51666ff380f7154cd1c8deade01bd09e575809f39111ec6e779bcd6e3db10c1c0dbac7176bfe306c0e"} build_url:https://queue.taskcluster.net/v1/task/L8LmHO6mSFGTmFh1kM0wRA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011035 build_url: 'https://queue.taskcluster.net/v1/task/L8LmHO6mSFGTmFh1kM0wRA/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/8a52270b9aaced445b73965aa59cb0e3aaf8c648d300008eabdf436a91bfd18eca0947b53f5dac57df2756ff15940210c5b0fdbb1c77e6a4291b96cb4bf390f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83eb8461c8f8ee8a8dd7c9d98ca4ecd50477f9fbfbf3061ccd20fc636fbaf219d4dc8715728753a40dd7db37599c267feba750c8b3258b5711af776be80aa485", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1f6dca3ca92dfa97f7fed7ba7ddfea804ecca7a2c247d51666ff380f7154cd1c8deade01bd09e575809f39111ec6e779bcd6e3db10c1c0dbac7176bfe306c0e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 16:12:08.593894) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 16:12:08.594226) ========= 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.USaz5zP99U/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.FMlTO3qnoW/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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.005052 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 16:12:08.644019) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 16:12:08.644500) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 16:12:08.645061) ========= ========= Total master_lag: 0.18 =========