builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0104 starttime: 1472573437.99 results: success (0) buildid: 20160830065321 builduid: 1f3b0468af7a41ba852782b03ceabc74 revision: b18c8bcdc116eef8799880b7c50317bf54218474 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 09:10:37.987138) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 09:10:37.987609) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 09:10:37.987895) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 09:10:38.014908) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 09:10:38.015178) ========= 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.IxN8FVrBqT/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.Yxlt8Z7gJe/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-30 09:10:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 168M=0s 2016-08-30 09:10:38 (168 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.637507 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 09:10:38.678971) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 09:10:38.679259) ========= 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.IxN8FVrBqT/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.Yxlt8Z7gJe/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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.028433 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 09:10:38.729449) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-30 09:10:38.729792) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b18c8bcdc116eef8799880b7c50317bf54218474 --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 b18c8bcdc116eef8799880b7c50317bf54218474 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IxN8FVrBqT/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.Yxlt8Z7gJe/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-30 09:10:38,808 truncating revision to first 12 chars 2016-08-30 09:10:38,808 Setting DEBUG logging. 2016-08-30 09:10:38,808 attempt 1/10 2016-08-30 09:10:38,808 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b18c8bcdc116?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-30 09:10:40,389 unpacking tar archive at: mozilla-central-b18c8bcdc116/testing/mozharness/ program finished with exit code 0 elapsedTime=1.845778 ========= master_lag: 0.49 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-30 09:10:41.068617) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 09:10:41.068904) ========= script_repo_revision: b18c8bcdc116eef8799880b7c50317bf54218474 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 09:10:41.069267) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 09:10:41.069524) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 09:10:41.089234) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-30 09:10:41.089602) ========= /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.IxN8FVrBqT/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.Yxlt8Z7gJe/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 09:10:41 INFO - MultiFileLogger online at 20160830 09:10:41 in /builds/slave/test 09:10:41 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 09:10:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:10:41 INFO - {'append_to_log': False, 09:10:41 INFO - 'base_work_dir': '/builds/slave/test', 09:10:41 INFO - 'blob_upload_branch': 'Firefox', 09:10:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:10:41 INFO - 'branch': 'Firefox', 09:10:41 INFO - 'buildbot_json_path': 'buildprops.json', 09:10:41 INFO - 'config_files': ('talos/mac_config.py',), 09:10:41 INFO - 'default_actions': ('clobber', 09:10:41 INFO - 'read-buildbot-config', 09:10:41 INFO - 'download-and-extract', 09:10:41 INFO - 'populate-webroot', 09:10:41 INFO - 'create-virtualenv', 09:10:41 INFO - 'install', 09:10:41 INFO - 'run-tests'), 09:10:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:10:41 INFO - 'download_minidump_stackwalk': True, 09:10:41 INFO - 'download_symbols': 'ondemand', 09:10:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:10:41 INFO - 'tooltool.py': '/tools/tooltool.py', 09:10:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:10:41 INFO - '/tools/misc-python/virtualenv.py')}, 09:10:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:10:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:10:41 INFO - 'installer_path': 'installer.exe', 09:10:41 INFO - 'log_level': 'info', 09:10:41 INFO - 'log_name': 'talos', 09:10:41 INFO - 'log_to_console': True, 09:10:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:10:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:10:41 INFO - 'opt_config_files': (), 09:10:41 INFO - 'pip_index': False, 09:10:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:10:41 INFO - 'cmd': ('bash', 09:10:41 INFO - '-c', 09:10:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:10:41 INFO - 'enabled': True, 09:10:41 INFO - 'halt_on_failure': False, 09:10:41 INFO - 'name': 'check_screen_resolution'},), 09:10:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:10:41 INFO - 'cmd': ('bash', 09:10:41 INFO - '-c', 09:10:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:10:41 INFO - 'enabled': True, 09:10:41 INFO - 'halt_on_failure': False, 09:10:41 INFO - 'name': 'check_screen_resolution'},), 09:10:41 INFO - 'run_cmd_checks_enabled': True, 09:10:41 INFO - 'sps_profile': False, 09:10:41 INFO - 'sps_profile_interval': 0, 09:10:41 INFO - 'suite': 'dromaeojs-e10s', 09:10:41 INFO - 'system_bits': '32', 09:10:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:10:41 INFO - 'title': 't-yosemite-r7-0104', 09:10:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:10:41 INFO - 'use_talos_json': True, 09:10:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:10:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:10:41 INFO - 'work_dir': 'build'} 09:10:41 INFO - [mozharness: 2016-08-30 16:10:41.288588Z] Running clobber step. 09:10:41 INFO - Running pre-action listener: _resource_record_pre_action 09:10:41 INFO - Running main action method: clobber 09:10:41 INFO - rmtree: /builds/slave/test/build 09:10:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:10:43 INFO - Running post-action listener: _resource_record_post_action 09:10:43 INFO - [mozharness: 2016-08-30 16:10:43.425820Z] Finished clobber step (success) 09:10:43 INFO - [mozharness: 2016-08-30 16:10:43.425949Z] Running read-buildbot-config step. 09:10:43 INFO - Running pre-action listener: _resource_record_pre_action 09:10:43 INFO - Running main action method: read_buildbot_config 09:10:43 INFO - Using buildbot properties: 09:10:43 INFO - { 09:10:43 INFO - "project": "", 09:10:43 INFO - "product": "firefox", 09:10:43 INFO - "script_repo_revision": "production", 09:10:43 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 09:10:43 INFO - "repository": "", 09:10:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 09:10:43 INFO - "buildid": "20160830065321", 09:10:43 INFO - "pgo_build": "False", 09:10:43 INFO - "basedir": "/builds/slave/test", 09:10:43 INFO - "buildnumber": 50, 09:10:43 INFO - "slavename": "t-yosemite-r7-0104", 09:10:43 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 09:10:43 INFO - "platform": "yosemite_r7", 09:10:43 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:10:43 INFO - "branch": "mozilla-central", 09:10:43 INFO - "repo_path": "mozilla-central", 09:10:43 INFO - "revision": "b18c8bcdc116eef8799880b7c50317bf54218474", 09:10:43 INFO - "stage_platform": "macosx64", 09:10:43 INFO - "builduid": "1f3b0468af7a41ba852782b03ceabc74", 09:10:43 INFO - "slavebuilddir": "test" 09:10:43 INFO - } 09:10:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/d7P1Rf47TEG7VGn_dH6pGg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 09:10:43 INFO - Running post-action listener: _resource_record_post_action 09:10:43 INFO - [mozharness: 2016-08-30 16:10:43.429762Z] Finished read-buildbot-config step (success) 09:10:43 INFO - [mozharness: 2016-08-30 16:10:43.429883Z] Running download-and-extract step. 09:10:43 INFO - Running pre-action listener: _resource_record_pre_action 09:10:43 INFO - Running main action method: download_and_extract 09:10:43 INFO - mkdir: /builds/slave/test/build/tests 09:10:43 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')]} 09:10:43 INFO - trying https://queue.taskcluster.net/v1/task/d7P1Rf47TEG7VGn_dH6pGg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 09:10:43 INFO - Downloading https://queue.taskcluster.net/v1/task/d7P1Rf47TEG7VGn_dH6pGg/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 09:10:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d7P1Rf47TEG7VGn_dH6pGg/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 09:10:44 INFO - Downloaded 1199 bytes. 09:10:44 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 09:10:44 INFO - Using the following test package requirements: 09:10:44 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 09:10:44 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:10:44 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 09:10:44 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:10:44 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 09:10:44 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:10:44 INFO - u'jsshell-mac.zip'], 09:10:44 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:10:44 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 09:10:44 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 09:10:44 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:10:44 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 09:10:44 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:10:44 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 09:10:44 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:10:44 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 09:10:44 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:10:44 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 09:10:44 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:44 INFO - trying https://queue.taskcluster.net/v1/task/d7P1Rf47TEG7VGn_dH6pGg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 09:10:44 INFO - Downloading https://queue.taskcluster.net/v1/task/d7P1Rf47TEG7VGn_dH6pGg/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 09:10:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d7P1Rf47TEG7VGn_dH6pGg/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 09:10:45 INFO - Downloaded 16380213 bytes. 09:10:45 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 09:10:52 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 09:10: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')]} 09:10:52 INFO - trying https://queue.taskcluster.net/v1/task/d7P1Rf47TEG7VGn_dH6pGg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 09:10:52 INFO - Downloading https://queue.taskcluster.net/v1/task/d7P1Rf47TEG7VGn_dH6pGg/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 09:10:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d7P1Rf47TEG7VGn_dH6pGg/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 09:10:53 INFO - Downloaded 16380213 bytes. 09:10:53 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 09:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:59 INFO - trying https://queue.taskcluster.net/v1/task/d7P1Rf47TEG7VGn_dH6pGg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 09:10:59 INFO - Downloading https://queue.taskcluster.net/v1/task/d7P1Rf47TEG7VGn_dH6pGg/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 09:10:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d7P1Rf47TEG7VGn_dH6pGg/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 09:11:01 INFO - Downloaded 14413998 bytes. 09:11:01 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 09:11: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')]} 09:11:01 INFO - trying https://queue.taskcluster.net/v1/task/d7P1Rf47TEG7VGn_dH6pGg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 09:11:01 INFO - Downloading https://queue.taskcluster.net/v1/task/d7P1Rf47TEG7VGn_dH6pGg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 09:11:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d7P1Rf47TEG7VGn_dH6pGg/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 09:11:05 INFO - Downloaded 111582782 bytes. 09:11:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d7P1Rf47TEG7VGn_dH6pGg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 09:11:05 INFO - mkdir: /builds/slave/test/properties 09:11:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:11:05 INFO - Writing to file /builds/slave/test/properties/build_url 09:11:05 INFO - Contents: 09:11:05 INFO - build_url:https://queue.taskcluster.net/v1/task/d7P1Rf47TEG7VGn_dH6pGg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 09:11:05 INFO - Running post-action listener: _resource_record_post_action 09:11:05 INFO - Running post-action listener: set_extra_try_arguments 09:11:05 INFO - [mozharness: 2016-08-30 16:11:05.865056Z] Finished download-and-extract step (success) 09:11:05 INFO - [mozharness: 2016-08-30 16:11:05.865208Z] Running populate-webroot step. 09:11:05 INFO - Running pre-action listener: _resource_record_pre_action 09:11:05 INFO - Running main action method: populate_webroot 09:11:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:11:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:11:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:11:05 INFO - '--tppagecycles', 09:11:05 INFO - '7'], 09:11:05 INFO - 'tests': ['tsvgm']}}, 09:11:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:11:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:11:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:11:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:11:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:11:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:11:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:05 INFO - 'talos_options': ['--disable-e10s'], 09:11:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:11:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:11:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:05 INFO - 'talos_options': ['--disable-e10s'], 09:11:05 INFO - 'tests': ['damp', 'tps']}, 09:11:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:05 INFO - 'tests': ['damp', 'tps']}, 09:11:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:11:05 INFO - 'tests': ['dromaeo_dom']}, 09:11:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:11:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:11:05 INFO - 'tests': ['basic_compositor_video']}, 09:11:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:11:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:11:05 INFO - 'tests': ['a11yr', 09:11:05 INFO - 'ts_paint', 09:11:05 INFO - 'tpaint', 09:11:05 INFO - 'sessionrestore', 09:11:05 INFO - 'sessionrestore_no_auto_restore', 09:11:05 INFO - 'tabpaint']}, 09:11:05 INFO - 'other-e10s': {'tests': ['a11yr', 09:11:05 INFO - 'ts_paint', 09:11:05 INFO - 'tpaint', 09:11:05 INFO - 'sessionrestore', 09:11:05 INFO - 'sessionrestore_no_auto_restore', 09:11:05 INFO - 'tabpaint']}, 09:11:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:11:05 INFO - 'ts_paint', 09:11:05 INFO - 'tpaint', 09:11:05 INFO - 'sessionrestore', 09:11:05 INFO - 'sessionrestore_no_auto_restore', 09:11:05 INFO - 'tabpaint']}, 09:11:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:11:05 INFO - 'ts_paint', 09:11:05 INFO - 'tpaint', 09:11:05 INFO - 'sessionrestore', 09:11:05 INFO - 'sessionrestore_no_auto_restore', 09:11:05 INFO - 'tabpaint']}, 09:11:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:11:05 INFO - 'tests': ['a11yr', 09:11:05 INFO - 'ts_paint', 09:11:05 INFO - 'tpaint', 09:11:05 INFO - 'sessionrestore', 09:11:05 INFO - 'sessionrestore_no_auto_restore', 09:11:05 INFO - 'tabpaint']}, 09:11:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:11:05 INFO - 'tests': ['a11yr', 09:11:05 INFO - 'ts_paint', 09:11:05 INFO - 'tpaint', 09:11:05 INFO - 'sessionrestore', 09:11:05 INFO - 'sessionrestore_no_auto_restore', 09:11:05 INFO - 'tabpaint']}, 09:11:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:11:05 INFO - 'tests': ['tsvgx', 09:11:05 INFO - 'tsvgr_opacity', 09:11:05 INFO - 'tart', 09:11:05 INFO - 'tscrollx', 09:11:05 INFO - 'cart']}, 09:11:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:11:05 INFO - 'tsvgr_opacity', 09:11:05 INFO - 'tart', 09:11:05 INFO - 'tscrollx', 09:11:05 INFO - 'cart']}, 09:11:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:05 INFO - 'talos_options': ['--disable-e10s'], 09:11:05 INFO - 'tests': ['tp5o']}, 09:11:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:05 INFO - 'tests': ['tp5o']}, 09:11:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:05 INFO - 'talos_options': ['--disable-e10s', 09:11:05 INFO - '--xperf_path', 09:11:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:11:05 INFO - 'tests': ['tp5n']}, 09:11:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:05 INFO - 'talos_options': ['--xperf_path', 09:11:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:11:05 INFO - 'tests': ['tp5n']}}, 09:11:05 INFO - 'talos.zip': {'path': '', 09:11:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:11:05 INFO - Running post-action listener: _resource_record_post_action 09:11:05 INFO - [mozharness: 2016-08-30 16:11:05.883935Z] Finished populate-webroot step (success) 09:11:05 INFO - [mozharness: 2016-08-30 16:11:05.884040Z] Running create-virtualenv step. 09:11:05 INFO - Running pre-action listener: _resource_record_pre_action 09:11:05 INFO - Running main action method: create_virtualenv 09:11:05 INFO - Creating virtualenv /builds/slave/test/build/venv 09:11:05 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 09:11:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:11:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:11:06 INFO - Using real prefix '/tools/python27' 09:11:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:11:06 INFO - Installing distribute.............................................................................................................................................................................................done. 09:11:09 INFO - Installing pip.................done. 09:11:09 INFO - Return code: 0 09:11:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:11: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')]} 09:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11: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')]} 09:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:09 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 0x10b48ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b521618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa092cc5a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3f0d30>, '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 0x10b155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3e8b20>, '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.IxN8FVrBqT/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.Yxlt8Z7gJe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 09:11:09 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 09:11:09 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 09:11:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IxN8FVrBqT/Render', 09:11:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:11:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:11:09 INFO - 'HOME': '/Users/cltbld', 09:11:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:11:09 INFO - 'LOGNAME': 'cltbld', 09:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:09 INFO - 'MOZ_NO_REMOTE': '1', 09:11:09 INFO - 'NO_EM_RESTART': '1', 09:11:09 INFO - 'PAGER': '/bin/cat', 09:11:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:09 INFO - 'PWD': '/builds/slave/test', 09:11:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:11:09 INFO - 'SHELL': '/bin/bash', 09:11:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yxlt8Z7gJe/Listeners', 09:11:09 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:11:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:11:09 INFO - 'USER': 'cltbld', 09:11:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:11:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:09 INFO - 'XPC_FLAGS': '0x0', 09:11:09 INFO - 'XPC_SERVICE_NAME': '0', 09:11:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:09 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 09:11:09 INFO - Cleaning up... 09:11:09 INFO - Return code: 0 09:11:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:11: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')]} 09:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11: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')]} 09:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:09 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 0x10b48ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b521618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa092cc5a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3f0d30>, '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 0x10b155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3e8b20>, '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.IxN8FVrBqT/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.Yxlt8Z7gJe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 09:11:09 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 09:11:09 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 09:11:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IxN8FVrBqT/Render', 09:11:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:11:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:11:09 INFO - 'HOME': '/Users/cltbld', 09:11:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:11:09 INFO - 'LOGNAME': 'cltbld', 09:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:09 INFO - 'MOZ_NO_REMOTE': '1', 09:11:09 INFO - 'NO_EM_RESTART': '1', 09:11:09 INFO - 'PAGER': '/bin/cat', 09:11:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:09 INFO - 'PWD': '/builds/slave/test', 09:11:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:11:09 INFO - 'SHELL': '/bin/bash', 09:11:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yxlt8Z7gJe/Listeners', 09:11:09 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:11:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:11:09 INFO - 'USER': 'cltbld', 09:11:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:11:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:09 INFO - 'XPC_FLAGS': '0x0', 09:11:09 INFO - 'XPC_SERVICE_NAME': '0', 09:11:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:10 INFO - Downloading/unpacking psutil>=3.1.1 09:11:10 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 09:11:10 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 09:11:10 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 09:11:10 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 09:11:10 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 09:11:10 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 09:11:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:11:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:11:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:11:13 INFO - Installing collected packages: psutil 09:11:13 INFO - Running setup.py install for psutil 09:11:14 INFO - building 'psutil._psutil_osx' extension 09:11:14 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 09:11:14 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 09:11:14 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 09:11:14 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 09:11:14 INFO - building 'psutil._psutil_posix' extension 09:11:14 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 09:11:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:11:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:11:14 INFO - ^ 09:11:14 INFO - 1 warning generated. 09:11:14 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 09:11:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:11:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:11:15 INFO - Successfully installed psutil 09:11:15 INFO - Cleaning up... 09:11:15 INFO - Return code: 0 09:11:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b48ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b521618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa092cc5a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3f0d30>, '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 0x10b155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3e8b20>, '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.IxN8FVrBqT/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.Yxlt8Z7gJe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 09:11:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:11:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:11:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IxN8FVrBqT/Render', 09:11:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:11:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:11:15 INFO - 'HOME': '/Users/cltbld', 09:11:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:11:15 INFO - 'LOGNAME': 'cltbld', 09:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:15 INFO - 'MOZ_NO_REMOTE': '1', 09:11:15 INFO - 'NO_EM_RESTART': '1', 09:11:15 INFO - 'PAGER': '/bin/cat', 09:11:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:15 INFO - 'PWD': '/builds/slave/test', 09:11:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:11:15 INFO - 'SHELL': '/bin/bash', 09:11:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yxlt8Z7gJe/Listeners', 09:11:15 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:11:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:11:15 INFO - 'USER': 'cltbld', 09:11:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:11:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:15 INFO - 'XPC_FLAGS': '0x0', 09:11:15 INFO - 'XPC_SERVICE_NAME': '0', 09:11:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:11:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:11:18 INFO - Installing collected packages: mozsystemmonitor 09:11:18 INFO - Running setup.py install for mozsystemmonitor 09:11:18 INFO - Successfully installed mozsystemmonitor 09:11:18 INFO - Cleaning up... 09:11:18 INFO - Return code: 0 09:11:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:11: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')]} 09:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11: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')]} 09:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b48ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b521618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa092cc5a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3f0d30>, '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 0x10b155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3e8b20>, '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.IxN8FVrBqT/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.Yxlt8Z7gJe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 09:11:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:11:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IxN8FVrBqT/Render', 09:11:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:11:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:11:18 INFO - 'HOME': '/Users/cltbld', 09:11:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:11:18 INFO - 'LOGNAME': 'cltbld', 09:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:18 INFO - 'MOZ_NO_REMOTE': '1', 09:11:18 INFO - 'NO_EM_RESTART': '1', 09:11:18 INFO - 'PAGER': '/bin/cat', 09:11:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:18 INFO - 'PWD': '/builds/slave/test', 09:11:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:11:18 INFO - 'SHELL': '/bin/bash', 09:11:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yxlt8Z7gJe/Listeners', 09:11:18 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:11:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:11:18 INFO - 'USER': 'cltbld', 09:11:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:11:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:18 INFO - 'XPC_FLAGS': '0x0', 09:11:18 INFO - 'XPC_SERVICE_NAME': '0', 09:11:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:18 INFO - Downloading/unpacking jsonschema==2.5.1 09:11:18 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 09:11:18 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 09:11:18 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 09:11:18 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 09:11:18 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 09:11:18 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 09:11:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:11:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:11:20 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 09:11:20 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 09:11:20 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 09:11:20 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 09:11:20 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 09:11:20 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 09:11:21 INFO - Downloading functools32-3.2.3-2.tar.gz 09:11:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:11:21 INFO - warning: no files found matching '*.txt' 09:11:21 INFO - no previously-included directories found matching 'build' 09:11:21 INFO - no previously-included directories found matching 'dist' 09:11:21 INFO - no previously-included directories found matching '.git*' 09:11:21 INFO - Installing collected packages: jsonschema, functools32 09:11:21 INFO - Running setup.py install for functools32 09:11:21 INFO - warning: no files found matching '*.txt' 09:11:21 INFO - no previously-included directories found matching 'build' 09:11:21 INFO - no previously-included directories found matching 'dist' 09:11:21 INFO - no previously-included directories found matching '.git*' 09:11:21 INFO - Successfully installed jsonschema functools32 09:11:21 INFO - Cleaning up... 09:11:21 INFO - Return code: 0 09:11:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:11:21 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')]} 09:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:21 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')]} 09:11:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:21 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 0x10b48ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b521618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa092cc5a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3f0d30>, '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 0x10b155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3e8b20>, '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.IxN8FVrBqT/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.Yxlt8Z7gJe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 09:11:21 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 09:11:21 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 09:11:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IxN8FVrBqT/Render', 09:11:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:11:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:11:21 INFO - 'HOME': '/Users/cltbld', 09:11:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:11:21 INFO - 'LOGNAME': 'cltbld', 09:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:21 INFO - 'MOZ_NO_REMOTE': '1', 09:11:21 INFO - 'NO_EM_RESTART': '1', 09:11:21 INFO - 'PAGER': '/bin/cat', 09:11:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:21 INFO - 'PWD': '/builds/slave/test', 09:11:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:11:21 INFO - 'SHELL': '/bin/bash', 09:11:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yxlt8Z7gJe/Listeners', 09:11:21 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:11:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:11:21 INFO - 'USER': 'cltbld', 09:11:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:11:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:21 INFO - 'XPC_FLAGS': '0x0', 09:11:21 INFO - 'XPC_SERVICE_NAME': '0', 09:11:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:11:22 INFO - Cleaning up... 09:11:22 INFO - Return code: 0 09:11:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:11:22 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')]} 09:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:22 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')]} 09:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:22 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 0x10b48ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b521618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa092cc5a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3f0d30>, '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 0x10b155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3e8b20>, '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.IxN8FVrBqT/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.Yxlt8Z7gJe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 09:11:22 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 09:11:22 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 09:11:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IxN8FVrBqT/Render', 09:11:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:11:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:11:22 INFO - 'HOME': '/Users/cltbld', 09:11:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:11:22 INFO - 'LOGNAME': 'cltbld', 09:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:22 INFO - 'MOZ_NO_REMOTE': '1', 09:11:22 INFO - 'NO_EM_RESTART': '1', 09:11:22 INFO - 'PAGER': '/bin/cat', 09:11:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:22 INFO - 'PWD': '/builds/slave/test', 09:11:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:11:22 INFO - 'SHELL': '/bin/bash', 09:11:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yxlt8Z7gJe/Listeners', 09:11:22 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:11:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:11:22 INFO - 'USER': 'cltbld', 09:11:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:11:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:22 INFO - 'XPC_FLAGS': '0x0', 09:11:22 INFO - 'XPC_SERVICE_NAME': '0', 09:11:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:22 INFO - Downloading/unpacking blobuploader==1.2.4 09:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:24 INFO - Downloading blobuploader-1.2.4.tar.gz 09:11:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:11:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:11:24 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 09:11:24 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 09:11:24 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 09:11:24 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 09:11:24 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 09:11:24 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 09:11:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:11:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:11:25 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 09:11:25 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 09:11:25 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 09:11:25 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 09:11:25 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 09:11:25 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 09:11:25 INFO - Downloading docopt-0.6.1.tar.gz 09:11:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:11:26 INFO - Installing collected packages: blobuploader, requests, docopt 09:11:26 INFO - Running setup.py install for blobuploader 09:11:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:11:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:11:26 INFO - Running setup.py install for requests 09:11:26 INFO - Running setup.py install for docopt 09:11:26 INFO - Successfully installed blobuploader requests docopt 09:11:26 INFO - Cleaning up... 09:11:26 INFO - Return code: 0 09:11:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11: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')]} 09:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11: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')]} 09:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:26 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 0x10b48ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b521618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa092cc5a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3f0d30>, '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 0x10b155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3e8b20>, '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.IxN8FVrBqT/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.Yxlt8Z7gJe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 09:11:26 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 09:11:26 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 09:11:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IxN8FVrBqT/Render', 09:11:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:11:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:11:26 INFO - 'HOME': '/Users/cltbld', 09:11:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:11:26 INFO - 'LOGNAME': 'cltbld', 09:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:26 INFO - 'MOZ_NO_REMOTE': '1', 09:11:26 INFO - 'NO_EM_RESTART': '1', 09:11:26 INFO - 'PAGER': '/bin/cat', 09:11:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:26 INFO - 'PWD': '/builds/slave/test', 09:11:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:11:26 INFO - 'SHELL': '/bin/bash', 09:11:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yxlt8Z7gJe/Listeners', 09:11:26 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:11:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:11:26 INFO - 'USER': 'cltbld', 09:11:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:11:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:26 INFO - 'XPC_FLAGS': '0x0', 09:11:26 INFO - 'XPC_SERVICE_NAME': '0', 09:11:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:11:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:11:27 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-GVaLT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:11:27 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-NVKfRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:11:27 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-1aoriG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:11:27 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-0xuza2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:11:27 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-xa9kLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:11:27 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-1zbaCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:11:27 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-678yJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:11:27 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-k3XXbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:11:28 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-aM2L5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:11:28 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-fekWCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:11:28 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-SK9Euf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:11:28 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-oQqX3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:11:28 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-83tVDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:11:28 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-AaQnY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:28 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-u_e50a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:11:28 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-HdTEdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:11:28 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-EaAGZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:11:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:11:28 INFO - Running setup.py install for manifestparser 09:11:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:11:29 INFO - Running setup.py install for mozcrash 09:11:29 INFO - Running setup.py install for mozdebug 09:11:29 INFO - Running setup.py install for mozdevice 09:11:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:11:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:11:29 INFO - Running setup.py install for mozfile 09:11:29 INFO - Running setup.py install for mozhttpd 09:11:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:11:29 INFO - Running setup.py install for mozinfo 09:11:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:11:29 INFO - Running setup.py install for mozInstall 09:11:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:11:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:11:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:11:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:11:30 INFO - Running setup.py install for mozleak 09:11:30 INFO - Running setup.py install for mozlog 09:11:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:11:30 INFO - Running setup.py install for moznetwork 09:11:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:11:30 INFO - Running setup.py install for mozprocess 09:11:30 INFO - Running setup.py install for mozprofile 09:11:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:11:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:11:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:11:30 INFO - Running setup.py install for mozrunner 09:11:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:11:31 INFO - Running setup.py install for mozscreenshot 09:11:31 INFO - Running setup.py install for moztest 09:11:31 INFO - Running setup.py install for mozversion 09:11:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:11:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:11:31 INFO - Cleaning up... 09:11:31 INFO - Return code: 0 09:11:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:31 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 0x10b48ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b521618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa092cc5a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3f0d30>, '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 0x10b155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3e8b20>, '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.IxN8FVrBqT/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.Yxlt8Z7gJe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 09:11:31 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 09:11:31 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 09:11:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IxN8FVrBqT/Render', 09:11:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:11:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:11:31 INFO - 'HOME': '/Users/cltbld', 09:11:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:11:31 INFO - 'LOGNAME': 'cltbld', 09:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:31 INFO - 'MOZ_NO_REMOTE': '1', 09:11:31 INFO - 'NO_EM_RESTART': '1', 09:11:31 INFO - 'PAGER': '/bin/cat', 09:11:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:31 INFO - 'PWD': '/builds/slave/test', 09:11:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:11:31 INFO - 'SHELL': '/bin/bash', 09:11:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yxlt8Z7gJe/Listeners', 09:11:31 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:11:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:11:31 INFO - 'USER': 'cltbld', 09:11:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:11:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:31 INFO - 'XPC_FLAGS': '0x0', 09:11:31 INFO - 'XPC_SERVICE_NAME': '0', 09:11:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:11:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:11:31 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-wVu8DZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:11:31 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)) 09:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:11:31 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-ga9GqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:11:32 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)) 09:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:11:32 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-a1tSEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:11:32 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)) 09:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:11:32 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-ehheJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:11:32 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)) 09:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:11:32 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-3o2y6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:11:32 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)) 09:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:11:32 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-PYQQh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:11:32 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)) 09:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:11:32 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-LIptUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:11:32 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)) 09:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:11:32 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-vUZeDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:11:32 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)) 09:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:11:32 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-u3ZO57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:11:32 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)) 09:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:11:32 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-89zbjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:11:32 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)) 09:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:11:32 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-uC7ETW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:11:32 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)) 09:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:11:32 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-xaueCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:11:33 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)) 09:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:11:33 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-eZfcxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:11:33 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)) 09:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:11:33 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-jAxGxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:11:33 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)) 09:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:33 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-OcaG3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:33 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)) 09:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:11:33 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-m_9RJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:11:33 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)) 09:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:11:33 INFO - Running setup.py (path:/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/pip-3uGYvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:11:33 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)) 09:11:33 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)) 09:11:33 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)) 09:11:33 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)) 09:11:33 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)) 09:11:33 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)) 09:11:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:11:33 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 09:11:33 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 09:11:33 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 09:11:33 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 09:11:33 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 09:11:33 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 09:11:36 INFO - Downloading blessings-1.6.tar.gz 09:11:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:11:36 INFO - Installing collected packages: blessings 09:11:36 INFO - Running setup.py install for blessings 09:11:36 INFO - Successfully installed blessings 09:11:36 INFO - Cleaning up... 09:11:36 INFO - Return code: 0 09:11:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:11:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:11:36 INFO - Reading from file tmpfile_stdout 09:11:36 INFO - Current package versions: 09:11:36 INFO - blessings == 1.6 09:11:36 INFO - blobuploader == 1.2.4 09:11:36 INFO - docopt == 0.6.1 09:11:36 INFO - functools32 == 3.2.3-2 09:11:36 INFO - jsonschema == 2.5.1 09:11:36 INFO - manifestparser == 1.1 09:11:36 INFO - mozInstall == 1.12 09:11:36 INFO - mozcrash == 0.17 09:11:36 INFO - mozdebug == 0.1 09:11:36 INFO - mozdevice == 0.48 09:11:36 INFO - mozfile == 1.2 09:11:36 INFO - mozhttpd == 0.7 09:11:36 INFO - mozinfo == 0.9 09:11:36 INFO - mozleak == 0.1 09:11:36 INFO - mozlog == 3.3 09:11:36 INFO - moznetwork == 0.27 09:11:36 INFO - mozprocess == 0.23 09:11:36 INFO - mozprofile == 0.28 09:11:36 INFO - mozrunner == 6.12 09:11:36 INFO - mozscreenshot == 0.1 09:11:36 INFO - mozsystemmonitor == 0.3 09:11:36 INFO - moztest == 0.7 09:11:36 INFO - mozversion == 1.4 09:11:36 INFO - psutil == 3.1.1 09:11:36 INFO - requests == 1.2.3 09:11:36 INFO - wsgiref == 0.1.2 09:11:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11:36 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')]} 09:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:36 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')]} 09:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:36 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 0x10b48ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b521618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa092cc5a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3f0d30>, '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 0x10b155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3e8b20>, '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.IxN8FVrBqT/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.Yxlt8Z7gJe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 09:11:36 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 09:11:36 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 09:11:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IxN8FVrBqT/Render', 09:11:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:11:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:11:36 INFO - 'HOME': '/Users/cltbld', 09:11:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:11:36 INFO - 'LOGNAME': 'cltbld', 09:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:36 INFO - 'MOZ_NO_REMOTE': '1', 09:11:36 INFO - 'NO_EM_RESTART': '1', 09:11:36 INFO - 'PAGER': '/bin/cat', 09:11:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:36 INFO - 'PWD': '/builds/slave/test', 09:11:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:11:36 INFO - 'SHELL': '/bin/bash', 09:11:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yxlt8Z7gJe/Listeners', 09:11:36 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:11:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:11:36 INFO - 'USER': 'cltbld', 09:11:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:11:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:36 INFO - 'XPC_FLAGS': '0x0', 09:11:36 INFO - 'XPC_SERVICE_NAME': '0', 09:11:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:37 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)) 09:11:37 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)) 09:11:37 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)) 09:11:37 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)) 09:11:37 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)) 09:11:37 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)) 09:11:37 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)) 09:11:37 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)) 09:11:37 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)) 09:11:37 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)) 09:11:37 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)) 09:11:37 INFO - Cleaning up... 09:11:37 INFO - Return code: 0 09:11:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:11: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')]} 09:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11: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')]} 09:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b48ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b521618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa092cc5a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3f0d30>, '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 0x10b155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3e8b20>, '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.IxN8FVrBqT/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.Yxlt8Z7gJe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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 09:11: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', 'jsonschema'] in /builds/slave/test/build 09:11: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 jsonschema 09:11:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IxN8FVrBqT/Render', 09:11:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:11:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:11:37 INFO - 'HOME': '/Users/cltbld', 09:11:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:11:37 INFO - 'LOGNAME': 'cltbld', 09:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:37 INFO - 'MOZ_NO_REMOTE': '1', 09:11:37 INFO - 'NO_EM_RESTART': '1', 09:11:37 INFO - 'PAGER': '/bin/cat', 09:11:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:37 INFO - 'PWD': '/builds/slave/test', 09:11:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:11:37 INFO - 'SHELL': '/bin/bash', 09:11:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yxlt8Z7gJe/Listeners', 09:11:37 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:11:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:11:37 INFO - 'USER': 'cltbld', 09:11:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:11:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:37 INFO - 'XPC_FLAGS': '0x0', 09:11:37 INFO - 'XPC_SERVICE_NAME': '0', 09:11:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:11:37 INFO - Cleaning up... 09:11:37 INFO - Return code: 0 09:11:37 INFO - Running post-action listener: _resource_record_post_action 09:11:37 INFO - Running post-action listener: _start_resource_monitoring 09:11:37 INFO - Starting resource monitoring. 09:11:37 INFO - [mozharness: 2016-08-30 16:11:37.417695Z] Finished create-virtualenv step (success) 09:11:37 INFO - [mozharness: 2016-08-30 16:11:37.418753Z] Running install step. 09:11:37 INFO - Running pre-action listener: _resource_record_pre_action 09:11:37 INFO - Running main action method: install 09:11:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:11:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:11:37 INFO - Reading from file tmpfile_stdout 09:11:37 INFO - Detecting whether we're running mozinstall >=1.0... 09:11:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:11:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:11:37 INFO - Reading from file tmpfile_stdout 09:11:37 INFO - Output received: 09:11:37 INFO - Usage: mozinstall [options] installer 09:11:37 INFO - Options: 09:11:37 INFO - -h, --help show this help message and exit 09:11:37 INFO - -d DEST, --destination=DEST 09:11:37 INFO - Directory to install application into. [default: 09:11:37 INFO - "/builds/slave/test"] 09:11:37 INFO - --app=APP Application being installed. [default: firefox] 09:11:37 INFO - mkdir: /builds/slave/test/build/application 09:11:37 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'] 09:11:37 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 09:12:11 INFO - Reading from file tmpfile_stdout 09:12:11 INFO - Output received: 09:12:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:12:11 INFO - Running post-action listener: _resource_record_post_action 09:12:11 INFO - [mozharness: 2016-08-30 16:12:11.911519Z] Finished install step (success) 09:12:11 INFO - [mozharness: 2016-08-30 16:12:11.911661Z] Running run-tests step. 09:12:11 INFO - Running pre-action listener: _resource_record_pre_action 09:12:11 INFO - Running main action method: run_tests 09:12:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:12:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:12:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:12:11 INFO - 2016-08-30 09:12:11.926 screenresolution[1638:8163] starting screenresolution argv=screenresolution get 09:12:11 INFO - 2016-08-30 09:12:11.929 screenresolution[1638:8163] Display 0: 1600x1200x32@60 09:12:11 INFO - 2016-08-30 09:12:11.935 screenresolution[1639:8165] starting screenresolution argv=screenresolution list 09:12:11 INFO - Available Modes on Display 0 09:12:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:12:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:12:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:12:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:12:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:12:12 INFO - Intel Iris: 09:12:12 INFO - Chipset Model: Intel Iris 09:12:12 INFO - Type: GPU 09:12:12 INFO - Bus: Built-In 09:12:12 INFO - VRAM (Dynamic, Max): 1536 MB 09:12:12 INFO - Vendor: Intel (0x8086) 09:12:12 INFO - Device ID: 0x0a2e 09:12:12 INFO - Revision ID: 0x0009 09:12:12 INFO - Displays: 09:12:12 INFO - Display: 09:12:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:12:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:12:12 INFO - Display Serial Number: 1600x1200 60 09:12:12 INFO - Main Display: Yes 09:12:12 INFO - Mirror: Off 09:12:12 INFO - Online: Yes 09:12:12 INFO - Rotation: Supported 09:12:12 INFO - Return code: 0 09:12:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:12:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:12:12 INFO - Python 2.7.3 09:12:12 INFO - Return code: 0 09:12:12 INFO - grabbing minidump binary from tooltool 09:12:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:12 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 0x10b3f0d30>, '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 0x10b155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3e8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:12:12 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 09:12:12 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 09:12:12 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 09:12:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:12:12 INFO - Return code: 0 09:12:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:12:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:12:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:12:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:12:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:12:12 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/d7P1Rf47TEG7VGn_dH6pGg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0104', '--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 09:12:12 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/d7P1Rf47TEG7VGn_dH6pGg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0104 --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 09:12:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IxN8FVrBqT/Render', 09:12:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:12 INFO - 'HOME': '/Users/cltbld', 09:12:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:12 INFO - 'LOGNAME': 'cltbld', 09:12:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:12:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:12 INFO - 'MOZ_NO_REMOTE': '1', 09:12:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:12:12 INFO - 'NO_EM_RESTART': '1', 09:12:12 INFO - 'PAGER': '/bin/cat', 09:12:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:12 INFO - 'PWD': '/builds/slave/test', 09:12:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:12:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:12 INFO - 'SHELL': '/bin/bash', 09:12:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Yxlt8Z7gJe/Listeners', 09:12:12 INFO - 'TMPDIR': '/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/', 09:12:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:12 INFO - 'USER': 'cltbld', 09:12:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:12 INFO - 'XPC_FLAGS': '0x0', 09:12:12 INFO - 'XPC_SERVICE_NAME': '0', 09:12:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:12 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/d7P1Rf47TEG7VGn_dH6pGg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0104', '--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 09:12:12 INFO - mozversion application_buildid: 20160830065321 09:12:12 INFO - mozversion application_changeset: b18c8bcdc116eef8799880b7c50317bf54218474 09:12:12 INFO - mozversion application_display_name: Nightly 09:12:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:12:12 INFO - mozversion application_name: Firefox 09:12:12 INFO - mozversion application_remotingname: firefox 09:12:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:12:12 INFO - mozversion application_vendor: Mozilla 09:12:12 INFO - mozversion application_version: 51.0a1 09:12:12 INFO - mozversion platform_buildid: 20160830065321 09:12:12 INFO - mozversion platform_changeset: b18c8bcdc116eef8799880b7c50317bf54218474 09:12:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:12:12 INFO - mozversion platform_version: 51.0a1 09:12:12 INFO - using testdate: 1472573532 09:12:12 INFO - actual date: 1472573532 09:12:12 INFO - starting webserver on 'localhost:49266' 09:12:12 INFO - SUITE-START | Running 2 tests 09:12:12 INFO - TEST-START | dromaeo_css 09:12:12 INFO - operating with platform_type : mac_ 09:12:12 INFO - Initialising browser for dromaeo_css test... 09:12:12 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmpXZdmEq/profile http://localhost:49266/getInfo.html) 09:12:15 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 09:12:15 INFO - PROCESS | 1649 | colorDepth:24 09:12:15 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 09:12:15 INFO - PROCESS | 1649 | __metrics 09:12:15 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 09:12:16 INFO - TEST-INFO | 1649: exit 0 09:12:16 INFO - Browser initialized. 09:12:16 INFO - Running cycle 1/1 for dromaeo_css test... 09:12:16 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmpXZdmEq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:12:28 INFO - PROCESS | 1653 | RSS: Main: 244281344 09:12:28 INFO - PROCESS | 1653 | 09:13:17 INFO - PROCESS | 1653 | 1472573597676 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] 09:15:30 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 09:15:31 INFO - PROCESS | 1653 | RSS: Main: 266600448 09:15:31 INFO - PROCESS | 1653 | 09:18:33 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 09:18:34 INFO - PROCESS | 1653 | RSS: Main: 275566592 09:18:34 INFO - PROCESS | 1653 | 09:21:36 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 09:21:37 INFO - PROCESS | 1653 | RSS: Main: 277323776 09:21:37 INFO - PROCESS | 1653 | 09:24:39 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 09:24:39 INFO - PROCESS | 1653 | RSS: Main: 272998400 09:24:39 INFO - PROCESS | 1653 | 09:27:42 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 09:27:43 INFO - PROCESS | 1653 | RSS: Main: 278392832 09:27:43 INFO - PROCESS | 1653 | 09:30:46 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 09:30:46 INFO - PROCESS | 1653 | RSS: Main: 280010752 09:30:46 INFO - PROCESS | 1653 | 09:30:46 INFO - PROCESS | 1653 | __start_tp_report 09:30:46 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 09:30:46 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 09:30:46 INFO - PROCESS | 1653 | |i|pagename|runs| 09:30:46 INFO - PROCESS | 1653 | |0;dojo.html;3073.2931425772085;3359;3389.4237979543477;3410.249745056087;3466.7919924804505;5614.101743721006;5693.373728889829;5720.05619072853;5733.713314334287;5803.332616749075;5712.828615141542;5715.2855893013375;5729.05470597352;5792.71036448177;5863.237779088712;5150.562202212797;5196.3764348278255;5214;5287.41838397776;5297.046531624306;5321.201819727034;5344.011357898782;5352.545033672142;5367.06076436624;5377.274068000828;5159.484051594848;5220.660657057279;5237.083510385667;5249.501297376743;5261.684298942076;4291.570842915715;4320.330348795942;4565.771711414416;5251.317328747276;5309.283246761715;3803;4353.129374125156;4965.155923493015;5178.197379406198;5235.319408476912;4645.651576131803;5581.972090139523;5679.261695979538;5763.596548241625;5765.538756899438;6091.17419508421;6149.831532008904;6209.348018458042;6223.346548612376;6228.750849965996;6243.843903902393;6290.308066112724;6292.024736165901;6294.181756371642;6317.87364252717;5785.47930686236;5818.7672493100645;5852.707364631751;5865.941340586625;5893.911591326134;6203.658798766111;6205.751769929243;6241.500679945593;6271.749130034838;6325.557210995278;6046.516278697693;6175.042868355412;6180.598261113013;6188.597741146811;6191.628502289787;6097.766665674581;6161.507079433634;6224.875502489925;6252.187215661935;6261.624302541862;6147.047207682816;6229.906551401733;6236.251649801962;6236.6258024518675;6276.497880169575;6233.875322493524;6248.718807653667;6288.056791481315;6300.117983482316;6322.209723784527;4852.393450818648;4906.656534042583;4909.7790599423115;4934.4572097069295;4995.975020124876;4430.623397011225;4433.1577000369825;4435.822567097344;4445.133199026223;4487.035287413222;5453.836384908459;5757.683327417032;5843.18195452637;5869.383714709979;5870.119482077723;4728.38530990969;5127.282180494733;5158.587313014949;6187.969060154671;6198.132261483306;5877.706114694248;5889.293284805851;5904.5571582131515;5921.496672782861;5973.641581505123;5432.782688692408;5465.945340546544;5475.425080366584;5482.23248745176;5496.31296087989;6165.414285642857;6225.564210505221;6242.875142497034;6322.652254125976;6324.430801227912;6231.688415579293;6245.781397651061;6273.404026617464;6285.371462853678;6288.276848162337;6245.843853903689;6264.718087685974;6275.937240627535;6300.086487459384;6321.209848768904;5024;6125.571210015256;6143.511877689543;6239.719212635533;6288.496920246461;6250.781222657185;6260.280067792262;6274.843128921813;6289.654069026247;6312.368763123651;6029.939700603113;6142.969285153546;6172.506199504119;6173.104899789416;6188.659623720739;5997.400259973968;6057.273127224761;6127.295361033538;6135.32453530862;6173.907391389043;5435.93999170158;5805.245318108618;6013.098035294566;6063.060225665029;6088.36072212429;6151.907721384094;6163.106349579376;6187.288461826947;6196.225471816023;6206.813795585959;5856.824295271149;5978.701064946648;6047.002244629763;6063.787767428295;6076.453119219292 09:30:46 INFO - PROCESS | 1653 | |1;ext.html;444.57987202094034;480.8966072294456;506.2002036781884;522.9633925625205;630.2279707358483;38372.42441363382;40933.38599921;40983.59016409835;41035.79482102593;41149.38275925864;41369.58630413695;41917;41965.37051944216;41977;42026.36960445588;9696.369735967157;9885;9906.257030722689;9913.801723965516;9929.205663546934;9769.169620582259;9851;9857.90142098577;9858.112769850712;9865.062819032217;9793.461359625218;9859.90140098597;9891.455969921652;9896.257780666443;9907.207423406111;9854.852177217348;9867.654632087842;9868.703938881845;9883.011698830096;9895.208383329316;9754.512274386252;9803.411795292306;9819.90180098197;9835.852462213072;9852.50737463124;35173.648263517294;35288.58845646171;35828.641713582794;40128.79935600333;40273.99315017118;2971.6731159572428;3150.8582113804705;3286.917827054319;3518.9296214075575;3627.9455808162897;22815.31554053381;22932.88533557338;23360.64959025616;27328.59007114895;28133.57799633007;2665.8800353983925;3239.0444818778515;3288.852001659931;3402.5236466894653;3403.846826892796;442689;446570;447917;453391;453936.7303163496;32921.17697057593;33739.66260337414;61483.38516614777;61757.69121154455;61861;34525.30949380998;34725.47911781325;34845.30309393798;34966.30067398638;34999.65000349964;14734.336954837057;14905.850941490446;14915.850841491663;14922.477713279983;14935.551933442013;12193.024558035337;12522;12539.811902821464;12618.432170552347;12620.558280460324;7606.163322034572;7623.35201507867;7688.231176882267;7691.653960556992;7701.422393320523;3106.8601912913973;3147.4177277203335;3150.9054728358187;3174.2857856981996;3179.2846609513135;916.5325683901125;997.9451130187764;1019.0268293779571;1043.2957753516498;1126.1474873832499;30350;30741.538876916864;31060;31295.687043129732;31299;947.5877993073035;1009.3439264478149;1009.9092979582034;1029.9279050466546;1054.4710170253163;12424.399172369902;15172.393104275927;15376.384944602314;15742.97670651427;15762.369505219893;664751;677831;680813;681483;685245;56650.86698266012;56686;56882;57150.714246429336;57491.13763293554;1281;1312.4159748911834;1314.0867097367238;1317.117531254043;1322.233104799214;29399.26501837471;29574.704252957195;29688.55467167951;30120;30130.84934575313;49144.262836056776;54964.45035549753;55272.17091743547;56711;59714.40285597088;629006;634925;635085.8245708742;635398;641668;42673.57326426696;42737.786311068245;42874.356884646135;43024.56975430206;43340.13319733524;38825.6117438822;47156.7642161787;47649.28526072181;47670.523294768;48149.75925120352;38555.80722096372;39431.80284098561;39477.01307467336;39582.80208599054;41187.1762564741;37224.81387593045;39346.80326598463;39477.81566553008;40337.79831100826;40604.3909341366;37799;38144.42783358196;38309.24884215574;39133;39376.606233937295;30914.690853091182;35050.82474587611;35213;35646.465303019955;37546.624533754315;23070.307890763303;23167.02432045785;25394.365140871625;26057.478850423264;26159.607605886307 09:30:46 INFO - PROCESS | 1653 | |2;jquery.html;341.31225580455384;371.0667670807917;379.4327480416777;383.52251446948554;402.4225236785213;16720.08039557824;19733.70399444008;20752.792472075274;21476.463088422777;21733;20457.795422045812;20727.963601819923;21183.682244766303;21259.787402125974;21427.464313392175;5277.445868183843;5864.912026319608;6050.969745151268;6104.572679912408;6123.601965872204;6016.578839481238;6052.152698622196;6059.575829691923;6073.574849760518;6095.878082438348;5835.0241376897875;5886.676232807194;6018.7893423730175;6024.879502409949;6032.276126864783;5925.407459254083;5951.523878089764;5995.370486098984;6019.127226552169;6025.307089684698;4988.5260900214425;5186.766595503173;5193.428722840485;5195.012947539955;5203.7918483261;25792;25829.22512324633;25915;25972.480550389075;26055.478890422084;1643.926023328953;2260.028187879211;2300.1029598456616;2504.9749502504924;2546.4652422991194;10195;10490.055894969413;12342.01263898886;15053.153085866572;15363;1781.4388467632655;1842.1986435900292;1845.308009496439;1878.4834170603194;1900.7338972543855;125799;130292.34853825765;130888;131913;132322;10721.463926803628;11325.37710425918;11453.484593193327;11467.254628449124;11572.826407603892;14355.995080344484;14386.712265754835;14497.492587759378;14509.201993890438;14522.346494407777;7768.805779855549;7974.843647671171;8443.831123377498;8530.616122274512;8576.356773242032;8445.57772111392;8522.5284667447;8526.445781024213;8693.217610415093;8703.47779133254;4477.350784136282;4480.663950203748;4484.708493947883;4490.012197316585;4518.43519560055;1756.9560760981078;1772.7075032619732;1872.4944265048632;1913.4068438784022;1925.431997560695;695.4957655699577;894.4633220067907;911.2163539356148;942.4910548303976;975.2490582251627;15001.024933379296;16505.917470412813;19398.61202775965;20201.393958181277;20370.898145509178;887.3573978816993;912.9863052054225;957.5978089202413;986.2356673578034;1016.2530540053056;10721.678349649523;11147.052500537384;11168.720781980515;11273.549058037586;11292.830607540729;550615;574713;595900;606033;610818;113945.4302728481;131240.3437982823;136193;136252;142852.28573857064;922.7462447826902;934.7990182110879;971.4414211828228;971.5482300730195;1000.7598176437602;19272.518187045436;19340.516487087934;19466;19635.509112272306;19672.803271967095;55185.44814551803;56231;56350.8729825393;57694.42305576891;58728.82542349215;83977.16022839694;84187;84540;84622.57688711517;84764.57617711872;7925.841483170419;7985.880211796712;8025.638846251816;8172.918270817216;8206.876896846672;10138.543765530716;12635.74728505443;12788;12943.935280323538;13202.867971320164;10775.676729698122;10850.620228291971;11113.555457781598;11206.719832004264;11319.773604527698;10126.24053196028;10849.783004340026;10949.50727217293;11133.777324453627;11259.268147570381;10896.564137434414;11256.549738010388;11351.489182986621;11375.54497820078;11447.599334023269;7907.090684571348;7927.920720792718;8267.049289331804;8292.958535207526;8335.166483351617;9915.752106197402;11003.889961100607;11184;11205.271657342246;11324.773504529698 09:30:46 INFO - PROCESS | 1653 | |3;mootools.html;1372.2109786872547;1469.9044562103459;1657.4116188752992;1758.5076178669976;1840.0891558678447;8035.357171426272;8478.321734261259;8697.2607328377;9087.727368178957;9112.726618201448;8685.95657021714;8936.285097192225;8936.776580585489;8936.955315223415;8948.552572371387;2368.348704106367;2387.259949415678;2394.1022116706235;2396.18529699902;2398.9324750485953;2355.9882200588972;2375.679283296759;2397.5324811661735;2404.230646193219;2419.6854408926815;2361.374235827507;2367.633016882386;2370.691810064689;2386.176769014687;2395.425097976482;1978.485593745622;2335.346103091137;2362.7282862470865;2372.2171683344627;2374.347054560001;2333.9380581835394;2354.6114891042957;2363.066588697472;2368.396059004943;2368.526294741059;8977.910220897838;9053.411528250643;9054.909450905472;9063.68277110298;9085.500297483635;5235.319408476874;5433.8369848904595;5434.456554344573;5436.103042997901;5455.863603409907;3578.2306804037;3605.4231322988194;3608.0979755061235;3672.706183505313;3676.191237927652;1069.7913906788178;1070.1064611049783;1073.683263437288;1075.4891426572394;1088.8149014667447;11580.247283926517;11639.941800290944;11671.883281167164;11736.178467507278;11766.647000589996;4598.724076555417;4692.366530518405;4839.830605928775;4850.53919877611;4892.510748925079;10074.194064474825;10162.542685579167;10163.542640581043;10200.846987295197;10219.540120694586;5367.221752845816;5369.570434365241;5388.407275199725;5393.865153371197;5433.8369848904595;3490.7032902203596;3811.809409529568;4085.775282359439;4907.3620429343955;4918.163912134945;3847.134394761212;3882.8058597070035;3970.4838371011583;3982.38273067675;4027.194561087794;1118.4016551145098;1123.6516679829278;1299.2139755447818;1313.960581182566;1314.4545013819159;647.9092926990226;929.2983797233046;936.9906300936904;937.95310234488;941.5010044676333;5608.822147349021;5840.970795145997;5854.151148083504;6085.117657939662;6178.165947597017;437.4204179462225;439.03193458424096;454.096348266953;460.9331646911179;460.9976950115228;3937.523428714232;4065.4714887064492;4181.581841815794;4190;4215.662746980234;10366.222533310032;10839.187060970458;10848.891511084947;10870.891291087146;10873.728156796144;10798.190135739695;10824.67525974222;10860.72848178786;10882.966118218757;10901.890981090088;7846.372290216769;8215.58922053895;8272.503649780912;8289.668413263402;8320.916790832136;5494.5054945055135;6077.848053798691;6083.787067452795;6207.596506227081;6343.3022367538615;10040.748981275527;10240.846387304047;10279.126274266471;10320.277580569287;10330.896691032993;9270.907290927003;9706.70879873605;10069.546870390997;10396.58413663445;10402.27184097106;7029.226785053538;7545.849083018418;7569.318761311288;7722.996010518596;7730.922690773245;8575;8579.485230886166;8650.826983460422;8661.740147795575;8674.783130421538;7561.470697051153;7712.652930618248;7720.7683769487;7784.9610751945875;7805.687772489036;7431.36833369148;7532.736354227576;7535.095788505414;7578.621068946421;7736.535807851547;7045.929540704732;7073.328033836778;7169.211386747558;7173.426125910019;7209.891851622335;4986.626003049713;4993.450720420823;5088.626070960894;5115.769790359368;5264.815731449381;4468.061707041427;4594.196015697173;4763.309320148628;5151.587872970078;5221.660592061504 09:30:46 INFO - PROCESS | 1653 | |4;prototype.html;305.8119256657156;310.6753442652428;311.91890108571766;312.8654678488252;315.2843046284933;4778.856634300968;5620.522255608273;5690.926899474279;5691.3739488656265;5695.43375571718;5528.153001204383;5532.75923251083;5573.442655734435;5600.327960644719;5682.602217844753;3686.4286035664513;4013.8761146878774;4137.8965525861795;4157.979210103946;4231.788410579474;3384.458486642138;4199.664026877857;4199.669183603099;4215.915681686364;4254.064105896698;3539.50446937429;3919.255341485123;3992.7604343739467;4013.4514583239707;4145.523264824538;3552.769070010441;3580.03339098442;4167.708260421741;4167.770507700206;4208.410822484854;3013.442513135077;3533.028417185269;3581.94627080594;3586.39031364666;3587.94155724062;4499.932501012488;4550.931736023962;5124.4875512448825;5429.53848922842;5478.780848766045;4629.699069560502;4638;4745.383100196952;4754.619630429557;4791.802049487628;5779.780760045149;5880.235569375954;5896.469317761422;5921.111833225051;5987.880242395127;3316.9054212110186;3397.1507123219194;3460.3425349183576;3500.8469791078305;3945.6251656092627;4979.875503112451;5215;5345;6010.278766547998;6031.276246850406;3612.710983121344;3926.54844692864;3987.803658902376;4017.1563971565715;4022.557518672944;4071.2875246831686;4076.8165432555606;4092.1201941582704;4096.283150448659;4134.855280065183;3738.3084129436143;4037.6366127048705;4802.519748025239;4813.462105352563;4814.662973591885;5408.91886621701;5431.565474762088;5497.6255936016;5753.568482363839;5983.491403230687;1240.2930329712158;1362.264377236301;1390.6453854267097;1391.8747312741903;1393.191948669769;788.7909703928464;830.8919840420707;847.3687103108224;847.4999750147442;849.1720572441819;4795.760211989386;5431.2396264522995;5628.831135065954;5660;5665.348484924204;4923.75381230937;5623.943760562423;5850.824475265749;6146.5390095743;6170.969145154335;4814.398200224972;5170.741462926914;5401.6218864679095;5620.63465874725;5622.943770562324;2607.331307962905;2899.6230490036583;2944.131481213047;3171.349873275973;3218.3885061838178;5368.5436737876935;5579.442055794388;5870.73581688825;6425.74297028123;6427.967860160669;5707.286589176353;5806.622569532967;5869.442402971711;6271.216097987752;6320.525960552977;5390.299261096033;6387.169667943138;6409.455196308273;6437.839054023687;6440.32376600469;5458.590605704668;5739.139129130497;6147.44672979434;6150.538709596887;6180.7527698891545;5351.973240133774;6098.695065246809;6152.230971128609;6174.228221472316;6203.410675985774;5339.4660533947845;6033.939660603338;6224.875502489835;6322.475004341751;6359.04614307839;4013.8795836124964;4019.954811748908;4059.5331536873637;4065.84123524794;4074.083331250445;6229.470495007975;6265.530085243534;6276.21127978524;6277.654728989949;6292.339304373158;4695.929561056519;4747.881302967454;4764.618830493483;4981.875453113701;5792.783515461801;5436.3476382834315;5953.690188158598;5974.058431010026;5975.760969561169;6023.909641355295;5174.560162386088;5500.129955815042;5853.2976042875125;5872.794452194153;5945;4964.404271487445;5214.400343960341;5425.376081750649;5871.4715675589405;5921.009890005692;5161.66449180802;5873.765049398147;5882.794102206402;5923.822285331447;5967.373425790403 09:30:46 INFO - PROCESS | 1653 | |5;yui.html;719.74089327842;764.2853931573978;776.7436745873862;793.7102957420543;803.4014659078987;15622.218889055559;15964.361425542993;15989.960652557591;15997.84002159978;16015.599610009756;14627.341769620367;14768.04007739499;14770.261486925638;14788.408463661468;14815.33331000105;688.7933619914031;834.7203686764926;838.1492784823379;858.1461445861377;861.5649097205934;871.024452613071;871.1897934920521;872.014623475475;874.5845723281423;875.1336177184605;925.8194652042854;927.420362273579;928.1507420710042;928.2666693312275;928.7213835849218;917.2936838634281;921.1203300847708;922.0917396364575;922.903095175007;923.8568021956642;683.2006552333781;684.3806355248508;686.502285842765;687.089606271687;690.5580428525748;14723.926380368137;14954.850451495455;15007.699846003128;15028.173450460221;15045.849541504555;14701.779473307908;14738;14749.77875331871;14788.70422591553;14789.852101478955;11779.175457717964;12045.096617753616;12096.153269271155;12267.631971040882;12519.248845069325;3737.4580685800406;3745.2696724138805;3962.32640451124;3966.7818269995137;3984.721069525134;102490;116746;117210;118218.81781182165;118657.40671296588;10616.710348661754;11196;11290.490780789818;11568.768624627628;11629.767404651859;20242.291519796738;22972.19597314086;23002.53994920126;23033.654495182585;23049.88475057614;6068.302145253352;7961;8097.271245587807;8211.83576328482;8298.294644955246;4400.955990440055;4465.642748580106;4530.184566778012;4540.72755634663;4617.561331673553;3478.339115568034;3585.0858031202397;3595.2449985503335;3596.011096948308;3599.1002249437643;612.3784358875745;628.4783629587431;639.8400399900025;648.614074625597;650.6161364794793;476.4282860567333;530.5357811914574;622.449132517725;637.8245982354797;640.5651340996135;8246.299064579458;9403.43579385239;9629.181519570915;9651.69702090223;9672.70981870545;558.2268558047134;586.3140126052529;602.2050892821521;602.5812060617916;641.3874749614107;4656.3713898623255;4705.741184234831;4707.388039554904;4746.240601503743;4747;95567;153219;161900;162068;162579;76616;78836;92696.53651731698;114155;134634.3268283672;103663.96336036694;105115;106324;107120.39319410214;108392.91607083986;8079.959600201962;8402.621882015203;8472.91527084746;9728.124468797841;10018.499075046364;46088.53911460977;46454.07091858212;52724.73637631941;54180;58640.70679646575;78192;89532.10467895499;89937.10062899288;91451;92619;10949.288296260718;11382;11432.657020289405;11478.483468243781;11482.712932176762;12164;12356.814647780111;12369.196002259825;12406.503739850667;12737.872621274038;11829.17195796286;11951.402429878297;12010.519579216734;12347.938260308641;12378.876211237772;11794.882051179378;12041.939790300992;12115.575954841539;12359.69100772488;12442.191257568229;11847.76304473923;11913.463894124612;12060.457279422271;12276.017918566671;12334;9805;9892.208623310262;9957;10043.69868903934;10082.798344033225;9845.163161131384;9985.950070249603;10056.899431005597;10107.595696172071;10150.340227885164 09:30:46 INFO - PROCESS | 1653 | __end_tp_report 09:30:46 INFO - PROCESS | 1653 | __start_cc_report 09:30:46 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,388 09:30:46 INFO - PROCESS | 1653 | __end_cc_report 09:30:46 INFO - PROCESS | 1653 | __startTimestamp1472574646480__endTimestamp 09:30:46 INFO - PROCESS | 1653 | 09:30:46 INFO - PROCESS | 1653 | ------- Summary: start ------- 09:30:46 INFO - PROCESS | 1653 | Number of tests: 6 09:30:46 INFO - PROCESS | 1653 | 09:30:46 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5706.83 Median:5978.70 stddev:695.85 (11.6%) stddev-sans-first:666.61 09:30:46 INFO - PROCESS | 1653 | Values: 3073.3 3359.0 3389.4 3410.2 3466.8 5614.1 5693.4 5720.1 5733.7 5803.3 5712.8 5715.3 5729.1 5792.7 5863.2 5150.6 5196.4 5214.0 5287.4 5297.0 5321.2 5344.0 5352.5 5367.1 5377.3 5159.5 5220.7 5237.1 5249.5 5261.7 4291.6 4320.3 4565.8 5251.3 5309.3 3803.0 4353.1 4965.2 5178.2 5235.3 4645.7 5582.0 5679.3 5763.6 5765.5 6091.2 6149.8 6209.3 6223.3 6228.8 6243.8 6290.3 6292.0 6294.2 6317.9 5785.5 5818.8 5852.7 5865.9 5893.9 6203.7 6205.8 6241.5 6271.7 6325.6 6046.5 6175.0 6180.6 6188.6 6191.6 6097.8 6161.5 6224.9 6252.2 6261.6 6147.0 6229.9 6236.3 6236.6 6276.5 6233.9 6248.7 6288.1 6300.1 6322.2 4852.4 4906.7 4909.8 4934.5 4996.0 4430.6 4433.2 4435.8 4445.1 4487.0 5453.8 5757.7 5843.2 5869.4 5870.1 4728.4 5127.3 5158.6 6188.0 6198.1 5877.7 5889.3 5904.6 5921.5 5973.6 5432.8 5465.9 5475.4 5482.2 5496.3 6165.4 6225.6 6242.9 6322.7 6324.4 6231.7 6245.8 6273.4 6285.4 6288.3 6245.8 6264.7 6275.9 6300.1 6321.2 5024.0 6125.6 6143.5 6239.7 6288.5 6250.8 6260.3 6274.8 6289.7 6312.4 6029.9 6143.0 6172.5 6173.1 6188.7 5997.4 6057.3 6127.3 6135.3 6173.9 5435.9 5805.2 6013.1 6063.1 6088.4 6151.9 6163.1 6187.3 6196.2 6206.8 5856.8 5978.7 6047.0 6063.8 6076.5 09:30:46 INFO - PROCESS | 1653 | 09:30:46 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:70654.34 Median:39855.80 stddev:159800.49 (400.9%) stddev-sans-first:160161.82 09:30:46 INFO - PROCESS | 1653 | Values: 444.6 480.9 506.2 523.0 630.2 38372.4 40933.4 40983.6 41035.8 41149.4 41369.6 41917.0 41965.4 41977.0 42026.4 9696.4 9885.0 9906.3 9913.8 9929.2 9769.2 9851.0 9857.9 9858.1 9865.1 9793.5 9859.9 9891.5 9896.3 9907.2 9854.9 9867.7 9868.7 9883.0 9895.2 9754.5 9803.4 9819.9 9835.9 9852.5 35173.6 35288.6 35828.6 40128.8 40274.0 2971.7 3150.9 3286.9 3518.9 3627.9 22815.3 22932.9 23360.6 27328.6 28133.6 2665.9 3239.0 3288.9 3402.5 3403.8 442689.0 446570.0 447917.0 453391.0 453936.7 32921.2 33739.7 61483.4 61757.7 61861.0 34525.3 34725.5 34845.3 34966.3 34999.7 14734.3 14905.9 14915.9 14922.5 14935.6 12193.0 12522.0 12539.8 12618.4 12620.6 7606.2 7623.4 7688.2 7691.7 7701.4 3106.9 3147.4 3150.9 3174.3 3179.3 916.5 997.9 1019.0 1043.3 1126.1 30350.0 30741.5 31060.0 31295.7 31299.0 947.6 1009.3 1009.9 1029.9 1054.5 12424.4 15172.4 15376.4 15743.0 15762.4 664751.0 677831.0 680813.0 681483.0 685245.0 56650.9 56686.0 56882.0 57150.7 57491.1 1281.0 1312.4 1314.1 1317.1 1322.2 29399.3 29574.7 29688.6 30120.0 30130.8 49144.3 54964.5 55272.2 56711.0 59714.4 629006.0 634925.0 635085.8 635398.0 641668.0 42673.6 42737.8 42874.4 43024.6 43340.1 38825.6 47156.8 47649.3 47670.5 48149.8 38555.8 39431.8 39477.0 39582.8 41187.2 37224.8 39346.8 39477.8 40337.8 40604.4 37799.0 38144.4 38309.2 39133.0 39376.6 30914.7 35050.8 35213.0 35646.5 37546.6 23070.3 23167.0 25394.4 26057.5 26159.6 09:30:46 INFO - PROCESS | 1653 | 09:30:46 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:35492.02 Median:14169.23 stddev:98776.87 (697.1%) stddev-sans-first:99018.70 09:30:46 INFO - PROCESS | 1653 | Values: 341.3 371.1 379.4 383.5 402.4 16720.1 19733.7 20752.8 21476.5 21733.0 20457.8 20728.0 21183.7 21259.8 21427.5 5277.4 5864.9 6051.0 6104.6 6123.6 6016.6 6052.2 6059.6 6073.6 6095.9 5835.0 5886.7 6018.8 6024.9 6032.3 5925.4 5951.5 5995.4 6019.1 6025.3 4988.5 5186.8 5193.4 5195.0 5203.8 25792.0 25829.2 25915.0 25972.5 26055.5 1643.9 2260.0 2300.1 2505.0 2546.5 10195.0 10490.1 12342.0 15053.2 15363.0 1781.4 1842.2 1845.3 1878.5 1900.7 125799.0 130292.3 130888.0 131913.0 132322.0 10721.5 11325.4 11453.5 11467.3 11572.8 14356.0 14386.7 14497.5 14509.2 14522.3 7768.8 7974.8 8443.8 8530.6 8576.4 8445.6 8522.5 8526.4 8693.2 8703.5 4477.4 4480.7 4484.7 4490.0 4518.4 1757.0 1772.7 1872.5 1913.4 1925.4 695.5 894.5 911.2 942.5 975.2 15001.0 16505.9 19398.6 20201.4 20370.9 887.4 913.0 957.6 986.2 1016.3 10721.7 11147.1 11168.7 11273.5 11292.8 550615.0 574713.0 595900.0 606033.0 610818.0 113945.4 131240.3 136193.0 136252.0 142852.3 922.7 934.8 971.4 971.5 1000.8 19272.5 19340.5 19466.0 19635.5 19672.8 55185.4 56231.0 56350.9 57694.4 58728.8 83977.2 84187.0 84540.0 84622.6 84764.6 7925.8 7985.9 8025.6 8172.9 8206.9 10138.5 12635.7 12788.0 12943.9 13202.9 10775.7 10850.6 11113.6 11206.7 11319.8 10126.2 10849.8 10949.5 11133.8 11259.3 10896.6 11256.5 11351.5 11375.5 11447.6 7907.1 7927.9 8267.0 8293.0 8335.2 9915.8 11003.9 11184.0 11205.3 11324.8 09:30:46 INFO - PROCESS | 1653 | 09:30:46 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5763.17 Median:4596.46 stddev:3277.72 (71.3%) stddev-sans-first:3270.31 09:30:46 INFO - PROCESS | 1653 | Values: 1372.2 1469.9 1657.4 1758.5 1840.1 8035.4 8478.3 8697.3 9087.7 9112.7 8686.0 8936.3 8936.8 8937.0 8948.6 2368.3 2387.3 2394.1 2396.2 2398.9 2356.0 2375.7 2397.5 2404.2 2419.7 2361.4 2367.6 2370.7 2386.2 2395.4 1978.5 2335.3 2362.7 2372.2 2374.3 2333.9 2354.6 2363.1 2368.4 2368.5 8977.9 9053.4 9054.9 9063.7 9085.5 5235.3 5433.8 5434.5 5436.1 5455.9 3578.2 3605.4 3608.1 3672.7 3676.2 1069.8 1070.1 1073.7 1075.5 1088.8 11580.2 11639.9 11671.9 11736.2 11766.6 4598.7 4692.4 4839.8 4850.5 4892.5 10074.2 10162.5 10163.5 10200.8 10219.5 5367.2 5369.6 5388.4 5393.9 5433.8 3490.7 3811.8 4085.8 4907.4 4918.2 3847.1 3882.8 3970.5 3982.4 4027.2 1118.4 1123.7 1299.2 1314.0 1314.5 647.9 929.3 937.0 938.0 941.5 5608.8 5841.0 5854.2 6085.1 6178.2 437.4 439.0 454.1 460.9 461.0 3937.5 4065.5 4181.6 4190.0 4215.7 10366.2 10839.2 10848.9 10870.9 10873.7 10798.2 10824.7 10860.7 10883.0 10901.9 7846.4 8215.6 8272.5 8289.7 8320.9 5494.5 6077.8 6083.8 6207.6 6343.3 10040.7 10240.8 10279.1 10320.3 10330.9 9270.9 9706.7 10069.5 10396.6 10402.3 7029.2 7545.8 7569.3 7723.0 7730.9 8575.0 8579.5 8650.8 8661.7 8674.8 7561.5 7712.7 7720.8 7785.0 7805.7 7431.4 7532.7 7535.1 7578.6 7736.5 7045.9 7073.3 7169.2 7173.4 7209.9 4986.6 4993.5 5088.6 5115.8 5264.8 4468.1 4594.2 4763.3 5151.6 5221.7 09:30:46 INFO - PROCESS | 1653 | 09:30:46 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4706.04 Median:5360.26 stddev:1507.36 (28.1%) stddev-sans-first:1474.96 09:30:46 INFO - PROCESS | 1653 | Values: 305.8 310.7 311.9 312.9 315.3 4778.9 5620.5 5690.9 5691.4 5695.4 5528.2 5532.8 5573.4 5600.3 5682.6 3686.4 4013.9 4137.9 4158.0 4231.8 3384.5 4199.7 4199.7 4215.9 4254.1 3539.5 3919.3 3992.8 4013.5 4145.5 3552.8 3580.0 4167.7 4167.8 4208.4 3013.4 3533.0 3581.9 3586.4 3587.9 4499.9 4550.9 5124.5 5429.5 5478.8 4629.7 4638.0 4745.4 4754.6 4791.8 5779.8 5880.2 5896.5 5921.1 5987.9 3316.9 3397.2 3460.3 3500.8 3945.6 4979.9 5215.0 5345.0 6010.3 6031.3 3612.7 3926.5 3987.8 4017.2 4022.6 4071.3 4076.8 4092.1 4096.3 4134.9 3738.3 4037.6 4802.5 4813.5 4814.7 5408.9 5431.6 5497.6 5753.6 5983.5 1240.3 1362.3 1390.6 1391.9 1393.2 788.8 830.9 847.4 847.5 849.2 4795.8 5431.2 5628.8 5660.0 5665.3 4923.8 5623.9 5850.8 6146.5 6171.0 4814.4 5170.7 5401.6 5620.6 5622.9 2607.3 2899.6 2944.1 3171.3 3218.4 5368.5 5579.4 5870.7 6425.7 6428.0 5707.3 5806.6 5869.4 6271.2 6320.5 5390.3 6387.2 6409.5 6437.8 6440.3 5458.6 5739.1 6147.4 6150.5 6180.8 5352.0 6098.7 6152.2 6174.2 6203.4 5339.5 6033.9 6224.9 6322.5 6359.0 4013.9 4020.0 4059.5 4065.8 4074.1 6229.5 6265.5 6276.2 6277.7 6292.3 4695.9 4747.9 4764.6 4981.9 5792.8 5436.3 5953.7 5974.1 5975.8 6023.9 5174.6 5500.1 5853.3 5872.8 5945.0 4964.4 5214.4 5425.4 5871.5 5921.0 5161.7 5873.8 5882.8 5923.8 5967.4 09:30:46 INFO - PROCESS | 1653 | 09:30:46 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:23416.59 Median:3975.75 stddev:37676.71 (947.7%) stddev-sans-first:37743.86 09:30:46 INFO - PROCESS | 1653 | Values: 719.7 764.3 776.7 793.7 803.4 15622.2 15964.4 15990.0 15997.8 16015.6 14627.3 14768.0 14770.3 14788.4 14815.3 688.8 834.7 838.1 858.1 861.6 871.0 871.2 872.0 874.6 875.1 925.8 927.4 928.2 928.3 928.7 917.3 921.1 922.1 922.9 923.9 683.2 684.4 686.5 687.1 690.6 14723.9 14954.9 15007.7 15028.2 15045.8 14701.8 14738.0 14749.8 14788.7 14789.9 11779.2 12045.1 12096.2 12267.6 12519.2 3737.5 3745.3 3962.3 3966.8 3984.7 102490.0 116746.0 117210.0 118218.8 118657.4 10616.7 11196.0 11290.5 11568.8 11629.8 20242.3 22972.2 23002.5 23033.7 23049.9 6068.3 7961.0 8097.3 8211.8 8298.3 4401.0 4465.6 4530.2 4540.7 4617.6 3478.3 3585.1 3595.2 3596.0 3599.1 612.4 628.5 639.8 648.6 650.6 476.4 530.5 622.4 637.8 640.6 8246.3 9403.4 9629.2 9651.7 9672.7 558.2 586.3 602.2 602.6 641.4 4656.4 4705.7 4707.4 4746.2 4747.0 95567.0 153219.0 161900.0 162068.0 162579.0 76616.0 78836.0 92696.5 114155.0 134634.3 103664.0 105115.0 106324.0 107120.4 108392.9 8080.0 8402.6 8472.9 9728.1 10018.5 46088.5 46454.1 52724.7 54180.0 58640.7 78192.0 89532.1 89937.1 91451.0 92619.0 10949.3 11382.0 11432.7 11478.5 11482.7 12164.0 12356.8 12369.2 12406.5 12737.9 11829.2 11951.4 12010.5 12347.9 12378.9 11794.9 12041.9 12115.6 12359.7 12442.2 11847.8 11913.5 12060.5 12276.0 12334.0 9805.0 9892.2 9957.0 10043.7 10082.8 9845.2 9986.0 10056.9 10107.6 10150.3 09:30:46 INFO - PROCESS | 1653 | -------- Summary: end -------- 09:30:46 INFO - PROCESS | 1653 | 09:30:47 INFO - TEST-INFO | 1653: exit 0 09:30:47 INFO - TEST-OK | dromaeo_css | took 1114605ms 09:30:47 INFO - TEST-START | kraken 09:30:47 INFO - operating with platform_type : mac_ 09:30:47 INFO - Initialising browser for kraken test... 09:30:47 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmphxnQ0d/profile http://localhost:49266/getInfo.html) 09:30:49 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 09:30:49 INFO - PROCESS | 1664 | colorDepth:24 09:30:49 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 09:30:49 INFO - PROCESS | 1664 | __metrics 09:30:50 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 09:30:50 INFO - TEST-INFO | 1664: exit 0 09:30:50 INFO - Browser initialized. 09:30:50 INFO - Running cycle 1/1 for kraken test... 09:30:50 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/T/tmphxnQ0d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:31:02 INFO - PROCESS | 1666 | RSS: Main: 244011008 09:31:02 INFO - PROCESS | 1666 | 09:31:05 INFO - PROCESS | 1666 | 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) 09:31:06 INFO - PROCESS | 1666 | RSS: Main: 257052672 09:31:06 INFO - PROCESS | 1666 | 09:31:09 INFO - PROCESS | 1666 | 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) 09:31:09 INFO - PROCESS | 1666 | RSS: Main: 265699328 09:31:09 INFO - PROCESS | 1666 | 09:31:13 INFO - PROCESS | 1666 | 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) 09:31:13 INFO - PROCESS | 1666 | RSS: Main: 263348224 09:31:13 INFO - PROCESS | 1666 | 09:31:15 INFO - PROCESS | 1666 | 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) 09:31:16 INFO - PROCESS | 1666 | RSS: Main: 264617984 09:31:16 INFO - PROCESS | 1666 | 09:31:18 INFO - PROCESS | 1666 | 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) 09:31:19 INFO - PROCESS | 1666 | RSS: Main: 265011200 09:31:19 INFO - PROCESS | 1666 | 09:31:22 INFO - PROCESS | 1666 | 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) 09:31:22 INFO - PROCESS | 1666 | RSS: Main: 267124736 09:31:22 INFO - PROCESS | 1666 | 09:31:25 INFO - PROCESS | 1666 | 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) 09:31:26 INFO - PROCESS | 1666 | RSS: Main: 267313152 09:31:26 INFO - PROCESS | 1666 | 09:31:29 INFO - PROCESS | 1666 | 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) 09:31:30 INFO - PROCESS | 1666 | RSS: Main: 267399168 09:31:30 INFO - PROCESS | 1666 | 09:31:31 INFO - PROCESS | 1666 | 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) 09:31:32 INFO - PROCESS | 1666 | RSS: Main: 267427840 09:31:32 INFO - PROCESS | 1666 | 09:31:34 INFO - PROCESS | 1666 | 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) 09:31:35 INFO - PROCESS | 1666 | RSS: Main: 266674176 09:31:35 INFO - PROCESS | 1666 | 09:31:37 INFO - PROCESS | 1666 | 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) 09:31:38 INFO - PROCESS | 1666 | RSS: Main: 266760192 09:31:38 INFO - PROCESS | 1666 | 09:31:41 INFO - PROCESS | 1666 | 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) 09:31:41 INFO - PROCESS | 1666 | RSS: Main: 266985472 09:31:41 INFO - PROCESS | 1666 | 09:31:44 INFO - PROCESS | 1666 | 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) 09:31:45 INFO - PROCESS | 1666 | RSS: Main: 266899456 09:31:45 INFO - PROCESS | 1666 | 09:31:47 INFO - PROCESS | 1666 | 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) 09:31:47 INFO - PROCESS | 1666 | RSS: Main: 268738560 09:31:47 INFO - PROCESS | 1666 | 09:31:47 INFO - PROCESS | 1666 | __start_tp_report 09:31:47 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 09:31:47 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 09:31:47 INFO - PROCESS | 1666 | |i|pagename|runs| 09:31:47 INFO - PROCESS | 1666 | |0;ai-astar;109;123;153;114;115;116;118;114;116;134 09:31:47 INFO - PROCESS | 1666 | |1;audio-beat-detection;143;120;169;199;134;129;129;111;157;107 09:31:47 INFO - PROCESS | 1666 | |2;audio-dft;196;213;252;280;201;204;197;202;195;196 09:31:47 INFO - PROCESS | 1666 | |3;audio-fft;68;81;78;141;58;58;58;60;132;58 09:31:47 INFO - PROCESS | 1666 | |4;audio-oscillator;68;85;145;69;72;102;108;68;60;125 09:31:47 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;89;88;98;95;138;126;112;84;137;108 09:31:47 INFO - PROCESS | 1666 | |6;imaging-darkroom;96;127;152;131;95;96;96;135;150;96 09:31:47 INFO - PROCESS | 1666 | |7;imaging-desaturate;97;119;92;92;94;90;90;126;145;142 09:31:47 INFO - PROCESS | 1666 | |8;json-parse-financial;56;59;57;67;72;90;89;89;76;57 09:31:47 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;68;68;76;70;86;73;63;62;74;108 09:31:47 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;87;85;82;103;108;100;86;87;90;89 09:31:47 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;160;163;149;153;165;140;139;165;189;141 09:31:47 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;207;158;225;231;209;167;174;173;172;171 09:31:47 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;68;69;67;68;66;69;68;68;70;67 09:31:47 INFO - PROCESS | 1666 | __end_tp_report 09:31:47 INFO - PROCESS | 1666 | __start_cc_report 09:31:47 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,975 09:31:47 INFO - PROCESS | 1666 | __end_cc_report 09:31:47 INFO - PROCESS | 1666 | __startTimestamp1472574707315__endTimestamp 09:31:47 INFO - PROCESS | 1666 | 09:31:47 INFO - PROCESS | 1666 | ------- Summary: start ------- 09:31:47 INFO - PROCESS | 1666 | Number of tests: 14 09:31:47 INFO - PROCESS | 1666 | 09:31:47 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:121.20 Median:117.00 stddev:13.05 (11.2%) stddev-sans-first:13.08 09:31:47 INFO - PROCESS | 1666 | Values: 109.0 123.0 153.0 114.0 115.0 116.0 118.0 114.0 116.0 134.0 09:31:47 INFO - PROCESS | 1666 | 09:31:47 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:138.50 stddev:28.34 (20.5%) stddev-sans-first:30.03 09:31:47 INFO - PROCESS | 1666 | Values: 143.0 120.0 169.0 199.0 134.0 129.0 129.0 111.0 157.0 107.0 09:31:47 INFO - PROCESS | 1666 | 09:31:47 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:213.60 Median:203.00 stddev:28.89 (14.2%) stddev-sans-first:29.93 09:31:47 INFO - PROCESS | 1666 | Values: 196.0 213.0 252.0 280.0 201.0 204.0 197.0 202.0 195.0 196.0 09:31:47 INFO - PROCESS | 1666 | 09:31:47 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:79.20 Median:59.00 stddev:31.45 (53.3%) stddev-sans-first:33.10 09:31:47 INFO - PROCESS | 1666 | Values: 68.0 81.0 78.0 141.0 58.0 58.0 58.0 60.0 132.0 58.0 09:31:47 INFO - PROCESS | 1666 | 09:31:47 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:68.00 stddev:28.63 (42.1%) stddev-sans-first:29.21 09:31:47 INFO - PROCESS | 1666 | Values: 68.0 85.0 145.0 69.0 72.0 102.0 108.0 68.0 60.0 125.0 09:31:47 INFO - PROCESS | 1666 | 09:31:47 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:107.50 Median:86.00 stddev:20.23 (23.5%) stddev-sans-first:20.32 09:31:47 INFO - PROCESS | 1666 | Values: 89.0 88.0 98.0 95.0 138.0 126.0 112.0 84.0 137.0 108.0 09:31:47 INFO - PROCESS | 1666 | 09:31:47 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:117.40 Median:95.50 stddev:23.99 (25.1%) stddev-sans-first:24.16 09:31:47 INFO - PROCESS | 1666 | Values: 96.0 127.0 152.0 131.0 95.0 96.0 96.0 135.0 150.0 96.0 09:31:47 INFO - PROCESS | 1666 | 09:31:47 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:108.70 Median:91.00 stddev:22.22 (24.4%) stddev-sans-first:23.16 09:31:47 INFO - PROCESS | 1666 | Values: 97.0 119.0 92.0 92.0 94.0 90.0 90.0 126.0 145.0 142.0 09:31:47 INFO - PROCESS | 1666 | 09:31:47 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:71.20 Median:74.00 stddev:14.19 (19.2%) stddev-sans-first:13.94 09:31:47 INFO - PROCESS | 1666 | Values: 56.0 59.0 57.0 67.0 72.0 90.0 89.0 89.0 76.0 57.0 09:31:47 INFO - PROCESS | 1666 | 09:31:47 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:74.80 Median:71.50 stddev:13.55 (18.9%) stddev-sans-first:14.14 09:31:47 INFO - PROCESS | 1666 | Values: 68.0 68.0 76.0 70.0 86.0 73.0 63.0 62.0 74.0 108.0 09:31:47 INFO - PROCESS | 1666 | 09:31:47 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:86.50 stddev:8.74 (10.1%) stddev-sans-first:9.11 09:31:47 INFO - PROCESS | 1666 | Values: 87.0 85.0 82.0 103.0 108.0 100.0 86.0 87.0 90.0 89.0 09:31:47 INFO - PROCESS | 1666 | 09:31:47 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:156.40 Median:161.50 stddev:15.43 (9.6%) stddev-sans-first:16.31 09:31:47 INFO - PROCESS | 1666 | Values: 160.0 163.0 149.0 153.0 165.0 140.0 139.0 165.0 189.0 141.0 09:31:47 INFO - PROCESS | 1666 | 09:31:47 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.70 Median:190.50 stddev:26.50 (13.9%) stddev-sans-first:27.27 09:31:47 INFO - PROCESS | 1666 | Values: 207.0 158.0 225.0 231.0 209.0 167.0 174.0 173.0 172.0 171.0 09:31:47 INFO - PROCESS | 1666 | 09:31:47 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.15 (1.7%) stddev-sans-first:1.22 09:31:47 INFO - PROCESS | 1666 | Values: 68.0 69.0 67.0 68.0 66.0 69.0 68.0 68.0 70.0 67.0 09:31:47 INFO - PROCESS | 1666 | -------- Summary: end -------- 09:31:47 INFO - PROCESS | 1666 | 09:31:48 INFO - TEST-INFO | 1666: exit 0 09:31:48 INFO - TEST-OK | kraken | took 61021ms 09:31:48 INFO - SUITE-END | took 1175s 09:31:48 INFO - Completed test suite (00:19:35) 09:31:48 INFO - javascript benchmark 09:31:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7274.596323430807, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3073.2931425772085, 3359.0, 3389.4237979543477, 3410.249745056087, 3466.7919924804505, 5614.101743721006, 5693.373728889829, 5720.05619072853, 5733.713314334287, 5803.332616749075, 5712.828615141542, 5715.2855893013375, 5729.05470597352, 5792.71036448177, 5863.237779088712, 5150.562202212797, 5196.3764348278255, 5214.0, 5287.41838397776, 5297.046531624306, 5321.201819727034, 5344.011357898782, 5352.545033672142, 5367.06076436624, 5377.274068000828, 5159.484051594848, 5220.660657057279, 5237.083510385667, 5249.501297376743, 5261.684298942076, 4291.570842915715, 4320.330348795942, 4565.771711414416, 5251.317328747276, 5309.283246761715, 3803.0, 4353.129374125156, 4965.155923493015, 5178.197379406198, 5235.319408476912, 4645.651576131803, 5581.972090139523, 5679.261695979538, 5763.596548241625, 5765.538756899438, 6091.17419508421, 6149.831532008904, 6209.348018458042, 6223.346548612376, 6228.750849965996, 6243.843903902393, 6290.308066112724, 6292.024736165901, 6294.181756371642, 6317.87364252717, 5785.47930686236, 5818.7672493100645, 5852.707364631751, 5865.941340586625, 5893.911591326134, 6203.658798766111, 6205.751769929243, 6241.500679945593, 6271.749130034838, 6325.557210995278, 6046.516278697693, 6175.042868355412, 6180.598261113013, 6188.597741146811, 6191.628502289787, 6097.766665674581, 6161.507079433634, 6224.875502489925, 6252.187215661935, 6261.624302541862, 6147.047207682816, 6229.906551401733, 6236.251649801962, 6236.6258024518675, 6276.497880169575, 6233.875322493524, 6248.718807653667, 6288.056791481315, 6300.117983482316, 6322.209723784527, 4852.393450818648, 4906.656534042583, 4909.7790599423115, 4934.4572097069295, 4995.975020124876, 4430.623397011225, 4433.1577000369825, 4435.822567097344, 4445.133199026223, 4487.035287413222, 5453.836384908459, 5757.683327417032, 5843.18195452637, 5869.383714709979, 5870.119482077723, 4728.38530990969, 5127.282180494733, 5158.587313014949, 6187.969060154671, 6198.132261483306, 5877.706114694248, 5889.293284805851, 5904.5571582131515, 5921.496672782861, 5973.641581505123, 5432.782688692408, 5465.945340546544, 5475.425080366584, 5482.23248745176, 5496.31296087989, 6165.414285642857, 6225.564210505221, 6242.875142497034, 6322.652254125976, 6324.430801227912, 6231.688415579293, 6245.781397651061, 6273.404026617464, 6285.371462853678, 6288.276848162337, 6245.843853903689, 6264.718087685974, 6275.937240627535, 6300.086487459384, 6321.209848768904, 5024.0, 6125.571210015256, 6143.511877689543, 6239.719212635533, 6288.496920246461, 6250.781222657185, 6260.280067792262, 6274.843128921813, 6289.654069026247, 6312.368763123651, 6029.939700603113, 6142.969285153546, 6172.506199504119, 6173.104899789416, 6188.659623720739, 5997.400259973968, 6057.273127224761, 6127.295361033538, 6135.32453530862, 6173.907391389043, 5435.93999170158, 5805.245318108618, 6013.098035294566, 6063.060225665029, 6088.36072212429, 6151.907721384094, 6163.106349579376, 6187.288461826947, 6196.225471816023, 6206.813795585959, 5856.824295271149, 5978.701064946648, 6047.002244629763, 6063.787767428295, 6076.453119219292], "value": 5661.489116048616, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [444.57987202094034, 480.8966072294456, 506.2002036781884, 522.9633925625205, 630.2279707358483, 38372.42441363382, 40933.38599921, 40983.59016409835, 41035.79482102593, 41149.38275925864, 41369.58630413695, 41917.0, 41965.37051944216, 41977.0, 42026.36960445588, 9696.369735967157, 9885.0, 9906.257030722689, 9913.801723965516, 9929.205663546934, 9769.169620582259, 9851.0, 9857.90142098577, 9858.112769850712, 9865.062819032217, 9793.461359625218, 9859.90140098597, 9891.455969921652, 9896.257780666443, 9907.207423406111, 9854.852177217348, 9867.654632087842, 9868.703938881845, 9883.011698830096, 9895.208383329316, 9754.512274386252, 9803.411795292306, 9819.90180098197, 9835.852462213072, 9852.50737463124, 35173.648263517294, 35288.58845646171, 35828.641713582794, 40128.79935600333, 40273.99315017118, 2971.6731159572428, 3150.8582113804705, 3286.917827054319, 3518.9296214075575, 3627.9455808162897, 22815.31554053381, 22932.88533557338, 23360.64959025616, 27328.59007114895, 28133.57799633007, 2665.8800353983925, 3239.0444818778515, 3288.852001659931, 3402.5236466894653, 3403.846826892796, 442689.0, 446570.0, 447917.0, 453391.0, 453936.7303163496, 32921.17697057593, 33739.66260337414, 61483.38516614777, 61757.69121154455, 61861.0, 34525.30949380998, 34725.47911781325, 34845.30309393798, 34966.30067398638, 34999.65000349964, 14734.336954837057, 14905.850941490446, 14915.850841491663, 14922.477713279983, 14935.551933442013, 12193.024558035337, 12522.0, 12539.811902821464, 12618.432170552347, 12620.558280460324, 7606.163322034572, 7623.35201507867, 7688.231176882267, 7691.653960556992, 7701.422393320523, 3106.8601912913973, 3147.4177277203335, 3150.9054728358187, 3174.2857856981996, 3179.2846609513135, 916.5325683901125, 997.9451130187764, 1019.0268293779571, 1043.2957753516498, 1126.1474873832499, 30350.0, 30741.538876916864, 31060.0, 31295.687043129732, 31299.0, 947.5877993073035, 1009.3439264478149, 1009.9092979582034, 1029.9279050466546, 1054.4710170253163, 12424.399172369902, 15172.393104275927, 15376.384944602314, 15742.97670651427, 15762.369505219893, 664751.0, 677831.0, 680813.0, 681483.0, 685245.0, 56650.86698266012, 56686.0, 56882.0, 57150.714246429336, 57491.13763293554, 1281.0, 1312.4159748911834, 1314.0867097367238, 1317.117531254043, 1322.233104799214, 29399.26501837471, 29574.704252957195, 29688.55467167951, 30120.0, 30130.84934575313, 49144.262836056776, 54964.45035549753, 55272.17091743547, 56711.0, 59714.40285597088, 629006.0, 634925.0, 635085.8245708742, 635398.0, 641668.0, 42673.57326426696, 42737.786311068245, 42874.356884646135, 43024.56975430206, 43340.13319733524, 38825.6117438822, 47156.7642161787, 47649.28526072181, 47670.523294768, 48149.75925120352, 38555.80722096372, 39431.80284098561, 39477.01307467336, 39582.80208599054, 41187.1762564741, 37224.81387593045, 39346.80326598463, 39477.81566553008, 40337.79831100826, 40604.3909341366, 37799.0, 38144.42783358196, 38309.24884215574, 39133.0, 39376.606233937295, 30914.690853091182, 35050.82474587611, 35213.0, 35646.465303019955, 37546.624533754315, 23070.307890763303, 23167.02432045785, 25394.365140871625, 26057.478850423264, 26159.607605886307], "value": 18794.065770054003, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.31225580455384, 371.0667670807917, 379.4327480416777, 383.52251446948554, 402.4225236785213, 16720.08039557824, 19733.70399444008, 20752.792472075274, 21476.463088422777, 21733.0, 20457.795422045812, 20727.963601819923, 21183.682244766303, 21259.787402125974, 21427.464313392175, 5277.445868183843, 5864.912026319608, 6050.969745151268, 6104.572679912408, 6123.601965872204, 6016.578839481238, 6052.152698622196, 6059.575829691923, 6073.574849760518, 6095.878082438348, 5835.0241376897875, 5886.676232807194, 6018.7893423730175, 6024.879502409949, 6032.276126864783, 5925.407459254083, 5951.523878089764, 5995.370486098984, 6019.127226552169, 6025.307089684698, 4988.5260900214425, 5186.766595503173, 5193.428722840485, 5195.012947539955, 5203.7918483261, 25792.0, 25829.22512324633, 25915.0, 25972.480550389075, 26055.478890422084, 1643.926023328953, 2260.028187879211, 2300.1029598456616, 2504.9749502504924, 2546.4652422991194, 10195.0, 10490.055894969413, 12342.01263898886, 15053.153085866572, 15363.0, 1781.4388467632655, 1842.1986435900292, 1845.308009496439, 1878.4834170603194, 1900.7338972543855, 125799.0, 130292.34853825765, 130888.0, 131913.0, 132322.0, 10721.463926803628, 11325.37710425918, 11453.484593193327, 11467.254628449124, 11572.826407603892, 14355.995080344484, 14386.712265754835, 14497.492587759378, 14509.201993890438, 14522.346494407777, 7768.805779855549, 7974.843647671171, 8443.831123377498, 8530.616122274512, 8576.356773242032, 8445.57772111392, 8522.5284667447, 8526.445781024213, 8693.217610415093, 8703.47779133254, 4477.350784136282, 4480.663950203748, 4484.708493947883, 4490.012197316585, 4518.43519560055, 1756.9560760981078, 1772.7075032619732, 1872.4944265048632, 1913.4068438784022, 1925.431997560695, 695.4957655699577, 894.4633220067907, 911.2163539356148, 942.4910548303976, 975.2490582251627, 15001.024933379296, 16505.917470412813, 19398.61202775965, 20201.393958181277, 20370.898145509178, 887.3573978816993, 912.9863052054225, 957.5978089202413, 986.2356673578034, 1016.2530540053056, 10721.678349649523, 11147.052500537384, 11168.720781980515, 11273.549058037586, 11292.830607540729, 550615.0, 574713.0, 595900.0, 606033.0, 610818.0, 113945.4302728481, 131240.3437982823, 136193.0, 136252.0, 142852.28573857064, 922.7462447826902, 934.7990182110879, 971.4414211828228, 971.5482300730195, 1000.7598176437602, 19272.518187045436, 19340.516487087934, 19466.0, 19635.509112272306, 19672.803271967095, 55185.44814551803, 56231.0, 56350.8729825393, 57694.42305576891, 58728.82542349215, 83977.16022839694, 84187.0, 84540.0, 84622.57688711517, 84764.57617711872, 7925.841483170419, 7985.880211796712, 8025.638846251816, 8172.918270817216, 8206.876896846672, 10138.543765530716, 12635.74728505443, 12788.0, 12943.935280323538, 13202.867971320164, 10775.676729698122, 10850.620228291971, 11113.555457781598, 11206.719832004264, 11319.773604527698, 10126.24053196028, 10849.783004340026, 10949.50727217293, 11133.777324453627, 11259.268147570381, 10896.564137434414, 11256.549738010388, 11351.489182986621, 11375.54497820078, 11447.599334023269, 7907.090684571348, 7927.920720792718, 8267.049289331804, 8292.958535207526, 8335.166483351617, 9915.752106197402, 11003.889961100607, 11184.0, 11205.271657342246, 11324.773504529698], "value": 9628.442309120015, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1372.2109786872547, 1469.9044562103459, 1657.4116188752992, 1758.5076178669976, 1840.0891558678447, 8035.357171426272, 8478.321734261259, 8697.2607328377, 9087.727368178957, 9112.726618201448, 8685.95657021714, 8936.285097192225, 8936.776580585489, 8936.955315223415, 8948.552572371387, 2368.348704106367, 2387.259949415678, 2394.1022116706235, 2396.18529699902, 2398.9324750485953, 2355.9882200588972, 2375.679283296759, 2397.5324811661735, 2404.230646193219, 2419.6854408926815, 2361.374235827507, 2367.633016882386, 2370.691810064689, 2386.176769014687, 2395.425097976482, 1978.485593745622, 2335.346103091137, 2362.7282862470865, 2372.2171683344627, 2374.347054560001, 2333.9380581835394, 2354.6114891042957, 2363.066588697472, 2368.396059004943, 2368.526294741059, 8977.910220897838, 9053.411528250643, 9054.909450905472, 9063.68277110298, 9085.500297483635, 5235.319408476874, 5433.8369848904595, 5434.456554344573, 5436.103042997901, 5455.863603409907, 3578.2306804037, 3605.4231322988194, 3608.0979755061235, 3672.706183505313, 3676.191237927652, 1069.7913906788178, 1070.1064611049783, 1073.683263437288, 1075.4891426572394, 1088.8149014667447, 11580.247283926517, 11639.941800290944, 11671.883281167164, 11736.178467507278, 11766.647000589996, 4598.724076555417, 4692.366530518405, 4839.830605928775, 4850.53919877611, 4892.510748925079, 10074.194064474825, 10162.542685579167, 10163.542640581043, 10200.846987295197, 10219.540120694586, 5367.221752845816, 5369.570434365241, 5388.407275199725, 5393.865153371197, 5433.8369848904595, 3490.7032902203596, 3811.809409529568, 4085.775282359439, 4907.3620429343955, 4918.163912134945, 3847.134394761212, 3882.8058597070035, 3970.4838371011583, 3982.38273067675, 4027.194561087794, 1118.4016551145098, 1123.6516679829278, 1299.2139755447818, 1313.960581182566, 1314.4545013819159, 647.9092926990226, 929.2983797233046, 936.9906300936904, 937.95310234488, 941.5010044676333, 5608.822147349021, 5840.970795145997, 5854.151148083504, 6085.117657939662, 6178.165947597017, 437.4204179462225, 439.03193458424096, 454.096348266953, 460.9331646911179, 460.9976950115228, 3937.523428714232, 4065.4714887064492, 4181.581841815794, 4190.0, 4215.662746980234, 10366.222533310032, 10839.187060970458, 10848.891511084947, 10870.891291087146, 10873.728156796144, 10798.190135739695, 10824.67525974222, 10860.72848178786, 10882.966118218757, 10901.890981090088, 7846.372290216769, 8215.58922053895, 8272.503649780912, 8289.668413263402, 8320.916790832136, 5494.5054945055135, 6077.848053798691, 6083.787067452795, 6207.596506227081, 6343.3022367538615, 10040.748981275527, 10240.846387304047, 10279.126274266471, 10320.277580569287, 10330.896691032993, 9270.907290927003, 9706.70879873605, 10069.546870390997, 10396.58413663445, 10402.27184097106, 7029.226785053538, 7545.849083018418, 7569.318761311288, 7722.996010518596, 7730.922690773245, 8575.0, 8579.485230886166, 8650.826983460422, 8661.740147795575, 8674.783130421538, 7561.470697051153, 7712.652930618248, 7720.7683769487, 7784.9610751945875, 7805.687772489036, 7431.36833369148, 7532.736354227576, 7535.095788505414, 7578.621068946421, 7736.535807851547, 7045.929540704732, 7073.328033836778, 7169.211386747558, 7173.426125910019, 7209.891851622335, 4986.626003049713, 4993.450720420823, 5088.626070960894, 5115.769790359368, 5264.815731449381, 4468.061707041427, 4594.196015697173, 4763.309320148628, 5151.587872970078, 5221.660592061504], "value": 4530.2585115328575, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.8119256657156, 310.6753442652428, 311.91890108571766, 312.8654678488252, 315.2843046284933, 4778.856634300968, 5620.522255608273, 5690.926899474279, 5691.3739488656265, 5695.43375571718, 5528.153001204383, 5532.75923251083, 5573.442655734435, 5600.327960644719, 5682.602217844753, 3686.4286035664513, 4013.8761146878774, 4137.8965525861795, 4157.979210103946, 4231.788410579474, 3384.458486642138, 4199.664026877857, 4199.669183603099, 4215.915681686364, 4254.064105896698, 3539.50446937429, 3919.255341485123, 3992.7604343739467, 4013.4514583239707, 4145.523264824538, 3552.769070010441, 3580.03339098442, 4167.708260421741, 4167.770507700206, 4208.410822484854, 3013.442513135077, 3533.028417185269, 3581.94627080594, 3586.39031364666, 3587.94155724062, 4499.932501012488, 4550.931736023962, 5124.4875512448825, 5429.53848922842, 5478.780848766045, 4629.699069560502, 4638.0, 4745.383100196952, 4754.619630429557, 4791.802049487628, 5779.780760045149, 5880.235569375954, 5896.469317761422, 5921.111833225051, 5987.880242395127, 3316.9054212110186, 3397.1507123219194, 3460.3425349183576, 3500.8469791078305, 3945.6251656092627, 4979.875503112451, 5215.0, 5345.0, 6010.278766547998, 6031.276246850406, 3612.710983121344, 3926.54844692864, 3987.803658902376, 4017.1563971565715, 4022.557518672944, 4071.2875246831686, 4076.8165432555606, 4092.1201941582704, 4096.283150448659, 4134.855280065183, 3738.3084129436143, 4037.6366127048705, 4802.519748025239, 4813.462105352563, 4814.662973591885, 5408.91886621701, 5431.565474762088, 5497.6255936016, 5753.568482363839, 5983.491403230687, 1240.2930329712158, 1362.264377236301, 1390.6453854267097, 1391.8747312741903, 1393.191948669769, 788.7909703928464, 830.8919840420707, 847.3687103108224, 847.4999750147442, 849.1720572441819, 4795.760211989386, 5431.2396264522995, 5628.831135065954, 5660.0, 5665.348484924204, 4923.75381230937, 5623.943760562423, 5850.824475265749, 6146.5390095743, 6170.969145154335, 4814.398200224972, 5170.741462926914, 5401.6218864679095, 5620.63465874725, 5622.943770562324, 2607.331307962905, 2899.6230490036583, 2944.131481213047, 3171.349873275973, 3218.3885061838178, 5368.5436737876935, 5579.442055794388, 5870.73581688825, 6425.74297028123, 6427.967860160669, 5707.286589176353, 5806.622569532967, 5869.442402971711, 6271.216097987752, 6320.525960552977, 5390.299261096033, 6387.169667943138, 6409.455196308273, 6437.839054023687, 6440.32376600469, 5458.590605704668, 5739.139129130497, 6147.44672979434, 6150.538709596887, 6180.7527698891545, 5351.973240133774, 6098.695065246809, 6152.230971128609, 6174.228221472316, 6203.410675985774, 5339.4660533947845, 6033.939660603338, 6224.875502489835, 6322.475004341751, 6359.04614307839, 4013.8795836124964, 4019.954811748908, 4059.5331536873637, 4065.84123524794, 4074.083331250445, 6229.470495007975, 6265.530085243534, 6276.21127978524, 6277.654728989949, 6292.339304373158, 4695.929561056519, 4747.881302967454, 4764.618830493483, 4981.875453113701, 5792.783515461801, 5436.3476382834315, 5953.690188158598, 5974.058431010026, 5975.760969561169, 6023.909641355295, 5174.560162386088, 5500.129955815042, 5853.2976042875125, 5872.794452194153, 5945.0, 4964.404271487445, 5214.400343960341, 5425.376081750649, 5871.4715675589405, 5921.009890005692, 5161.66449180802, 5873.765049398147, 5882.794102206402, 5923.822285331447, 5967.373425790403], "value": 4218.730911097882, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.74089327842, 764.2853931573978, 776.7436745873862, 793.7102957420543, 803.4014659078987, 15622.218889055559, 15964.361425542993, 15989.960652557591, 15997.84002159978, 16015.599610009756, 14627.341769620367, 14768.04007739499, 14770.261486925638, 14788.408463661468, 14815.33331000105, 688.7933619914031, 834.7203686764926, 838.1492784823379, 858.1461445861377, 861.5649097205934, 871.024452613071, 871.1897934920521, 872.014623475475, 874.5845723281423, 875.1336177184605, 925.8194652042854, 927.420362273579, 928.1507420710042, 928.2666693312275, 928.7213835849218, 917.2936838634281, 921.1203300847708, 922.0917396364575, 922.903095175007, 923.8568021956642, 683.2006552333781, 684.3806355248508, 686.502285842765, 687.089606271687, 690.5580428525748, 14723.926380368137, 14954.850451495455, 15007.699846003128, 15028.173450460221, 15045.849541504555, 14701.779473307908, 14738.0, 14749.77875331871, 14788.70422591553, 14789.852101478955, 11779.175457717964, 12045.096617753616, 12096.153269271155, 12267.631971040882, 12519.248845069325, 3737.4580685800406, 3745.2696724138805, 3962.32640451124, 3966.7818269995137, 3984.721069525134, 102490.0, 116746.0, 117210.0, 118218.81781182165, 118657.40671296588, 10616.710348661754, 11196.0, 11290.490780789818, 11568.768624627628, 11629.767404651859, 20242.291519796738, 22972.19597314086, 23002.53994920126, 23033.654495182585, 23049.88475057614, 6068.302145253352, 7961.0, 8097.271245587807, 8211.83576328482, 8298.294644955246, 4400.955990440055, 4465.642748580106, 4530.184566778012, 4540.72755634663, 4617.561331673553, 3478.339115568034, 3585.0858031202397, 3595.2449985503335, 3596.011096948308, 3599.1002249437643, 612.3784358875745, 628.4783629587431, 639.8400399900025, 648.614074625597, 650.6161364794793, 476.4282860567333, 530.5357811914574, 622.449132517725, 637.8245982354797, 640.5651340996135, 8246.299064579458, 9403.43579385239, 9629.181519570915, 9651.69702090223, 9672.70981870545, 558.2268558047134, 586.3140126052529, 602.2050892821521, 602.5812060617916, 641.3874749614107, 4656.3713898623255, 4705.741184234831, 4707.388039554904, 4746.240601503743, 4747.0, 95567.0, 153219.0, 161900.0, 162068.0, 162579.0, 76616.0, 78836.0, 92696.53651731698, 114155.0, 134634.3268283672, 103663.96336036694, 105115.0, 106324.0, 107120.39319410214, 108392.91607083986, 8079.959600201962, 8402.621882015203, 8472.91527084746, 9728.124468797841, 10018.499075046364, 46088.53911460977, 46454.07091858212, 52724.73637631941, 54180.0, 58640.70679646575, 78192.0, 89532.10467895499, 89937.10062899288, 91451.0, 92619.0, 10949.288296260718, 11382.0, 11432.657020289405, 11478.483468243781, 11482.712932176762, 12164.0, 12356.814647780111, 12369.196002259825, 12406.503739850667, 12737.872621274038, 11829.17195796286, 11951.402429878297, 12010.519579216734, 12347.938260308641, 12378.876211237772, 11794.882051179378, 12041.939790300992, 12115.575954841539, 12359.69100772488, 12442.191257568229, 11847.76304473923, 11913.463894124612, 12060.457279422271, 12276.017918566671, 12334.0, 9805.0, 9892.208623310262, 9957.0, 10043.69868903934, 10082.798344033225, 9845.163161131384, 9985.950070249603, 10056.899431005597, 10107.595696172071, 10150.340227885164], "value": 7568.298048496353, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1628.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 123.0, 153.0, 114.0, 115.0, 116.0, 118.0, 114.0, 116.0, 134.0], "value": 121.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 120.0, 169.0, 199.0, 134.0, 129.0, 129.0, 111.0, 157.0, 107.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 213.0, 252.0, 280.0, 201.0, 204.0, 197.0, 202.0, 195.0, 196.0], "value": 213.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 81.0, 78.0, 141.0, 58.0, 58.0, 58.0, 60.0, 132.0, 58.0], "value": 79.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 85.0, 145.0, 69.0, 72.0, 102.0, 108.0, 68.0, 60.0, 125.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 98.0, 95.0, 138.0, 126.0, 112.0, 84.0, 137.0, 108.0], "value": 107.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 127.0, 152.0, 131.0, 95.0, 96.0, 96.0, 135.0, 150.0, 96.0], "value": 117.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 119.0, 92.0, 92.0, 94.0, 90.0, 90.0, 126.0, 145.0, 142.0], "value": 108.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 59.0, 57.0, 67.0, 72.0, 90.0, 89.0, 89.0, 76.0, 57.0], "value": 71.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 76.0, 70.0, 86.0, 73.0, 63.0, 62.0, 74.0, 108.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 82.0, 103.0, 108.0, 100.0, 86.0, 87.0, 90.0, 89.0], "value": 91.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 149.0, 153.0, 165.0, 140.0, 139.0, 165.0, 189.0, 141.0], "value": 156.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [207.0, 158.0, 225.0, 231.0, 209.0, 167.0, 174.0, 173.0, 172.0, 171.0], "value": 188.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 67.0, 68.0, 66.0, 69.0, 68.0, 68.0, 70.0, 67.0], "value": 68.0, "unit": "score"}]}]} 09:31:48 INFO - Return code: 0 09:31:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:31:48 ERROR - # TBPL SUCCESS # 09:31:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:31:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:31:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:31:48 INFO - 2016-08-30 09:31:48.671 screenresolution[1671:11182] starting screenresolution argv=screenresolution get 09:31:48 INFO - 2016-08-30 09:31:48.674 screenresolution[1671:11182] Display 0: 1600x1200x32@60 09:31:48 INFO - 2016-08-30 09:31:48.680 screenresolution[1672:11185] starting screenresolution argv=screenresolution list 09:31:48 INFO - Available Modes on Display 0 09:31:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:31:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:31:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:31:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:31:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:31:48 INFO - Intel Iris: 09:31:48 INFO - Chipset Model: Intel Iris 09:31:48 INFO - Type: GPU 09:31:48 INFO - Bus: Built-In 09:31:48 INFO - VRAM (Dynamic, Max): 1536 MB 09:31:48 INFO - Vendor: Intel (0x8086) 09:31:48 INFO - Device ID: 0x0a2e 09:31:48 INFO - Revision ID: 0x0009 09:31:48 INFO - Displays: 09:31:48 INFO - Display: 09:31:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:31:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:31:48 INFO - Display Serial Number: 1600x1200 60 09:31:48 INFO - Main Display: Yes 09:31:48 INFO - Mirror: Off 09:31:48 INFO - Online: Yes 09:31:48 INFO - Rotation: Supported 09:31:48 INFO - Return code: 0 09:31:48 INFO - Running post-action listener: _resource_record_post_action 09:31:48 INFO - [mozharness: 2016-08-30 16:31:48.918272Z] Finished run-tests step (success) 09:31:48 INFO - Running post-run listener: _resource_record_post_run 09:31:48 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 33168384; Write bytes: 710245376; Read time: 318; Write time: 1963 09:31:48 INFO - TinderboxPrint: CPU usage
54.4% 09:31:48 INFO - TinderboxPrint: I/O read bytes / time
33,168,384 / 318 09:31:48 INFO - TinderboxPrint: I/O write bytes / time
710,245,376 / 1,963 09:31:48 INFO - TinderboxPrint: CPU idle
2,211.9 (45.6%) 09:31:48 INFO - TinderboxPrint: CPU system
976.5 (20.2%) 09:31:48 INFO - TinderboxPrint: CPU user
1,657.3 (34.2%) 09:31:48 INFO - TinderboxPrint: Swap in / out
435,433,472 / 0 09:31:48 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 396624384; Write bytes: 391534080; Read time: 29306; Write time: 709 09:31:48 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 31190016; Write bytes: 299992576; Read time: 297; Write time: 1213 09:31:49 INFO - Running post-run listener: _upload_blobber_files 09:31:49 INFO - Blob upload gear active. 09:31:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:31:49 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 09:31:49 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'] 09:31:49 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 09:31:49 INFO - (blobuploader) - INFO - Open directory for files ... 09:31:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:31:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:31:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:50 INFO - (blobuploader) - INFO - Done attempting. 09:31:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:31:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:31:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:51 INFO - (blobuploader) - INFO - Done attempting. 09:31:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:31:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:31:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:57 INFO - (blobuploader) - INFO - Done attempting. 09:31:57 INFO - (blobuploader) - INFO - Iteration through files over. 09:31:57 INFO - Return code: 0 09:31:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:31:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:31:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2892744b256a6f597cf8134411b17dda83cc37b16084e5588d271f568d0de0e5f01af00e19d6d51f48b44e07e878f9143c0ee080fbd13682c96fb0a40cc5014", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b290d52e6e13a20cdb9f40cee041aa9b49ee51c12b89382ca6415dcce2cd7d0e3d6fc4160bc4c9fa35406675ac2b4d44f4e7afb20ab70627e7a01c8902d93cc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/955476af7231270ad25f56ab5661785988a6983f102447f5b27409dfacfd9e7a005bb51dab8f3e9fe88ebad11b2321fd47c6b49f01944d02aa238283fe454d88"} 09:31:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:31:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:31:57 INFO - Contents: 09:31:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2892744b256a6f597cf8134411b17dda83cc37b16084e5588d271f568d0de0e5f01af00e19d6d51f48b44e07e878f9143c0ee080fbd13682c96fb0a40cc5014", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b290d52e6e13a20cdb9f40cee041aa9b49ee51c12b89382ca6415dcce2cd7d0e3d6fc4160bc4c9fa35406675ac2b4d44f4e7afb20ab70627e7a01c8902d93cc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/955476af7231270ad25f56ab5661785988a6983f102447f5b27409dfacfd9e7a005bb51dab8f3e9fe88ebad11b2321fd47c6b49f01944d02aa238283fe454d88"} 09:31:57 INFO - Running post-run listener: copy_logs_to_upload_dir 09:31:57 INFO - Copying logs to upload dir... 09:31:57 INFO - mkdir: /builds/slave/test/build/upload/logs 09:31:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.335011 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-30 09:31:57.470634) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 09:31:57.474104) ========= 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.IxN8FVrBqT/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.Yxlt8Z7gJe/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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/e2892744b256a6f597cf8134411b17dda83cc37b16084e5588d271f568d0de0e5f01af00e19d6d51f48b44e07e878f9143c0ee080fbd13682c96fb0a40cc5014", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b290d52e6e13a20cdb9f40cee041aa9b49ee51c12b89382ca6415dcce2cd7d0e3d6fc4160bc4c9fa35406675ac2b4d44f4e7afb20ab70627e7a01c8902d93cc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/955476af7231270ad25f56ab5661785988a6983f102447f5b27409dfacfd9e7a005bb51dab8f3e9fe88ebad11b2321fd47c6b49f01944d02aa238283fe454d88"} build_url:https://queue.taskcluster.net/v1/task/d7P1Rf47TEG7VGn_dH6pGg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011030 build_url: 'https://queue.taskcluster.net/v1/task/d7P1Rf47TEG7VGn_dH6pGg/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/e2892744b256a6f597cf8134411b17dda83cc37b16084e5588d271f568d0de0e5f01af00e19d6d51f48b44e07e878f9143c0ee080fbd13682c96fb0a40cc5014", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b290d52e6e13a20cdb9f40cee041aa9b49ee51c12b89382ca6415dcce2cd7d0e3d6fc4160bc4c9fa35406675ac2b4d44f4e7afb20ab70627e7a01c8902d93cc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/955476af7231270ad25f56ab5661785988a6983f102447f5b27409dfacfd9e7a005bb51dab8f3e9fe88ebad11b2321fd47c6b49f01944d02aa238283fe454d88"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 09:31:57.507250) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 09:31:57.507579) ========= 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.IxN8FVrBqT/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.Yxlt8Z7gJe/Listeners TMPDIR=/var/folders/d1/6kk031nx1xl7zwdbm4mjf_yc00000w/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.005250 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 09:31:57.556677) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 09:31:57.556994) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 09:31:57.557340) ========= ========= Total master_lag: 0.65 =========