builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0116 starttime: 1472676291.97 results: success (0) buildid: 20160831061621 builduid: ed1ea8338b1f471a85ea9d1b844a5abd revision: 3d9cabea1e561a62734fa8d4ce8005696ef33f6d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 13:44:51.969273) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 13:44:51.969753) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 13:44:51.970042) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 13:44:51.994597) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 13:44:51.994880) ========= 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.ctdsr4I433/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.fvTrk6wD4a/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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-31 13:44:52-- 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% 16.0M=0.001s 2016-08-31 13:44:52 (16.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.140546 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 13:44:52.159897) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 13:44:52.160428) ========= 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.ctdsr4I433/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.fvTrk6wD4a/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.028723 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 13:44:52.210657) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-31 13:44:52.211005) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3d9cabea1e561a62734fa8d4ce8005696ef33f6d --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 3d9cabea1e561a62734fa8d4ce8005696ef33f6d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ctdsr4I433/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.fvTrk6wD4a/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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-31 13:44:52,287 truncating revision to first 12 chars 2016-08-31 13:44:52,288 Setting DEBUG logging. 2016-08-31 13:44:52,288 attempt 1/10 2016-08-31 13:44:52,288 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3d9cabea1e56?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-31 13:44:53,690 unpacking tar archive at: mozilla-central-3d9cabea1e56/testing/mozharness/ program finished with exit code 0 elapsedTime=1.656626 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-31 13:44:53.889772) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 13:44:53.890141) ========= script_repo_revision: 3d9cabea1e561a62734fa8d4ce8005696ef33f6d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 13:44:53.890596) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 13:44:53.890923) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 13:44:53.909958) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-31 13:44:53.910612) ========= /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.ctdsr4I433/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.fvTrk6wD4a/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 13:44:54 INFO - MultiFileLogger online at 20160831 13:44:54 in /builds/slave/test 13:44:54 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 13:44:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:44:54 INFO - {'append_to_log': False, 13:44:54 INFO - 'base_work_dir': '/builds/slave/test', 13:44:54 INFO - 'blob_upload_branch': 'Firefox', 13:44:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:44:54 INFO - 'branch': 'Firefox', 13:44:54 INFO - 'buildbot_json_path': 'buildprops.json', 13:44:54 INFO - 'config_files': ('talos/mac_config.py',), 13:44:54 INFO - 'default_actions': ('clobber', 13:44:54 INFO - 'read-buildbot-config', 13:44:54 INFO - 'download-and-extract', 13:44:54 INFO - 'populate-webroot', 13:44:54 INFO - 'create-virtualenv', 13:44:54 INFO - 'install', 13:44:54 INFO - 'run-tests'), 13:44:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:44:54 INFO - 'download_minidump_stackwalk': True, 13:44:54 INFO - 'download_symbols': 'ondemand', 13:44:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:44:54 INFO - 'tooltool.py': '/tools/tooltool.py', 13:44:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:44:54 INFO - '/tools/misc-python/virtualenv.py')}, 13:44:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:44:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:44:54 INFO - 'installer_path': 'installer.exe', 13:44:54 INFO - 'log_level': 'info', 13:44:54 INFO - 'log_name': 'talos', 13:44:54 INFO - 'log_to_console': True, 13:44:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:44:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:44:54 INFO - 'opt_config_files': (), 13:44:54 INFO - 'pip_index': False, 13:44:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:44:54 INFO - 'cmd': ('bash', 13:44:54 INFO - '-c', 13:44:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:44:54 INFO - 'enabled': True, 13:44:54 INFO - 'halt_on_failure': False, 13:44:54 INFO - 'name': 'check_screen_resolution'},), 13:44:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:44:54 INFO - 'cmd': ('bash', 13:44:54 INFO - '-c', 13:44:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:44:54 INFO - 'enabled': True, 13:44:54 INFO - 'halt_on_failure': False, 13:44:54 INFO - 'name': 'check_screen_resolution'},), 13:44:54 INFO - 'run_cmd_checks_enabled': True, 13:44:54 INFO - 'sps_profile': False, 13:44:54 INFO - 'sps_profile_interval': 0, 13:44:54 INFO - 'suite': 'dromaeojs-e10s', 13:44:54 INFO - 'system_bits': '32', 13:44:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:44:54 INFO - 'title': 't-yosemite-r7-0116', 13:44:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:44:54 INFO - 'use_talos_json': True, 13:44:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:44:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:44:54 INFO - 'work_dir': 'build'} 13:44:54 INFO - [mozharness: 2016-08-31 20:44:54.111761Z] Running clobber step. 13:44:54 INFO - Running pre-action listener: _resource_record_pre_action 13:44:54 INFO - Running main action method: clobber 13:44:54 INFO - rmtree: /builds/slave/test/build 13:44:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:44:56 INFO - Running post-action listener: _resource_record_post_action 13:44:56 INFO - [mozharness: 2016-08-31 20:44:56.253982Z] Finished clobber step (success) 13:44:56 INFO - [mozharness: 2016-08-31 20:44:56.254128Z] Running read-buildbot-config step. 13:44:56 INFO - Running pre-action listener: _resource_record_pre_action 13:44:56 INFO - Running main action method: read_buildbot_config 13:44:56 INFO - Using buildbot properties: 13:44:56 INFO - { 13:44:56 INFO - "project": "", 13:44:56 INFO - "product": "firefox", 13:44:56 INFO - "script_repo_revision": "production", 13:44:56 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 13:44:56 INFO - "repository": "", 13:44:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 13:44:56 INFO - "buildid": "20160831061621", 13:44:56 INFO - "pgo_build": "False", 13:44:56 INFO - "basedir": "/builds/slave/test", 13:44:56 INFO - "buildnumber": 54, 13:44:56 INFO - "slavename": "t-yosemite-r7-0116", 13:44:56 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 13:44:56 INFO - "platform": "yosemite_r7", 13:44:56 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 13:44:56 INFO - "branch": "mozilla-central", 13:44:56 INFO - "repo_path": "mozilla-central", 13:44:56 INFO - "revision": "3d9cabea1e561a62734fa8d4ce8005696ef33f6d", 13:44:56 INFO - "stage_platform": "macosx64", 13:44:56 INFO - "builduid": "ed1ea8338b1f471a85ea9d1b844a5abd", 13:44:56 INFO - "slavebuilddir": "test" 13:44:56 INFO - } 13:44:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/MXrpaP-tRTWIWlJDGZ1mBw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 13:44:56 INFO - Running post-action listener: _resource_record_post_action 13:44:56 INFO - [mozharness: 2016-08-31 20:44:56.257287Z] Finished read-buildbot-config step (success) 13:44:56 INFO - [mozharness: 2016-08-31 20:44:56.257400Z] Running download-and-extract step. 13:44:56 INFO - Running pre-action listener: _resource_record_pre_action 13:44:56 INFO - Running main action method: download_and_extract 13:44:56 INFO - mkdir: /builds/slave/test/build/tests 13:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:44:56 INFO - trying https://queue.taskcluster.net/v1/task/MXrpaP-tRTWIWlJDGZ1mBw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 13:44:56 INFO - Downloading https://queue.taskcluster.net/v1/task/MXrpaP-tRTWIWlJDGZ1mBw/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 13:44:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MXrpaP-tRTWIWlJDGZ1mBw/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 13:44:57 INFO - Downloaded 1199 bytes. 13:44:57 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 13:44:57 INFO - Using the following test package requirements: 13:44:57 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 13:44:57 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:44:57 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 13:44:57 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:44:57 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 13:44:57 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:44:57 INFO - u'jsshell-mac.zip'], 13:44:57 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:44:57 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 13:44:57 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 13:44:57 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:44:57 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 13:44:57 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:44:57 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 13:44:57 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:44:57 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 13:44:57 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:44:57 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 13:44:57 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:44:57 INFO - trying https://queue.taskcluster.net/v1/task/MXrpaP-tRTWIWlJDGZ1mBw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 13:44:57 INFO - Downloading https://queue.taskcluster.net/v1/task/MXrpaP-tRTWIWlJDGZ1mBw/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 13:44:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MXrpaP-tRTWIWlJDGZ1mBw/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 13:44:58 INFO - Downloaded 16396683 bytes. 13:44:58 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 13:45:05 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 13:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:05 INFO - trying https://queue.taskcluster.net/v1/task/MXrpaP-tRTWIWlJDGZ1mBw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 13:45:05 INFO - Downloading https://queue.taskcluster.net/v1/task/MXrpaP-tRTWIWlJDGZ1mBw/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 13:45:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MXrpaP-tRTWIWlJDGZ1mBw/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 13:45:06 INFO - Downloaded 16396683 bytes. 13:45:06 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 13:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:13 INFO - trying https://queue.taskcluster.net/v1/task/MXrpaP-tRTWIWlJDGZ1mBw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 13:45:13 INFO - Downloading https://queue.taskcluster.net/v1/task/MXrpaP-tRTWIWlJDGZ1mBw/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 13:45:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MXrpaP-tRTWIWlJDGZ1mBw/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 13:45:13 INFO - Downloaded 14413998 bytes. 13:45:13 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 13:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:14 INFO - trying https://queue.taskcluster.net/v1/task/MXrpaP-tRTWIWlJDGZ1mBw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:45:14 INFO - Downloading https://queue.taskcluster.net/v1/task/MXrpaP-tRTWIWlJDGZ1mBw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 13:45:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MXrpaP-tRTWIWlJDGZ1mBw/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 13:45:17 INFO - Downloaded 111580035 bytes. 13:45:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MXrpaP-tRTWIWlJDGZ1mBw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:45:17 INFO - mkdir: /builds/slave/test/properties 13:45:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:45:17 INFO - Writing to file /builds/slave/test/properties/build_url 13:45:17 INFO - Contents: 13:45:17 INFO - build_url:https://queue.taskcluster.net/v1/task/MXrpaP-tRTWIWlJDGZ1mBw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:45:17 INFO - Running post-action listener: _resource_record_post_action 13:45:17 INFO - Running post-action listener: set_extra_try_arguments 13:45:17 INFO - [mozharness: 2016-08-31 20:45:17.807498Z] Finished download-and-extract step (success) 13:45:17 INFO - [mozharness: 2016-08-31 20:45:17.807624Z] Running populate-webroot step. 13:45:17 INFO - Running pre-action listener: _resource_record_pre_action 13:45:17 INFO - Running main action method: populate_webroot 13:45:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:45:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:45:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:45:17 INFO - '--tppagecycles', 13:45:17 INFO - '7'], 13:45:17 INFO - 'tests': ['tsvgm']}}, 13:45:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:45:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:45:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:45:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:45:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:45:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:45:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:17 INFO - 'talos_options': ['--disable-e10s'], 13:45:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:45:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:45:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:17 INFO - 'talos_options': ['--disable-e10s'], 13:45:17 INFO - 'tests': ['damp', 'tps']}, 13:45:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:17 INFO - 'tests': ['damp', 'tps']}, 13:45:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:45:17 INFO - 'tests': ['dromaeo_dom']}, 13:45:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:45:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:45:17 INFO - 'tests': ['basic_compositor_video']}, 13:45:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:45:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:45:17 INFO - 'tests': ['a11yr', 13:45:17 INFO - 'ts_paint', 13:45:17 INFO - 'tpaint', 13:45:17 INFO - 'sessionrestore', 13:45:17 INFO - 'sessionrestore_no_auto_restore', 13:45:17 INFO - 'tabpaint']}, 13:45:17 INFO - 'other-e10s': {'tests': ['a11yr', 13:45:17 INFO - 'ts_paint', 13:45:17 INFO - 'tpaint', 13:45:17 INFO - 'sessionrestore', 13:45:17 INFO - 'sessionrestore_no_auto_restore', 13:45:17 INFO - 'tabpaint']}, 13:45:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:45:17 INFO - 'ts_paint', 13:45:17 INFO - 'tpaint', 13:45:17 INFO - 'sessionrestore', 13:45:17 INFO - 'sessionrestore_no_auto_restore', 13:45:17 INFO - 'tabpaint']}, 13:45:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:45:17 INFO - 'ts_paint', 13:45:17 INFO - 'tpaint', 13:45:17 INFO - 'sessionrestore', 13:45:17 INFO - 'sessionrestore_no_auto_restore', 13:45:17 INFO - 'tabpaint']}, 13:45:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:45:17 INFO - 'tests': ['a11yr', 13:45:17 INFO - 'ts_paint', 13:45:17 INFO - 'tpaint', 13:45:17 INFO - 'sessionrestore', 13:45:17 INFO - 'sessionrestore_no_auto_restore', 13:45:17 INFO - 'tabpaint']}, 13:45:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:45:17 INFO - 'tests': ['a11yr', 13:45:17 INFO - 'ts_paint', 13:45:17 INFO - 'tpaint', 13:45:17 INFO - 'sessionrestore', 13:45:17 INFO - 'sessionrestore_no_auto_restore', 13:45:17 INFO - 'tabpaint']}, 13:45:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:45:17 INFO - 'tests': ['tsvgx', 13:45:17 INFO - 'tsvgr_opacity', 13:45:17 INFO - 'tart', 13:45:17 INFO - 'tscrollx', 13:45:17 INFO - 'cart']}, 13:45:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:45:17 INFO - 'tsvgr_opacity', 13:45:17 INFO - 'tart', 13:45:17 INFO - 'tscrollx', 13:45:17 INFO - 'cart']}, 13:45:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:17 INFO - 'talos_options': ['--disable-e10s'], 13:45:17 INFO - 'tests': ['tp5o']}, 13:45:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:17 INFO - 'tests': ['tp5o']}, 13:45:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:17 INFO - 'talos_options': ['--disable-e10s', 13:45:17 INFO - '--xperf_path', 13:45:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:45:17 INFO - 'tests': ['tp5n']}, 13:45:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:17 INFO - 'talos_options': ['--xperf_path', 13:45:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:45:17 INFO - 'tests': ['tp5n']}}, 13:45:17 INFO - 'talos.zip': {'path': '', 13:45:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:45:17 INFO - Running post-action listener: _resource_record_post_action 13:45:17 INFO - [mozharness: 2016-08-31 20:45:17.826603Z] Finished populate-webroot step (success) 13:45:17 INFO - [mozharness: 2016-08-31 20:45:17.826702Z] Running create-virtualenv step. 13:45:17 INFO - Running pre-action listener: _resource_record_pre_action 13:45:17 INFO - Running main action method: create_virtualenv 13:45:17 INFO - Creating virtualenv /builds/slave/test/build/venv 13:45:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:45:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:45:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:45:17 INFO - Using real prefix '/tools/python27' 13:45:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:45:18 INFO - Installing distribute.............................................................................................................................................................................................done. 13:45:21 INFO - Installing pip.................done. 13:45:21 INFO - Return code: 0 13:45:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:45: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')]} 13:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45: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')]} 13:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f752a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7e7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f959ad7c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b6d30>, '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 0x10f41bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6aeb20>, '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.ctdsr4I433/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.fvTrk6wD4a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:45: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', 'pip>=1.5'] in /builds/slave/test/build 13:45: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 pip>=1.5 13:45:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ctdsr4I433/Render', 13:45:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:21 INFO - 'HOME': '/Users/cltbld', 13:45:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:21 INFO - 'LOGNAME': 'cltbld', 13:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:21 INFO - 'MOZ_NO_REMOTE': '1', 13:45:21 INFO - 'NO_EM_RESTART': '1', 13:45:21 INFO - 'PAGER': '/bin/cat', 13:45:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:21 INFO - 'PWD': '/builds/slave/test', 13:45:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:21 INFO - 'SHELL': '/bin/bash', 13:45:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fvTrk6wD4a/Listeners', 13:45:21 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 13:45:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:21 INFO - 'USER': 'cltbld', 13:45:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:21 INFO - 'XPC_FLAGS': '0x0', 13:45:21 INFO - 'XPC_SERVICE_NAME': '0', 13:45:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:45:21 INFO - Cleaning up... 13:45:21 INFO - Return code: 0 13:45:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:45: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')]} 13:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45: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')]} 13:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45: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', '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 0x10f752a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7e7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f959ad7c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b6d30>, '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 0x10f41bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6aeb20>, '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.ctdsr4I433/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.fvTrk6wD4a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:45: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', 'psutil>=3.1.1'] in /builds/slave/test/build 13:45: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 psutil>=3.1.1 13:45:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ctdsr4I433/Render', 13:45:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:21 INFO - 'HOME': '/Users/cltbld', 13:45:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:21 INFO - 'LOGNAME': 'cltbld', 13:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:21 INFO - 'MOZ_NO_REMOTE': '1', 13:45:21 INFO - 'NO_EM_RESTART': '1', 13:45:21 INFO - 'PAGER': '/bin/cat', 13:45:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:21 INFO - 'PWD': '/builds/slave/test', 13:45:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:21 INFO - 'SHELL': '/bin/bash', 13:45:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fvTrk6wD4a/Listeners', 13:45:21 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 13:45:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:21 INFO - 'USER': 'cltbld', 13:45:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:21 INFO - 'XPC_FLAGS': '0x0', 13:45:21 INFO - 'XPC_SERVICE_NAME': '0', 13:45:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:22 INFO - Downloading/unpacking psutil>=3.1.1 13:45: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 13:45: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 13:45: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 13:45: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 13:45: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 13:45: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 13:45:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:45:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:45:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:45:25 INFO - Installing collected packages: psutil 13:45:25 INFO - Running setup.py install for psutil 13:45:25 INFO - building 'psutil._psutil_osx' extension 13:45:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 13:45:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 13:45:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 13:45:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 13:45:26 INFO - building 'psutil._psutil_posix' extension 13:45:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 13:45:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:45:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:45:26 INFO - ^ 13:45:26 INFO - 1 warning generated. 13:45:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 13:45:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:45:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:45:26 INFO - Successfully installed psutil 13:45:26 INFO - Cleaning up... 13:45:26 INFO - Return code: 0 13:45:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:45: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')]} 13:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45: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')]} 13:45:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f752a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7e7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f959ad7c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b6d30>, '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 0x10f41bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6aeb20>, '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.ctdsr4I433/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.fvTrk6wD4a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:45:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:45:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:45:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ctdsr4I433/Render', 13:45:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:26 INFO - 'HOME': '/Users/cltbld', 13:45:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:26 INFO - 'LOGNAME': 'cltbld', 13:45:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:26 INFO - 'MOZ_NO_REMOTE': '1', 13:45:26 INFO - 'NO_EM_RESTART': '1', 13:45:26 INFO - 'PAGER': '/bin/cat', 13:45:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:26 INFO - 'PWD': '/builds/slave/test', 13:45:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:26 INFO - 'SHELL': '/bin/bash', 13:45:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fvTrk6wD4a/Listeners', 13:45:26 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 13:45:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:26 INFO - 'USER': 'cltbld', 13:45:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:26 INFO - 'XPC_FLAGS': '0x0', 13:45:26 INFO - 'XPC_SERVICE_NAME': '0', 13:45:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:45:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:45:29 INFO - Installing collected packages: mozsystemmonitor 13:45:29 INFO - Running setup.py install for mozsystemmonitor 13:45:29 INFO - Successfully installed mozsystemmonitor 13:45:29 INFO - Cleaning up... 13:45:29 INFO - Return code: 0 13:45:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:29 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 0x10f752a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7e7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f959ad7c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b6d30>, '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 0x10f41bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6aeb20>, '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.ctdsr4I433/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.fvTrk6wD4a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:45:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:45:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:45:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ctdsr4I433/Render', 13:45:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:29 INFO - 'HOME': '/Users/cltbld', 13:45:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:29 INFO - 'LOGNAME': 'cltbld', 13:45:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:29 INFO - 'MOZ_NO_REMOTE': '1', 13:45:29 INFO - 'NO_EM_RESTART': '1', 13:45:29 INFO - 'PAGER': '/bin/cat', 13:45:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:29 INFO - 'PWD': '/builds/slave/test', 13:45:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:29 INFO - 'SHELL': '/bin/bash', 13:45:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fvTrk6wD4a/Listeners', 13:45:29 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 13:45:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:29 INFO - 'USER': 'cltbld', 13:45:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:29 INFO - 'XPC_FLAGS': '0x0', 13:45:29 INFO - 'XPC_SERVICE_NAME': '0', 13:45:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:29 INFO - Downloading/unpacking jsonschema==2.5.1 13:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:45:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:32 INFO - Downloading functools32-3.2.3-2.tar.gz 13:45:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:45:32 INFO - warning: no files found matching '*.txt' 13:45:32 INFO - no previously-included directories found matching 'build' 13:45:32 INFO - no previously-included directories found matching 'dist' 13:45:32 INFO - no previously-included directories found matching '.git*' 13:45:32 INFO - Installing collected packages: jsonschema, functools32 13:45:32 INFO - Running setup.py install for functools32 13:45:33 INFO - warning: no files found matching '*.txt' 13:45:33 INFO - no previously-included directories found matching 'build' 13:45:33 INFO - no previously-included directories found matching 'dist' 13:45:33 INFO - no previously-included directories found matching '.git*' 13:45:33 INFO - Successfully installed jsonschema functools32 13:45:33 INFO - Cleaning up... 13:45:33 INFO - Return code: 0 13:45:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f752a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7e7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f959ad7c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b6d30>, '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 0x10f41bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6aeb20>, '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.ctdsr4I433/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.fvTrk6wD4a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:45:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:45:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ctdsr4I433/Render', 13:45:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:33 INFO - 'HOME': '/Users/cltbld', 13:45:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:33 INFO - 'LOGNAME': 'cltbld', 13:45:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:33 INFO - 'MOZ_NO_REMOTE': '1', 13:45:33 INFO - 'NO_EM_RESTART': '1', 13:45:33 INFO - 'PAGER': '/bin/cat', 13:45:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:33 INFO - 'PWD': '/builds/slave/test', 13:45:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:33 INFO - 'SHELL': '/bin/bash', 13:45:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fvTrk6wD4a/Listeners', 13:45:33 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 13:45:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:33 INFO - 'USER': 'cltbld', 13:45:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:33 INFO - 'XPC_FLAGS': '0x0', 13:45:33 INFO - 'XPC_SERVICE_NAME': '0', 13:45:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:45:33 INFO - Cleaning up... 13:45:33 INFO - Return code: 0 13:45:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f752a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7e7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f959ad7c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b6d30>, '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 0x10f41bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6aeb20>, '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.ctdsr4I433/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.fvTrk6wD4a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:45:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:45:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ctdsr4I433/Render', 13:45:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:33 INFO - 'HOME': '/Users/cltbld', 13:45:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:33 INFO - 'LOGNAME': 'cltbld', 13:45:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:33 INFO - 'MOZ_NO_REMOTE': '1', 13:45:33 INFO - 'NO_EM_RESTART': '1', 13:45:33 INFO - 'PAGER': '/bin/cat', 13:45:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:33 INFO - 'PWD': '/builds/slave/test', 13:45:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:33 INFO - 'SHELL': '/bin/bash', 13:45:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fvTrk6wD4a/Listeners', 13:45:33 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 13:45:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:33 INFO - 'USER': 'cltbld', 13:45:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:33 INFO - 'XPC_FLAGS': '0x0', 13:45:33 INFO - 'XPC_SERVICE_NAME': '0', 13:45:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:33 INFO - Downloading/unpacking blobuploader==1.2.4 13:45: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 13:45: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 13:45: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 13:45: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 13:45: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 13:45: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 13:45:36 INFO - Downloading blobuploader-1.2.4.tar.gz 13:45:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:45:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:45:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:37 INFO - Downloading docopt-0.6.1.tar.gz 13:45:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:45:37 INFO - Installing collected packages: blobuploader, requests, docopt 13:45:37 INFO - Running setup.py install for blobuploader 13:45:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:45:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:45:37 INFO - Running setup.py install for requests 13:45:38 INFO - Running setup.py install for docopt 13:45:38 INFO - Successfully installed blobuploader requests docopt 13:45:38 INFO - Cleaning up... 13:45:38 INFO - Return code: 0 13:45:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:38 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 0x10f752a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7e7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f959ad7c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b6d30>, '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 0x10f41bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6aeb20>, '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.ctdsr4I433/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.fvTrk6wD4a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:45:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:45:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:45:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ctdsr4I433/Render', 13:45:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:38 INFO - 'HOME': '/Users/cltbld', 13:45:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:38 INFO - 'LOGNAME': 'cltbld', 13:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:38 INFO - 'MOZ_NO_REMOTE': '1', 13:45:38 INFO - 'NO_EM_RESTART': '1', 13:45:38 INFO - 'PAGER': '/bin/cat', 13:45:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:38 INFO - 'PWD': '/builds/slave/test', 13:45:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:38 INFO - 'SHELL': '/bin/bash', 13:45:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fvTrk6wD4a/Listeners', 13:45:38 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 13:45:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:38 INFO - 'USER': 'cltbld', 13:45:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:38 INFO - 'XPC_FLAGS': '0x0', 13:45:38 INFO - 'XPC_SERVICE_NAME': '0', 13:45:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:45:38 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-cm3uq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:45:38 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-xmhurS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:45:38 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-ca2nON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:45:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-9JfRTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:45:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-7owTxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:45:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-eVL26Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:45:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-LCsFGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:45:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-4VtF4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:45:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-7updiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:45:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-cOgh0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:45:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-GBxM5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:45:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-k1TxWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:45:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-VGfJ2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:45:40 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-CSxnLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:40 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-ZX7uJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:45:40 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-7FUHD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:45:40 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-6eRapV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:45:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:45:40 INFO - Running setup.py install for manifestparser 13:45:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:45:40 INFO - Running setup.py install for mozcrash 13:45:40 INFO - Running setup.py install for mozdebug 13:45:40 INFO - Running setup.py install for mozdevice 13:45:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:45:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:45:41 INFO - Running setup.py install for mozfile 13:45:41 INFO - Running setup.py install for mozhttpd 13:45:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:45:41 INFO - Running setup.py install for mozinfo 13:45:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:45:41 INFO - Running setup.py install for mozInstall 13:45:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:45:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:45:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:45:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:45:41 INFO - Running setup.py install for mozleak 13:45:41 INFO - Running setup.py install for mozlog 13:45:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:45:41 INFO - Running setup.py install for moznetwork 13:45:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:45:42 INFO - Running setup.py install for mozprocess 13:45:42 INFO - Running setup.py install for mozprofile 13:45:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:45:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:45:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:45:42 INFO - Running setup.py install for mozrunner 13:45:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:45:42 INFO - Running setup.py install for mozscreenshot 13:45:42 INFO - Running setup.py install for moztest 13:45:42 INFO - Running setup.py install for mozversion 13:45:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:45:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:45:43 INFO - Cleaning up... 13:45:43 INFO - Return code: 0 13:45:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:45: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')]} 13:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45: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')]} 13:45:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:43 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 0x10f752a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7e7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f959ad7c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b6d30>, '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 0x10f41bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6aeb20>, '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.ctdsr4I433/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.fvTrk6wD4a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:45:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:45:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:45:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ctdsr4I433/Render', 13:45:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:43 INFO - 'HOME': '/Users/cltbld', 13:45:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:43 INFO - 'LOGNAME': 'cltbld', 13:45:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:43 INFO - 'MOZ_NO_REMOTE': '1', 13:45:43 INFO - 'NO_EM_RESTART': '1', 13:45:43 INFO - 'PAGER': '/bin/cat', 13:45:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:43 INFO - 'PWD': '/builds/slave/test', 13:45:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:43 INFO - 'SHELL': '/bin/bash', 13:45:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fvTrk6wD4a/Listeners', 13:45:43 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 13:45:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:43 INFO - 'USER': 'cltbld', 13:45:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:43 INFO - 'XPC_FLAGS': '0x0', 13:45:43 INFO - 'XPC_SERVICE_NAME': '0', 13:45:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:45:43 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-vMAkiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:45:43 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-6KbeCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:45:43 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-m5Gzq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:45:43 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-rs5mLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:45:43 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-VCJRbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:45:43 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-_1kTym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:45:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:45:44 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-j4JgYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:45:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:45:44 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-OeoHvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:45:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:45:44 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-VRtZIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:45:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:45:44 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-Krlywi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:45:44 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)) 13:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:45:44 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-bKrWLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:45:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:45:44 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-mwc9eJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:45:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:45:44 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-KTe5sM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:45:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:45:44 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-tzOrtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:45:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:44 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-6NrhMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:45:44 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-6QvKno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:45:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:45:45 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-9wqSYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:45:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:45:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:45:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:45:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:45:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:45:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:45:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:47 INFO - Downloading blessings-1.6.tar.gz 13:45:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:45:47 INFO - Installing collected packages: blessings 13:45:47 INFO - Running setup.py install for blessings 13:45:47 INFO - Successfully installed blessings 13:45:47 INFO - Cleaning up... 13:45:48 INFO - Return code: 0 13:45:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:45:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:45:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:45:48 INFO - Reading from file tmpfile_stdout 13:45:48 INFO - Current package versions: 13:45:48 INFO - blessings == 1.6 13:45:48 INFO - blobuploader == 1.2.4 13:45:48 INFO - docopt == 0.6.1 13:45:48 INFO - functools32 == 3.2.3-2 13:45:48 INFO - jsonschema == 2.5.1 13:45:48 INFO - manifestparser == 1.1 13:45:48 INFO - mozInstall == 1.12 13:45:48 INFO - mozcrash == 0.17 13:45:48 INFO - mozdebug == 0.1 13:45:48 INFO - mozdevice == 0.48 13:45:48 INFO - mozfile == 1.2 13:45:48 INFO - mozhttpd == 0.7 13:45:48 INFO - mozinfo == 0.9 13:45:48 INFO - mozleak == 0.1 13:45:48 INFO - mozlog == 3.3 13:45:48 INFO - moznetwork == 0.27 13:45:48 INFO - mozprocess == 0.23 13:45:48 INFO - mozprofile == 0.28 13:45:48 INFO - mozrunner == 6.12 13:45:48 INFO - mozscreenshot == 0.1 13:45:48 INFO - mozsystemmonitor == 0.3 13:45:48 INFO - moztest == 0.7 13:45:48 INFO - mozversion == 1.4 13:45:48 INFO - psutil == 3.1.1 13:45:48 INFO - requests == 1.2.3 13:45:48 INFO - wsgiref == 0.1.2 13:45:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:48 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 0x10f752a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7e7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f959ad7c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b6d30>, '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 0x10f41bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6aeb20>, '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.ctdsr4I433/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.fvTrk6wD4a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:45:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:45:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:45:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ctdsr4I433/Render', 13:45:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:48 INFO - 'HOME': '/Users/cltbld', 13:45:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:48 INFO - 'LOGNAME': 'cltbld', 13:45:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:48 INFO - 'MOZ_NO_REMOTE': '1', 13:45:48 INFO - 'NO_EM_RESTART': '1', 13:45:48 INFO - 'PAGER': '/bin/cat', 13:45:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:48 INFO - 'PWD': '/builds/slave/test', 13:45:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:48 INFO - 'SHELL': '/bin/bash', 13:45:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fvTrk6wD4a/Listeners', 13:45:48 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 13:45:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:48 INFO - 'USER': 'cltbld', 13:45:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:48 INFO - 'XPC_FLAGS': '0x0', 13:45:48 INFO - 'XPC_SERVICE_NAME': '0', 13:45:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:45:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:45:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:45:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:45:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:45:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:45:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:45:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:45:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:45:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:45:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:45:48 INFO - Cleaning up... 13:45:48 INFO - Return code: 0 13:45:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f752a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7e7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f959ad7c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b6d30>, '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 0x10f41bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6aeb20>, '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.ctdsr4I433/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.fvTrk6wD4a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:45:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:45:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:45:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ctdsr4I433/Render', 13:45:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:49 INFO - 'HOME': '/Users/cltbld', 13:45:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:49 INFO - 'LOGNAME': 'cltbld', 13:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:49 INFO - 'MOZ_NO_REMOTE': '1', 13:45:49 INFO - 'NO_EM_RESTART': '1', 13:45:49 INFO - 'PAGER': '/bin/cat', 13:45:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:49 INFO - 'PWD': '/builds/slave/test', 13:45:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:49 INFO - 'SHELL': '/bin/bash', 13:45:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fvTrk6wD4a/Listeners', 13:45:49 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 13:45:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:49 INFO - 'USER': 'cltbld', 13:45:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:49 INFO - 'XPC_FLAGS': '0x0', 13:45:49 INFO - 'XPC_SERVICE_NAME': '0', 13:45:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:45:49 INFO - Cleaning up... 13:45:49 INFO - Return code: 0 13:45:49 INFO - Running post-action listener: _resource_record_post_action 13:45:49 INFO - Running post-action listener: _start_resource_monitoring 13:45:49 INFO - Starting resource monitoring. 13:45:49 INFO - [mozharness: 2016-08-31 20:45:49.608368Z] Finished create-virtualenv step (success) 13:45:49 INFO - [mozharness: 2016-08-31 20:45:49.609415Z] Running install step. 13:45:49 INFO - Running pre-action listener: _resource_record_pre_action 13:45:49 INFO - Running main action method: install 13:45:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:45:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:45:49 INFO - Reading from file tmpfile_stdout 13:45:49 INFO - Detecting whether we're running mozinstall >=1.0... 13:45:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:45:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:45:49 INFO - Reading from file tmpfile_stdout 13:45:49 INFO - Output received: 13:45:49 INFO - Usage: mozinstall [options] installer 13:45:49 INFO - Options: 13:45:49 INFO - -h, --help show this help message and exit 13:45:49 INFO - -d DEST, --destination=DEST 13:45:49 INFO - Directory to install application into. [default: 13:45:49 INFO - "/builds/slave/test"] 13:45:49 INFO - --app=APP Application being installed. [default: firefox] 13:45:49 INFO - mkdir: /builds/slave/test/build/application 13:45:49 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'] 13:45:49 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 13:46:24 INFO - Reading from file tmpfile_stdout 13:46:24 INFO - Output received: 13:46:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:46:24 INFO - Running post-action listener: _resource_record_post_action 13:46:24 INFO - [mozharness: 2016-08-31 20:46:24.224536Z] Finished install step (success) 13:46:24 INFO - [mozharness: 2016-08-31 20:46:24.224677Z] Running run-tests step. 13:46:24 INFO - Running pre-action listener: _resource_record_pre_action 13:46:24 INFO - Running main action method: run_tests 13:46:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:46:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:46:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:46:24 INFO - 2016-08-31 13:46:24.239 screenresolution[1632:7440] starting screenresolution argv=screenresolution get 13:46:24 INFO - 2016-08-31 13:46:24.241 screenresolution[1632:7440] Display 0: 1600x1200x32@60 13:46:24 INFO - 2016-08-31 13:46:24.247 screenresolution[1633:7442] starting screenresolution argv=screenresolution list 13:46:24 INFO - Available Modes on Display 0 13:46:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:46:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:46:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:46:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:46:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:46:24 INFO - Intel Iris: 13:46:24 INFO - Chipset Model: Intel Iris 13:46:24 INFO - Type: GPU 13:46:24 INFO - Bus: Built-In 13:46:24 INFO - VRAM (Dynamic, Max): 1536 MB 13:46:24 INFO - Vendor: Intel (0x8086) 13:46:24 INFO - Device ID: 0x0a2e 13:46:24 INFO - Revision ID: 0x0009 13:46:24 INFO - Displays: 13:46:24 INFO - Display: 13:46:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:46:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:46:24 INFO - Display Serial Number: 1600x1200 60 13:46:24 INFO - Main Display: Yes 13:46:24 INFO - Mirror: Off 13:46:24 INFO - Online: Yes 13:46:24 INFO - Rotation: Supported 13:46:24 INFO - Return code: 0 13:46:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:46:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:46:24 INFO - Python 2.7.3 13:46:24 INFO - Return code: 0 13:46:24 INFO - grabbing minidump binary from tooltool 13:46:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:46:24 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 0x10f6b6d30>, '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 0x10f41bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6aeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:46:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:46:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 13:46:24 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:46:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:46:24 INFO - Return code: 0 13:46:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:46:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:46:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:46:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:46:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:46:24 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/MXrpaP-tRTWIWlJDGZ1mBw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0116', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:46:24 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/MXrpaP-tRTWIWlJDGZ1mBw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0116 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:46:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ctdsr4I433/Render', 13:46:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:46:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:46:24 INFO - 'HOME': '/Users/cltbld', 13:46:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:46:24 INFO - 'LOGNAME': 'cltbld', 13:46:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:46:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:46:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:24 INFO - 'MOZ_NO_REMOTE': '1', 13:46:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:46:24 INFO - 'NO_EM_RESTART': '1', 13:46:24 INFO - 'PAGER': '/bin/cat', 13:46:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:46:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:46:24 INFO - 'PWD': '/builds/slave/test', 13:46:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:46:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:46:24 INFO - 'SHELL': '/bin/bash', 13:46:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fvTrk6wD4a/Listeners', 13:46:24 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 13:46:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:46:24 INFO - 'USER': 'cltbld', 13:46:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:46:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:46:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:24 INFO - 'XPC_FLAGS': '0x0', 13:46:24 INFO - 'XPC_SERVICE_NAME': '0', 13:46:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:46:24 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/MXrpaP-tRTWIWlJDGZ1mBw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0116', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:46:24 INFO - mozversion application_buildid: 20160831061621 13:46:24 INFO - mozversion application_changeset: 3d9cabea1e561a62734fa8d4ce8005696ef33f6d 13:46:24 INFO - mozversion application_display_name: Nightly 13:46:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:46:24 INFO - mozversion application_name: Firefox 13:46:24 INFO - mozversion application_remotingname: firefox 13:46:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:46:24 INFO - mozversion application_vendor: Mozilla 13:46:24 INFO - mozversion application_version: 51.0a1 13:46:24 INFO - mozversion platform_buildid: 20160831061621 13:46:24 INFO - mozversion platform_changeset: 3d9cabea1e561a62734fa8d4ce8005696ef33f6d 13:46:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:46:24 INFO - mozversion platform_version: 51.0a1 13:46:24 INFO - using testdate: 1472676384 13:46:24 INFO - actual date: 1472676384 13:46:24 INFO - starting webserver on 'localhost:49267' 13:46:24 INFO - SUITE-START | Running 2 tests 13:46:24 INFO - TEST-START | dromaeo_css 13:46:24 INFO - operating with platform_type : mac_ 13:46:24 INFO - Initialising browser for dromaeo_css test... 13:46:24 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpfwF1Ly/profile http://localhost:49267/getInfo.html) 13:46:27 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 13:46:27 INFO - PROCESS | 1643 | colorDepth:24 13:46:27 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 13:46:27 INFO - PROCESS | 1643 | __metrics 13:46:27 ERROR - PROCESS | 1643 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 13:46:28 INFO - TEST-INFO | 1643: exit 0 13:46:28 INFO - Browser initialized. 13:46:28 INFO - Running cycle 1/1 for dromaeo_css test... 13:46:28 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpfwF1Ly/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:46:40 INFO - PROCESS | 1646 | RSS: Main: 244346880 13:46:40 INFO - PROCESS | 1646 | 13:47:30 INFO - PROCESS | 1646 | 1472676450047 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:49:42 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 13:49:43 INFO - PROCESS | 1646 | RSS: Main: 265695232 13:49:43 INFO - PROCESS | 1646 | 13:52:45 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 13:52:46 INFO - PROCESS | 1646 | RSS: Main: 270708736 13:52:46 INFO - PROCESS | 1646 | 13:55:48 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 13:55:48 INFO - PROCESS | 1646 | RSS: Main: 276652032 13:55:48 INFO - PROCESS | 1646 | 13:58:50 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 13:58:51 INFO - PROCESS | 1646 | RSS: Main: 273776640 13:58:51 INFO - PROCESS | 1646 | 14:01:54 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 14:01:54 INFO - PROCESS | 1646 | RSS: Main: 279269376 14:01:54 INFO - PROCESS | 1646 | 14:04:57 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 14:04:58 INFO - PROCESS | 1646 | RSS: Main: 281853952 14:04:58 INFO - PROCESS | 1646 | 14:04:58 INFO - PROCESS | 1646 | __start_tp_report 14:04:58 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 14:04:58 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 14:04:58 INFO - PROCESS | 1646 | |i|pagename|runs| 14:04:58 INFO - PROCESS | 1646 | |0;dojo.html;3360.5463262459575;3386.068831071455;3394.7284217262622;3407.6762707542775;3429.931401371972;5660.433956604337;5671.007573674606;5686.289213848264;5749.770009199627;5764.51001664859;5529.225908372831;5632.3804381518;5685.317761868581;5724.169995350671;5827.125931110325;5054.595632349412;5089.847304580869;5185.662931909433;5229.058769421503;5232.92150617741;4813.796550862285;5047.545720885119;5319.308489896308;5338.412774594811;5346.224797404393;4859.465458799529;5024.522670346311;5115.923261151086;5159.2003239497935;5209.426963034063;5168.095583272912;5207.375114986188;5226.817061402832;5237.240600113;5259.526642602184;5143.7912090658665;5169;5178.766955487012;5211.947880521184;5214.765335559909;4992.301077849104;5450.55560276527;5550.306211723535;5577.9163312550345;5825.79609713658;5970.805838832251;6117.296510901258;6119.106526814669;6156.292026416974;6171.765646870599;4567.817287308504;4955.851324460272;5065.290859279704;5148.588112950993;5363.249145119687;5588.30146231721;5818.44724751148;5823.359430462646;5845.181674565564;5858.472737453607;5124.718140502234;6107.5833010365195;6135.661410523283;6138.294096178907;6183.96908015457;6009.2188015557695;6045.8488537786025;6048.9697551512845;6086;6136.110264011693;6145.231846019247;6182.28903676074;6196.0705894116245;6222.377762223741;6243.719032643542;6114.145302971479;6141.048137538689;6153.476954458921;6169.981952977709;6218.19163508741;6097.963346231151;6157.96921015392;6170.969145154246;6184.938150618526;6203.069539569011;4809.615230781529;4842.58837998774;4910.386201724785;4913.533214344631;4953.380827396575;4354.085642015149;4373.934390984138;4393.802278897458;4432.268675668543;4447.2439685253585;5795.94204057954;5843.604648276725;5860.648361098348;5863.296404431496;5921.73352199152;6134.8159555213415;6141.232345956755;6148.077788331697;6158.7228574714245;6166.044263139221;5850.23946886902;5926.288845338587;5927.762889484458;5956.2852457704485;5964;5341.439148889388;5372.946270537323;5389.487998640201;5415.6479828811;5440.211169380417;6076.270847498328;6143.358355907003;6246.375362463808;6260.40526150015;6265.0602409637095;5184.196449550326;6125.019996800491;6143.389059649542;6161.537884658579;6175.5677102602385;6238.532110091671;6246.46905013079;6246.875062498633;6254.155688981929;6304.306526282197;6028.577999540165;6130.938690613215;6159.938400615936;6165.10605962124;6174.969125154345;6045.818625441244;6144.187464697836;6145.187169785014;6150.892839288971;6152.661603611844;6056.848578785565;6089.51283897296;6095.451409373178;6115.541334400027;6128.908066378919;5948.434898684618;5995.550333725076;6027.547933904887;6099.176611157614;6114.357992410733;5815.912761308668;5948.13752005948;5952.702364881825;5992.003998001;6006.489448396936;6043.244594425697;6066.514678825595;6071.483923866344;6110.541709371726;6148;5794.565407594531;5872.148538461814;5945.435183657545;5961.731722072604;5971.253593300838 14:04:58 INFO - PROCESS | 1646 | |1;ext.html;457.90841831633674;485.80491989705325;507.441814004595;545.163174527101;559.1333433178572;29557.852210738944;38324.42513362295;38445.03887402809;38467.23065538691;38537.42193867091;31834.840825795898;32943.50584741231;38165.23669526608;39413.21173576527;40049.59950400495;7922.286994170538;9667.178289845371;9677.951610241938;9689.709308720714;9710.271729620272;8118.391120665944;9558.61765529378;9590.376625519319;9668;9693.75765605862;9645.276604254708;9654.613815447408;9687.806243875119;9704.320697551175;9726.465044422554;8246.670133194695;9697.3696709714;9700.854487182698;9707.951460242724;9715.46564938928;9558.808823823554;9601.615935362577;9607.4715890626;9634.42193468387;9653.17947974423;31360.21599460009;37689.246215075545;37941.43087853684;38199.427008594896;38265.23469530594;3299.538064670948;3382.01917967412;3540.3981323174867;3639.636036396366;4043.575424580406;29760.55359169614;29778.10665680033;30229;30339.544906826417;30484;3144.638366587849;3209.4383482890403;3231.1922019495128;3240.5787247657654;3268.950965735516;484958;488815.5559222217;489377;489619;490059;55981.44018559844;56143.43856561464;56311.155332670045;56440.717796410754;56453;33294.66705332964;34153.487697684555;34397.656023439944;58808.705956469945;59173.70413147907;16278.26747796352;16401.917990409973;16460.42388516396;16497.752533712002;16519.33922643105;12476;12624.305663188428;12667.619971400873;12689.302088385042;12711.237325760483;18319.084045797925;18447.907760461112;18503.722444163348;18510.81489185091;18525.536861578297;7743.4966727162555;7880.753985114329;7884.211578842184;7919.366450683931;7976.920230797734;839.9832003359899;992.6277645882794;1002.6290272599185;1017.5014243020867;1018.2057994763948;25603.103891364084;27935.72064279372;29654.55518167229;29963.101106966828;30184.396312073637;949.368669834566;1019.9694009179588;1033.7829055898196;1045.858809060767;1052.5474046160225;12874.27991866135;14205;14652.633684157769;15009.924950375178;15194.936354455082;630448;667182;669213;673596;678186;53887.73056134694;53977.73011134919;54030.18954715682;54393;54495.45504544904;1356.2201734002988;1368.719412520431;1389.8957578181476;1393.9512117075853;1397.4200706706604;22213.77786222117;24394.75605243996;28091.016814411396;28510.42979140364;28672.13983580496;37165.81417092897;47081;47150.76424617855;47152;47217.76391118023;573843;576460;578335;581260;585944;21702.565948681255;21864.89067554652;23231.53536929218;24602.76986150721;26040.479190416463;44542;45240;45857.541424585324;46245.53754462412;46494.76752616351;37625;37670.62329376671;37796.24407511889;38357.6164238354;38607;37135.07162320964;37279.627203727614;37647.81176094102;38318.80840595779;38474.807625961694;32449.51325730163;37233.62766372302;37460.62539374681;37474;37871;32839;33820.15449613681;33879.491807623395;33919.83040084784;34143;22384;24562.877185613957;24801.379965501008;24977;25406.364840879127 14:04:58 INFO - PROCESS | 1646 | |2;jquery.html;351.20276971275206;370.3777653542048;378.9298979688756;382.5676985006942;393.47078179848114;20084.799152008476;20844.062017209224;22068;22097.889510552446;22191.001404936775;11655;11932.940335298312;12013.879861201385;12063.51745930164;12126.69683257919;5240.842774716755;5546.91679624806;5559.499645031946;5582.972085139569;5599.468050535193;5263.868403289929;5455.645383050109;5457.481539253785;5498.120300751881;5546.805861794838;5411.783528658849;5483.945160548404;5497.175423686439;5497.835064948058;5513.421090785449;5332.720147164691;5487.6158668893195;5974.312954010279;6081.1790408294755;6083.117947897575;5336.359636843604;5373.946260537384;5375.381831089436;5382.434844341366;5388.110961691316;24632;25265.36836579082;25473.23580292594;25852.35369115787;25914.352141196432;2045.8158765711157;2084.8957552122333;2311.9653205201935;2406.747291534381;2879.934424263015;9983.450910199936;10289.588416463332;10304.793904121876;11708;16051.839481605151;1857.2106854586746;1918.980810191894;1972.556174860645;2039.377989713137;2056;124121;125999;127393;127647;128402;10944.975179591802;11120.610778622871;11191.992720655016;11428.885711142948;11566.248193867372;14264.714705705828;14291.071080379743;14347.92826035863;14348.713025739427;14381.7842732357;8338.24955753985;8452.408331416742;8570.871436928452;8622.223999840044;8625.627952313038;8309.626066827008;8425.368097392597;8476.576171191417;8626.309895208493;8643.135686431306;4422.601965823092;4457.799399027052;4475.888102797456;4521.073179998092;4558.88602784933;1502.0311898825414;1588.3011474950983;1611.9516414507584;1623.7497127212216;1960.823525882649;796.8645330293864;814.1410811593707;840.0297656207091;908.7319240823973;967.0812727908515;19396.04588333407;21391.25130620421;21441.142354305965;21449.46376340573;21560.137594496045;938.7840796616816;953.3136141977765;958.6596758150896;962.5705826847127;980.4656462228103;9273.304502162366;9819.558119884623;11280.492377843017;11337.03635191018;11406.600768973047;481225;546767;570262;572902;583481;129887;131926.34036829753;134230;135532;138113;1000.5497526113132;1023.1047833145997;1028.6554004408458;1048.449563978902;1050.6742909698019;13157.34213289351;17303.82696173022;18117.637647246716;18902.7164592534;18915.054247287855;41637;50361;51580.484195157565;52028.47971520388;52088.739556301975;72045.63977180081;72185.63907180431;72227.58293128142;72675.90986135106;73372.89347257643;6456.806295811133;7658.770236892902;7895.763127106196;7978.162292959156;8056.637451314587;9416.811663766823;12637.93681031589;12871.871281287067;13029.674258143243;13083.345832708135;8057.798555035936;9284.442933424016;10028.849567256642;10885.510152043336;11040.5031773572;10581.735456613646;10617.575296988034;10617.946910265708;10780.191485638452;10914.836277455686;11102.333859968428;11170.441477925908;11180.217384782987;11215.60745373908;11415.315081095161;7832.490888092256;8051.798705032187;8087.797805054921;8172.918270817454;8216;10467.214958877963;10611.151107911193;10723.624673136403;10927.071198948179;11060.723481913017 14:04:58 INFO - PROCESS | 1646 | |3;mootools.html;1423.2527922840507;1560.1575149419311;1766.3994241957732;1857.721341798729;1911.8183772541613;7966;8554.743357699272;8731.738047858575;9095.818083638324;9122.771930701727;8736.694215702451;8796.340274479408;8962.596683149257;8965.686200982967;8971.82056358874;2398.2445529658103;2410.963835542464;2427.5509030829267;2431.3678443604613;2442.3636163770316;2398.640203969401;2417.576924038295;2438.4391589934326;2439.817013723969;2445.400876785181;2412.0834083048417;2414.9517009659885;2426.6481360202847;2442.829001969863;2443.9755602443925;2364.2079903232266;2401.2076014915124;2416.1905761569897;2419.14120487228;2420.7337192908676;1982.3359174676357;2379.7263314718857;2392.6530653055383;2402.0631953538136;2408.3497455687043;8814.86777698335;8898.288136949028;8983.10168983103;8985.146411090936;8995.595198216097;4288.742675439484;4835.105505481462;5000.0999820032375;5203.453637368059;5295.258663787073;3352.7820691654965;3495.615482296945;3586.7847929124073;3654.214343916071;3660.68884144848;1066.2376400873336;1106.955721771128;1107.8227483602584;1116.101538261699;1778.5820332221917;11186.832197517044;11498.942505287503;11501.942490287578;11673.649790506299;11730.472128754227;4669.279958820845;4778.354922085544;4852.927206091911;4897.3878265216845;4910.410750709938;9982.750431239278;10020.396736522122;10032.197424206046;10033.498325083863;10054.798904021878;5441.700706461183;5449.891002180014;5465.726713664301;5466.758628962186;5473.31583552056;4471.396361491222;4801.063792560417;4909.533594308535;4946.530079642428;4985.501449854985;3936.6653834424396;3979.144483935968;4078.9592104079175;4085.4893138357706;4148.149629325981;1321.7356528694108;1324.417256407197;1331.8335208098988;1335.0441603051577;1341.812495941099;762.0525676993228;780.3172224303735;896.8744225996332;904.7828521155008;946.6923249943658;4947.82682606107;5249.895002099936;5778.88442231153;5824.0390335595;5909.734061967221;447.5142526811021;455.5353539389804;456.9588737013685;464.6515113664751;467.61889060415655;3831.2529056834205;3895.844166233319;3992;4002.5597184309704;4003.7797921114034;10470.528826202839;10860.945695271474;10861.782764344669;10867.83698244527;10895.182861285435;10479.790404192026;10530.31552949056;10620.681379558626;10743.033127018605;10743.355398676105;8061.51630902136;8134.430589858772;8196.508209507449;8218.21926916942;8236.341092712568;5682.77268909239;5774.653520788766;5778.797742079007;5784.50831679312;5792.21805056312;9545.904540954501;9908.653197138066;9989.800203996025;10050.94465081156;10086.546105425126;10217.33587316822;10225.84661230097;10242.48787560604;10297.02178293061;10395.32430392022;5609.887802244014;6897;7419.777406677593;7527.661255243636;7602.277783610548;8349;8359.707410240613;8458.450200736932;8458.661653533789;8465.957670211856;7172.820679483055;7408.222136675787;7540.547567145989;7551.924480755342;7675.155732869492;7356.632168391452;7409.036825212688;7516.47384683067;7517.736879209201;7519.924800752141;6978.406835419046;6985.476089293222;7034.050403195503;7049.400800931979;7052.541584796972;4519.367288579667;4684.180268452939;4968.2050871861775;5025.321581586585;5025.824096156617;4105.4662893823615;4699.976500117615;4893.975530122327;4998.550130488274;5088.363954505687 14:04:58 INFO - PROCESS | 1646 | |4;prototype.html;299.46993820936945;300.5987007345194;300.85107871603554;312.85295910921866;314.1314266054359;4311.870643880681;5430.5384042356445;5546.833594992152;5614;5621.044422448178;5487.368952570456;5565.554755619551;5577.44225577442;5586.24585680933;5601.551875849932;3586.7847929124337;3877.9529527027826;4030.2544029354517;4288.949207444172;4292.7121863441;3452.7915229669666;3847.7883716395727;4255.723283015099;4280.464941882265;4290;3415.667889523088;4085.079168394597;4102.815373308208;4106.609872062149;4116.835326586933;3738.7009039276927;4107.568705285947;4119.404774991766;4119.567445418218;4163.97918010411;3332.266901281714;3372.9831350843333;3531.99338188615;3566.8216589170697;3583.928321433557;4433.9113217735785;5045.571126454256;5250.264962905197;5268.473152684739;5321.627486075976;4743.501932297094;4745;4750.216214324632;4759.095771803346;4762.880927976828;4823.2282834746275;4941.777620007108;5157.664751791159;5699.088145896637;5832.825015249549;3143.104215298652;3541.698955588778;3628.9818550907075;3663.6336366363416;3953.960460395388;5282.894342113136;5619.578531610146;5722.370539240722;6194.1018552310115;6201.503879689614;3960.6039396060164;3978.1844721831953;3978.6419222270133;3978.8660231833787;4000.739951903117;3219.2917558137174;3990.20195960809;4014.538328092307;4021.3967904814513;4030.0730831908827;4735.810567577328;4742.5731684148595;4765.690230135099;4765.928511072337;4819.95180048195;5412.105762983003;5933.516620844789;5949.077892926603;5953.940460595425;5957.344692083867;1272.2303006681009;1297.8961683065331;1343.5297645824078;1360.9183448993092;1374.2647683489486;766.5209244222361;768.5043147170156;924.4915296586851;925.6069615229171;927.2535608834818;4303.139372125587;4474.284114541658;4562.931556026662;4811.687240329367;5119.820806271762;5010.69935803853;5926.199963005025;5946.762129514771;5947.881042379128;5976.641401515923;5162.328897243335;5193.065248255275;5211.530962213343;5394.1929453633475;5400.486953739389;2176.6190916589535;2272.5114100468477;2604.791616670662;2681.839089654627;2683.7718793902345;4245.469316335458;4348.891277718019;5221.791128354823;5241.68549887008;5290.418054014055;4537.410136682211;4749.453812811571;4764.595009424169;5208.791648334024;5219.399769026534;4510.015593139008;4584.862454126315;4961.776720047678;5016.724080175552;5211.400688920823;4296.914061718686;4661.762354070133;5037.5214354636255;5059.5952323814745;5079.339685840817;4638.93041604383;4977.341653884465;5015.623828212826;5409.675419474844;5916.970415147896;5188.7405629719115;5295.470452954673;6144.477719393902;6335.968320158369;6345.682715864096;3337.6829201225846;3595.658412450813;3901.6098390160755;4028.43601895729;4038.1318016626565;5305.522502974751;5689.175069614966;6044.879102418015;6072.514198864169;6202.627842329294;5777.32457587295;5904.202932604044;5922.111683247547;5936.209981308778;5952.226210592596;5905.970470147794;5949.6430214187285;5958.6424814511265;5974.940250597612;5985.25184351956;4747.409617778083;4832.540908613676;5400.972995134999;5685.299482745828;5826.7763769608855;5873.911891321719;5902.199829052181;5909.261342332208;5925.614835035709;5958.672273025025;4908.730019848943;5459.372172200247;5772.921748170739;5799.2750906136735;5806.767729290781 14:04:58 INFO - PROCESS | 1646 | |5;yui.html;705.5484489926446;719.7804669575777;725.9092613423322;765.334159281425;809.3686924199123;15097.320620572073;16205.351785928564;16218.189090545455;16221.675566488693;16259.187040647965;14296.857031429683;14676.26618669065;14697.926510367433;14815.703685926275;14933.925330373333;821.3716506872247;822.7696245051395;850.3792231670868;863.1886027134505;864.723288547665;685.2017399729309;732.8534293141394;869.3740506835069;871.4684042733927;872.821071680304;893.9553022348889;900.5137225898008;913.2328843771231;932.2961164320963;932.4172392254841;880.5773228850123;927.8561822917391;928.4382948316239;929.8791157149561;930.2836815651978;677.4648028057828;692.6952141057918;693.4175292754061;696.2202333386639;697.7557854750847;14972.326245318987;15005.324760385809;15058.774118388234;15064.171470569114;15067.773983390258;14497.637559061002;14517.419303227858;14540.491082812157;14784.112953222733;14876.851231487655;11830.822537661941;11937.164398492108;11979.94010029953;12264.38678066093;12539.56111536101;2976.9106926792233;3857.7492462989817;4016.6585840203616;4017.8995525111814;4031.3348297530874;117726.41136794347;120916.39541802322;121544.39227803893;121823;122017.77982220153;10954.507047182897;11129.888701112885;11438.714032149097;11456.255343402652;11727;18960.52598685044;19686.803131968783;20268.493287667927;22023.45835791511;22737;7501.924980750123;7713.19011503784;8176.509409435453;8415.663373465115;8427.536485493234;4483.30508771141;4509.616682582017;4541.250693635579;4547.7498737569085;4720.386349774507;3581.516495273157;3668.5781135169796;3698.130939229279;3714.832832522489;3723.087843478311;662.3442791636245;705.1679018757812;739.752183018684;745.8060904164847;746.5707218349362;595.1311085814673;607.3410349770548;644.9903251451232;681.8329509270161;684.5995092870727;9068.682596109236;9414.419136329387;9596.088371604686;9706.805863882682;9858.162056225157;543.4103997163044;604.3291945940003;619.3527763487167;675.3314218923329;690.0994202565699;4396.494403143615;4560;4596.678232523691;4687.414073240845;4732.455767586703;46497.535024649995;47242.76378618085;121110;123663;125838;90075.09924900798;125101;127075;127815;127990;108881;109513.45243273892;110900;115513;116318.4184079091;9672.903270967481;10030.849537256801;10034.749131271778;10057.49712514386;10065.69802905914;59960;61159.388406115366;61163.69418152881;63075.6846215766;63341;88443.11556884348;91324;93901;95481;97163;12760.220310291936;12829.294388808705;12982.221066736027;13178.275194864374;13364.064515483822;14585.489507867174;14644.414223430944;14762.926185369004;14796.704065918837;14896.329665164876;13468.769402707067;13528;13726.22267381915;14047.297635117999;14268.714625707635;10995.615153469591;13420.798688019493;13592.300787872586;13645.727085458433;13733.656658583615;13252.668683282995;13306.40121194568;13499.595012149652;13921.303934803016;13980.370883310072;11051;11268.71788720281;11274.84304394738;11483.425828708698;11487.885121149016;11168.441577920908;11239.269447485887;11487.770244594894;11499.597514086967;11515.136364772843 14:04:58 INFO - PROCESS | 1646 | __end_tp_report 14:04:58 INFO - PROCESS | 1646 | __start_cc_report 14:04:58 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,375 14:04:58 INFO - PROCESS | 1646 | __end_cc_report 14:04:58 INFO - PROCESS | 1646 | __startTimestamp1472677498185__endTimestamp 14:04:58 INFO - PROCESS | 1646 | 14:04:58 INFO - PROCESS | 1646 | ------- Summary: start ------- 14:04:58 INFO - PROCESS | 1646 | Number of tests: 6 14:04:58 INFO - PROCESS | 1646 | 14:04:58 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5662.59 Median:5927.76 stddev:632.21 (10.7%) stddev-sans-first:607.81 14:04:58 INFO - PROCESS | 1646 | Values: 3360.5 3386.1 3394.7 3407.7 3429.9 5660.4 5671.0 5686.3 5749.8 5764.5 5529.2 5632.4 5685.3 5724.2 5827.1 5054.6 5089.8 5185.7 5229.1 5232.9 4813.8 5047.5 5319.3 5338.4 5346.2 4859.5 5024.5 5115.9 5159.2 5209.4 5168.1 5207.4 5226.8 5237.2 5259.5 5143.8 5169.0 5178.8 5211.9 5214.8 4992.3 5450.6 5550.3 5577.9 5825.8 5970.8 6117.3 6119.1 6156.3 6171.8 4567.8 4955.9 5065.3 5148.6 5363.2 5588.3 5818.4 5823.4 5845.2 5858.5 5124.7 6107.6 6135.7 6138.3 6184.0 6009.2 6045.8 6049.0 6086.0 6136.1 6145.2 6182.3 6196.1 6222.4 6243.7 6114.1 6141.0 6153.5 6170.0 6218.2 6098.0 6158.0 6171.0 6184.9 6203.1 4809.6 4842.6 4910.4 4913.5 4953.4 4354.1 4373.9 4393.8 4432.3 4447.2 5795.9 5843.6 5860.6 5863.3 5921.7 6134.8 6141.2 6148.1 6158.7 6166.0 5850.2 5926.3 5927.8 5956.3 5964.0 5341.4 5372.9 5389.5 5415.6 5440.2 6076.3 6143.4 6246.4 6260.4 6265.1 5184.2 6125.0 6143.4 6161.5 6175.6 6238.5 6246.5 6246.9 6254.2 6304.3 6028.6 6130.9 6159.9 6165.1 6175.0 6045.8 6144.2 6145.2 6150.9 6152.7 6056.8 6089.5 6095.5 6115.5 6128.9 5948.4 5995.6 6027.5 6099.2 6114.4 5815.9 5948.1 5952.7 5992.0 6006.5 6043.2 6066.5 6071.5 6110.5 6148.0 5794.6 5872.1 5945.4 5961.7 5971.3 14:04:58 INFO - PROCESS | 1646 | 14:04:58 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:69262.32 Median:37906.22 stddev:155809.36 (411.0%) stddev-sans-first:156160.80 14:04:58 INFO - PROCESS | 1646 | Values: 457.9 485.8 507.4 545.2 559.1 29557.9 38324.4 38445.0 38467.2 38537.4 31834.8 32943.5 38165.2 39413.2 40049.6 7922.3 9667.2 9678.0 9689.7 9710.3 8118.4 9558.6 9590.4 9668.0 9693.8 9645.3 9654.6 9687.8 9704.3 9726.5 8246.7 9697.4 9700.9 9708.0 9715.5 9558.8 9601.6 9607.5 9634.4 9653.2 31360.2 37689.2 37941.4 38199.4 38265.2 3299.5 3382.0 3540.4 3639.6 4043.6 29760.6 29778.1 30229.0 30339.5 30484.0 3144.6 3209.4 3231.2 3240.6 3269.0 484958.0 488815.6 489377.0 489619.0 490059.0 55981.4 56143.4 56311.2 56440.7 56453.0 33294.7 34153.5 34397.7 58808.7 59173.7 16278.3 16401.9 16460.4 16497.8 16519.3 12476.0 12624.3 12667.6 12689.3 12711.2 18319.1 18447.9 18503.7 18510.8 18525.5 7743.5 7880.8 7884.2 7919.4 7976.9 840.0 992.6 1002.6 1017.5 1018.2 25603.1 27935.7 29654.6 29963.1 30184.4 949.4 1020.0 1033.8 1045.9 1052.5 12874.3 14205.0 14652.6 15009.9 15194.9 630448.0 667182.0 669213.0 673596.0 678186.0 53887.7 53977.7 54030.2 54393.0 54495.5 1356.2 1368.7 1389.9 1394.0 1397.4 22213.8 24394.8 28091.0 28510.4 28672.1 37165.8 47081.0 47150.8 47152.0 47217.8 573843.0 576460.0 578335.0 581260.0 585944.0 21702.6 21864.9 23231.5 24602.8 26040.5 44542.0 45240.0 45857.5 46245.5 46494.8 37625.0 37670.6 37796.2 38357.6 38607.0 37135.1 37279.6 37647.8 38318.8 38474.8 32449.5 37233.6 37460.6 37474.0 37871.0 32839.0 33820.2 33879.5 33919.8 34143.0 22384.0 24562.9 24801.4 24977.0 25406.4 14:04:58 INFO - PROCESS | 1646 | 14:04:58 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:33538.44 Median:25662.79 stddev:93019.56 (362.5%) stddev-sans-first:93247.13 14:04:58 INFO - PROCESS | 1646 | Values: 351.2 370.4 378.9 382.6 393.5 20084.8 20844.1 22068.0 22097.9 22191.0 11655.0 11932.9 12013.9 12063.5 12126.7 5240.8 5546.9 5559.5 5583.0 5599.5 5263.9 5455.6 5457.5 5498.1 5546.8 5411.8 5483.9 5497.2 5497.8 5513.4 5332.7 5487.6 5974.3 6081.2 6083.1 5336.4 5373.9 5375.4 5382.4 5388.1 24632.0 25265.4 25473.2 25852.4 25914.4 2045.8 2084.9 2312.0 2406.7 2879.9 9983.5 10289.6 10304.8 11708.0 16051.8 1857.2 1919.0 1972.6 2039.4 2056.0 124121.0 125999.0 127393.0 127647.0 128402.0 10945.0 11120.6 11192.0 11428.9 11566.2 14264.7 14291.1 14347.9 14348.7 14381.8 8338.2 8452.4 8570.9 8622.2 8625.6 8309.6 8425.4 8476.6 8626.3 8643.1 4422.6 4457.8 4475.9 4521.1 4558.9 1502.0 1588.3 1612.0 1623.7 1960.8 796.9 814.1 840.0 908.7 967.1 19396.0 21391.3 21441.1 21449.5 21560.1 938.8 953.3 958.7 962.6 980.5 9273.3 9819.6 11280.5 11337.0 11406.6 481225.0 546767.0 570262.0 572902.0 583481.0 129887.0 131926.3 134230.0 135532.0 138113.0 1000.5 1023.1 1028.7 1048.4 1050.7 13157.3 17303.8 18117.6 18902.7 18915.1 41637.0 50361.0 51580.5 52028.5 52088.7 72045.6 72185.6 72227.6 72675.9 73372.9 6456.8 7658.8 7895.8 7978.2 8056.6 9416.8 12637.9 12871.9 13029.7 13083.3 8057.8 9284.4 10028.8 10885.5 11040.5 10581.7 10617.6 10617.9 10780.2 10914.8 11102.3 11170.4 11180.2 11215.6 11415.3 7832.5 8051.8 8087.8 8172.9 8216.0 10467.2 10611.2 10723.6 10927.1 11060.7 14:04:58 INFO - PROCESS | 1646 | 14:04:58 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:5702.13 Median:2575.90 stddev:3216.79 (124.9%) stddev-sans-first:3209.74 14:04:58 INFO - PROCESS | 1646 | Values: 1423.3 1560.2 1766.4 1857.7 1911.8 7966.0 8554.7 8731.7 9095.8 9122.8 8736.7 8796.3 8962.6 8965.7 8971.8 2398.2 2411.0 2427.6 2431.4 2442.4 2398.6 2417.6 2438.4 2439.8 2445.4 2412.1 2415.0 2426.6 2442.8 2444.0 2364.2 2401.2 2416.2 2419.1 2420.7 1982.3 2379.7 2392.7 2402.1 2408.3 8814.9 8898.3 8983.1 8985.1 8995.6 4288.7 4835.1 5000.1 5203.5 5295.3 3352.8 3495.6 3586.8 3654.2 3660.7 1066.2 1107.0 1107.8 1116.1 1778.6 11186.8 11498.9 11501.9 11673.6 11730.5 4669.3 4778.4 4852.9 4897.4 4910.4 9982.8 10020.4 10032.2 10033.5 10054.8 5441.7 5449.9 5465.7 5466.8 5473.3 4471.4 4801.1 4909.5 4946.5 4985.5 3936.7 3979.1 4079.0 4085.5 4148.1 1321.7 1324.4 1331.8 1335.0 1341.8 762.1 780.3 896.9 904.8 946.7 4947.8 5249.9 5778.9 5824.0 5909.7 447.5 455.5 457.0 464.7 467.6 3831.3 3895.8 3992.0 4002.6 4003.8 10470.5 10860.9 10861.8 10867.8 10895.2 10479.8 10530.3 10620.7 10743.0 10743.4 8061.5 8134.4 8196.5 8218.2 8236.3 5682.8 5774.7 5778.8 5784.5 5792.2 9545.9 9908.7 9989.8 10050.9 10086.5 10217.3 10225.8 10242.5 10297.0 10395.3 5609.9 6897.0 7419.8 7527.7 7602.3 8349.0 8359.7 8458.5 8458.7 8466.0 7172.8 7408.2 7540.5 7551.9 7675.2 7356.6 7409.0 7516.5 7517.7 7519.9 6978.4 6985.5 7034.1 7049.4 7052.5 4519.4 4684.2 4968.2 5025.3 5025.8 4105.5 4700.0 4894.0 4998.6 5088.4 14:04:58 INFO - PROCESS | 1646 | 14:04:58 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4521.47 Median:4951.78 stddev:1427.10 (28.8%) stddev-sans-first:1395.47 14:04:58 INFO - PROCESS | 1646 | Values: 299.5 300.6 300.9 312.9 314.1 4311.9 5430.5 5546.8 5614.0 5621.0 5487.4 5565.6 5577.4 5586.2 5601.6 3586.8 3878.0 4030.3 4288.9 4292.7 3452.8 3847.8 4255.7 4280.5 4290.0 3415.7 4085.1 4102.8 4106.6 4116.8 3738.7 4107.6 4119.4 4119.6 4164.0 3332.3 3373.0 3532.0 3566.8 3583.9 4433.9 5045.6 5250.3 5268.5 5321.6 4743.5 4745.0 4750.2 4759.1 4762.9 4823.2 4941.8 5157.7 5699.1 5832.8 3143.1 3541.7 3629.0 3663.6 3954.0 5282.9 5619.6 5722.4 6194.1 6201.5 3960.6 3978.2 3978.6 3978.9 4000.7 3219.3 3990.2 4014.5 4021.4 4030.1 4735.8 4742.6 4765.7 4765.9 4820.0 5412.1 5933.5 5949.1 5953.9 5957.3 1272.2 1297.9 1343.5 1360.9 1374.3 766.5 768.5 924.5 925.6 927.3 4303.1 4474.3 4562.9 4811.7 5119.8 5010.7 5926.2 5946.8 5947.9 5976.6 5162.3 5193.1 5211.5 5394.2 5400.5 2176.6 2272.5 2604.8 2681.8 2683.8 4245.5 4348.9 5221.8 5241.7 5290.4 4537.4 4749.5 4764.6 5208.8 5219.4 4510.0 4584.9 4961.8 5016.7 5211.4 4296.9 4661.8 5037.5 5059.6 5079.3 4638.9 4977.3 5015.6 5409.7 5917.0 5188.7 5295.5 6144.5 6336.0 6345.7 3337.7 3595.7 3901.6 4028.4 4038.1 5305.5 5689.2 6044.9 6072.5 6202.6 5777.3 5904.2 5922.1 5936.2 5952.2 5906.0 5949.6 5958.6 5974.9 5985.3 4747.4 4832.5 5401.0 5685.3 5826.8 5873.9 5902.2 5909.3 5925.6 5958.7 4908.7 5459.4 5772.9 5799.3 5806.8 14:04:58 INFO - PROCESS | 1646 | 14:04:58 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:23529.63 Median:12856.96 stddev:36424.15 (283.3%) stddev-sans-first:36486.01 14:04:58 INFO - PROCESS | 1646 | Values: 705.5 719.8 725.9 765.3 809.4 15097.3 16205.4 16218.2 16221.7 16259.2 14296.9 14676.3 14697.9 14815.7 14933.9 821.4 822.8 850.4 863.2 864.7 685.2 732.9 869.4 871.5 872.8 894.0 900.5 913.2 932.3 932.4 880.6 927.9 928.4 929.9 930.3 677.5 692.7 693.4 696.2 697.8 14972.3 15005.3 15058.8 15064.2 15067.8 14497.6 14517.4 14540.5 14784.1 14876.9 11830.8 11937.2 11979.9 12264.4 12539.6 2976.9 3857.7 4016.7 4017.9 4031.3 117726.4 120916.4 121544.4 121823.0 122017.8 10954.5 11129.9 11438.7 11456.3 11727.0 18960.5 19686.8 20268.5 22023.5 22737.0 7501.9 7713.2 8176.5 8415.7 8427.5 4483.3 4509.6 4541.3 4547.7 4720.4 3581.5 3668.6 3698.1 3714.8 3723.1 662.3 705.2 739.8 745.8 746.6 595.1 607.3 645.0 681.8 684.6 9068.7 9414.4 9596.1 9706.8 9858.2 543.4 604.3 619.4 675.3 690.1 4396.5 4560.0 4596.7 4687.4 4732.5 46497.5 47242.8 121110.0 123663.0 125838.0 90075.1 125101.0 127075.0 127815.0 127990.0 108881.0 109513.5 110900.0 115513.0 116318.4 9672.9 10030.8 10034.7 10057.5 10065.7 59960.0 61159.4 61163.7 63075.7 63341.0 88443.1 91324.0 93901.0 95481.0 97163.0 12760.2 12829.3 12982.2 13178.3 13364.1 14585.5 14644.4 14762.9 14796.7 14896.3 13468.8 13528.0 13726.2 14047.3 14268.7 10995.6 13420.8 13592.3 13645.7 13733.7 13252.7 13306.4 13499.6 13921.3 13980.4 11051.0 11268.7 11274.8 11483.4 11487.9 11168.4 11239.3 11487.8 11499.6 11515.1 14:04:58 INFO - PROCESS | 1646 | -------- Summary: end -------- 14:04:58 INFO - PROCESS | 1646 | 14:04:58 INFO - TEST-INFO | 1646: exit 0 14:04:58 INFO - TEST-OK | dromaeo_css | took 1113975ms 14:04:58 INFO - TEST-START | kraken 14:04:58 INFO - operating with platform_type : mac_ 14:04:58 INFO - Initialising browser for kraken test... 14:04:58 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpUFP4C1/profile http://localhost:49267/getInfo.html) 14:05:01 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 14:05:01 INFO - PROCESS | 1658 | colorDepth:24 14:05:01 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 14:05:01 INFO - PROCESS | 1658 | __metrics 14:05:01 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 14:05:02 INFO - TEST-INFO | 1658: exit 0 14:05:02 INFO - Browser initialized. 14:05:02 INFO - Running cycle 1/1 for kraken test... 14:05:02 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpUFP4C1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:05:14 INFO - PROCESS | 1660 | RSS: Main: 244170752 14:05:14 INFO - PROCESS | 1660 | 14:05:17 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 14:05:18 INFO - PROCESS | 1660 | RSS: Main: 257134592 14:05:18 INFO - PROCESS | 1660 | 14:05:21 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 14:05:22 INFO - PROCESS | 1660 | RSS: Main: 265863168 14:05:22 INFO - PROCESS | 1660 | 14:05:25 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 14:05:26 INFO - PROCESS | 1660 | RSS: Main: 263520256 14:05:26 INFO - PROCESS | 1660 | 14:05:28 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 14:05:28 INFO - PROCESS | 1660 | RSS: Main: 264781824 14:05:28 INFO - PROCESS | 1660 | 14:05:30 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:05:31 INFO - PROCESS | 1660 | RSS: Main: 266465280 14:05:31 INFO - PROCESS | 1660 | 14:05:34 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 14:05:35 INFO - PROCESS | 1660 | RSS: Main: 267022336 14:05:35 INFO - PROCESS | 1660 | 14:05:38 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 14:05:38 INFO - PROCESS | 1660 | RSS: Main: 267542528 14:05:38 INFO - PROCESS | 1660 | 14:05:41 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 14:05:42 INFO - PROCESS | 1660 | RSS: Main: 267378688 14:05:42 INFO - PROCESS | 1660 | 14:05:43 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:05:44 INFO - PROCESS | 1660 | RSS: Main: 267186176 14:05:44 INFO - PROCESS | 1660 | 14:05:46 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:05:47 INFO - PROCESS | 1660 | RSS: Main: 266833920 14:05:47 INFO - PROCESS | 1660 | 14:05:49 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:05:50 INFO - PROCESS | 1660 | RSS: Main: 267247616 14:05:50 INFO - PROCESS | 1660 | 14:05:53 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:05:53 INFO - PROCESS | 1660 | RSS: Main: 267358208 14:05:53 INFO - PROCESS | 1660 | 14:05:56 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:05:57 INFO - PROCESS | 1660 | RSS: Main: 267317248 14:05:57 INFO - PROCESS | 1660 | 14:05:59 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 14:05:59 INFO - PROCESS | 1660 | RSS: Main: 269271040 14:05:59 INFO - PROCESS | 1660 | 14:05:59 INFO - PROCESS | 1660 | __start_tp_report 14:05:59 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 14:05:59 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 14:05:59 INFO - PROCESS | 1660 | |i|pagename|runs| 14:05:59 INFO - PROCESS | 1660 | |0;ai-astar;108;142;171;141;118;117;142;97;116;179 14:05:59 INFO - PROCESS | 1660 | |1;audio-beat-detection;145;111;135;162;132;150;156;147;178;114 14:05:59 INFO - PROCESS | 1660 | |2;audio-dft;216;246;200;202;195;201;190;199;194;202 14:05:59 INFO - PROCESS | 1660 | |3;audio-fft;74;82;77;146;60;58;61;88;157;69 14:05:59 INFO - PROCESS | 1660 | |4;audio-oscillator;58;91;109;71;59;110;105;81;102;108 14:05:59 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;93;89;85;120;92;89;92;79;132;88 14:05:59 INFO - PROCESS | 1660 | |6;imaging-darkroom;104;96;121;150;150;96;96;96;102;149 14:05:59 INFO - PROCESS | 1660 | |7;imaging-desaturate;92;94;101;146;129;91;93;91;109;145 14:05:59 INFO - PROCESS | 1660 | |8;json-parse-financial;58;59;59;57;57;59;59;58;57;57 14:05:59 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;68;69;69;72;108;112;87;72;71;72 14:05:59 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;87;87;111;104;105;91;104;108;79;95 14:05:59 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;159;155;143;139;141;140;141;141;180;137 14:05:59 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;171;175;172;173;182;209;231;208;238;184 14:05:59 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;67;69;69;68;72;69;68;82;90;89 14:05:59 INFO - PROCESS | 1660 | __end_tp_report 14:05:59 INFO - PROCESS | 1660 | __start_cc_report 14:05:59 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,962 14:05:59 INFO - PROCESS | 1660 | __end_cc_report 14:05:59 INFO - PROCESS | 1660 | __startTimestamp1472677559636__endTimestamp 14:05:59 INFO - PROCESS | 1660 | 14:05:59 INFO - PROCESS | 1660 | ------- Summary: start ------- 14:05:59 INFO - PROCESS | 1660 | Number of tests: 14 14:05:59 INFO - PROCESS | 1660 | 14:05:59 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:133.10 Median:142.00 stddev:26.83 (18.9%) stddev-sans-first:26.87 14:05:59 INFO - PROCESS | 1660 | Values: 108.0 142.0 171.0 141.0 118.0 117.0 142.0 97.0 116.0 179.0 14:05:59 INFO - PROCESS | 1660 | 14:05:59 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:148.50 stddev:20.75 (14.0%) stddev-sans-first:21.99 14:05:59 INFO - PROCESS | 1660 | Values: 145.0 111.0 135.0 162.0 132.0 150.0 156.0 147.0 178.0 114.0 14:05:59 INFO - PROCESS | 1660 | 14:05:59 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:204.50 Median:201.50 stddev:16.13 (8.0%) stddev-sans-first:16.56 14:05:59 INFO - PROCESS | 1660 | Values: 216.0 246.0 200.0 202.0 195.0 201.0 190.0 199.0 194.0 202.0 14:05:59 INFO - PROCESS | 1660 | 14:05:59 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:87.20 Median:71.50 stddev:35.35 (49.4%) stddev-sans-first:37.17 14:05:59 INFO - PROCESS | 1660 | Values: 74.0 82.0 77.0 146.0 60.0 58.0 61.0 88.0 157.0 69.0 14:05:59 INFO - PROCESS | 1660 | 14:05:59 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:58.50 stddev:20.76 (35.5%) stddev-sans-first:18.65 14:05:59 INFO - PROCESS | 1660 | Values: 58.0 91.0 109.0 71.0 59.0 110.0 105.0 81.0 102.0 108.0 14:05:59 INFO - PROCESS | 1660 | 14:05:59 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:95.90 Median:89.00 stddev:16.62 (18.7%) stddev-sans-first:17.59 14:05:59 INFO - PROCESS | 1660 | Values: 93.0 89.0 85.0 120.0 92.0 89.0 92.0 79.0 132.0 88.0 14:05:59 INFO - PROCESS | 1660 | 14:05:59 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:116.00 Median:123.00 stddev:24.42 (19.9%) stddev-sans-first:25.51 14:05:59 INFO - PROCESS | 1660 | Values: 104.0 96.0 121.0 150.0 150.0 96.0 96.0 96.0 102.0 149.0 14:05:59 INFO - PROCESS | 1660 | 14:05:59 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:109.10 Median:91.00 stddev:22.48 (24.7%) stddev-sans-first:22.97 14:05:59 INFO - PROCESS | 1660 | Values: 92.0 94.0 101.0 146.0 129.0 91.0 93.0 91.0 109.0 145.0 14:05:59 INFO - PROCESS | 1660 | 14:05:59 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:58.50 stddev:0.94 (1.6%) stddev-sans-first:1.00 14:05:59 INFO - PROCESS | 1660 | Values: 58.0 59.0 59.0 57.0 57.0 59.0 59.0 58.0 57.0 57.0 14:05:59 INFO - PROCESS | 1660 | 14:05:59 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:80.00 Median:71.50 stddev:16.72 (23.4%) stddev-sans-first:17.16 14:05:59 INFO - PROCESS | 1660 | Values: 68.0 69.0 69.0 72.0 108.0 112.0 87.0 72.0 71.0 72.0 14:05:59 INFO - PROCESS | 1660 | 14:05:59 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:97.10 Median:83.00 stddev:10.76 (13.0%) stddev-sans-first:10.78 14:05:59 INFO - PROCESS | 1660 | Values: 87.0 87.0 111.0 104.0 105.0 91.0 104.0 108.0 79.0 95.0 14:05:59 INFO - PROCESS | 1660 | 14:05:59 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:147.60 Median:142.00 stddev:13.46 (9.5%) stddev-sans-first:13.63 14:05:59 INFO - PROCESS | 1660 | Values: 159.0 155.0 143.0 139.0 141.0 140.0 141.0 141.0 180.0 137.0 14:05:59 INFO - PROCESS | 1660 | 14:05:59 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.30 Median:196.00 stddev:25.35 (12.9%) stddev-sans-first:25.45 14:05:59 INFO - PROCESS | 1660 | Values: 171.0 175.0 172.0 173.0 182.0 209.0 231.0 208.0 238.0 184.0 14:05:59 INFO - PROCESS | 1660 | 14:05:59 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.30 Median:70.50 stddev:9.09 (12.9%) stddev-sans-first:9.25 14:05:59 INFO - PROCESS | 1660 | Values: 67.0 69.0 69.0 68.0 72.0 69.0 68.0 82.0 90.0 89.0 14:05:59 INFO - PROCESS | 1660 | -------- Summary: end -------- 14:05:59 INFO - PROCESS | 1660 | 14:06:00 INFO - TEST-INFO | 1660: exit 0 14:06:00 INFO - TEST-OK | kraken | took 61655ms 14:06:00 INFO - SUITE-END | took 1175s 14:06:00 INFO - Completed test suite (00:19:35) 14:06:00 INFO - javascript benchmark 14:06:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7240.260781046365, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3360.5463262459575, 3386.068831071455, 3394.7284217262622, 3407.6762707542775, 3429.931401371972, 5660.433956604337, 5671.007573674606, 5686.289213848264, 5749.770009199627, 5764.51001664859, 5529.225908372831, 5632.3804381518, 5685.317761868581, 5724.169995350671, 5827.125931110325, 5054.595632349412, 5089.847304580869, 5185.662931909433, 5229.058769421503, 5232.92150617741, 4813.796550862285, 5047.545720885119, 5319.308489896308, 5338.412774594811, 5346.224797404393, 4859.465458799529, 5024.522670346311, 5115.923261151086, 5159.2003239497935, 5209.426963034063, 5168.095583272912, 5207.375114986188, 5226.817061402832, 5237.240600113, 5259.526642602184, 5143.7912090658665, 5169.0, 5178.766955487012, 5211.947880521184, 5214.765335559909, 4992.301077849104, 5450.55560276527, 5550.306211723535, 5577.9163312550345, 5825.79609713658, 5970.805838832251, 6117.296510901258, 6119.106526814669, 6156.292026416974, 6171.765646870599, 4567.817287308504, 4955.851324460272, 5065.290859279704, 5148.588112950993, 5363.249145119687, 5588.30146231721, 5818.44724751148, 5823.359430462646, 5845.181674565564, 5858.472737453607, 5124.718140502234, 6107.5833010365195, 6135.661410523283, 6138.294096178907, 6183.96908015457, 6009.2188015557695, 6045.8488537786025, 6048.9697551512845, 6086.0, 6136.110264011693, 6145.231846019247, 6182.28903676074, 6196.0705894116245, 6222.377762223741, 6243.719032643542, 6114.145302971479, 6141.048137538689, 6153.476954458921, 6169.981952977709, 6218.19163508741, 6097.963346231151, 6157.96921015392, 6170.969145154246, 6184.938150618526, 6203.069539569011, 4809.615230781529, 4842.58837998774, 4910.386201724785, 4913.533214344631, 4953.380827396575, 4354.085642015149, 4373.934390984138, 4393.802278897458, 4432.268675668543, 4447.2439685253585, 5795.94204057954, 5843.604648276725, 5860.648361098348, 5863.296404431496, 5921.73352199152, 6134.8159555213415, 6141.232345956755, 6148.077788331697, 6158.7228574714245, 6166.044263139221, 5850.23946886902, 5926.288845338587, 5927.762889484458, 5956.2852457704485, 5964.0, 5341.439148889388, 5372.946270537323, 5389.487998640201, 5415.6479828811, 5440.211169380417, 6076.270847498328, 6143.358355907003, 6246.375362463808, 6260.40526150015, 6265.0602409637095, 5184.196449550326, 6125.019996800491, 6143.389059649542, 6161.537884658579, 6175.5677102602385, 6238.532110091671, 6246.46905013079, 6246.875062498633, 6254.155688981929, 6304.306526282197, 6028.577999540165, 6130.938690613215, 6159.938400615936, 6165.10605962124, 6174.969125154345, 6045.818625441244, 6144.187464697836, 6145.187169785014, 6150.892839288971, 6152.661603611844, 6056.848578785565, 6089.51283897296, 6095.451409373178, 6115.541334400027, 6128.908066378919, 5948.434898684618, 5995.550333725076, 6027.547933904887, 6099.176611157614, 6114.357992410733, 5815.912761308668, 5948.13752005948, 5952.702364881825, 5992.003998001, 6006.489448396936, 6043.244594425697, 6066.514678825595, 6071.483923866344, 6110.541709371726, 6148.0, 5794.565407594531, 5872.148538461814, 5945.435183657545, 5961.731722072604, 5971.253593300838], "value": 5623.159770142399, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [457.90841831633674, 485.80491989705325, 507.441814004595, 545.163174527101, 559.1333433178572, 29557.852210738944, 38324.42513362295, 38445.03887402809, 38467.23065538691, 38537.42193867091, 31834.840825795898, 32943.50584741231, 38165.23669526608, 39413.21173576527, 40049.59950400495, 7922.286994170538, 9667.178289845371, 9677.951610241938, 9689.709308720714, 9710.271729620272, 8118.391120665944, 9558.61765529378, 9590.376625519319, 9668.0, 9693.75765605862, 9645.276604254708, 9654.613815447408, 9687.806243875119, 9704.320697551175, 9726.465044422554, 8246.670133194695, 9697.3696709714, 9700.854487182698, 9707.951460242724, 9715.46564938928, 9558.808823823554, 9601.615935362577, 9607.4715890626, 9634.42193468387, 9653.17947974423, 31360.21599460009, 37689.246215075545, 37941.43087853684, 38199.427008594896, 38265.23469530594, 3299.538064670948, 3382.01917967412, 3540.3981323174867, 3639.636036396366, 4043.575424580406, 29760.55359169614, 29778.10665680033, 30229.0, 30339.544906826417, 30484.0, 3144.638366587849, 3209.4383482890403, 3231.1922019495128, 3240.5787247657654, 3268.950965735516, 484958.0, 488815.5559222217, 489377.0, 489619.0, 490059.0, 55981.44018559844, 56143.43856561464, 56311.155332670045, 56440.717796410754, 56453.0, 33294.66705332964, 34153.487697684555, 34397.656023439944, 58808.705956469945, 59173.70413147907, 16278.26747796352, 16401.917990409973, 16460.42388516396, 16497.752533712002, 16519.33922643105, 12476.0, 12624.305663188428, 12667.619971400873, 12689.302088385042, 12711.237325760483, 18319.084045797925, 18447.907760461112, 18503.722444163348, 18510.81489185091, 18525.536861578297, 7743.4966727162555, 7880.753985114329, 7884.211578842184, 7919.366450683931, 7976.920230797734, 839.9832003359899, 992.6277645882794, 1002.6290272599185, 1017.5014243020867, 1018.2057994763948, 25603.103891364084, 27935.72064279372, 29654.55518167229, 29963.101106966828, 30184.396312073637, 949.368669834566, 1019.9694009179588, 1033.7829055898196, 1045.858809060767, 1052.5474046160225, 12874.27991866135, 14205.0, 14652.633684157769, 15009.924950375178, 15194.936354455082, 630448.0, 667182.0, 669213.0, 673596.0, 678186.0, 53887.73056134694, 53977.73011134919, 54030.18954715682, 54393.0, 54495.45504544904, 1356.2201734002988, 1368.719412520431, 1389.8957578181476, 1393.9512117075853, 1397.4200706706604, 22213.77786222117, 24394.75605243996, 28091.016814411396, 28510.42979140364, 28672.13983580496, 37165.81417092897, 47081.0, 47150.76424617855, 47152.0, 47217.76391118023, 573843.0, 576460.0, 578335.0, 581260.0, 585944.0, 21702.565948681255, 21864.89067554652, 23231.53536929218, 24602.76986150721, 26040.479190416463, 44542.0, 45240.0, 45857.541424585324, 46245.53754462412, 46494.76752616351, 37625.0, 37670.62329376671, 37796.24407511889, 38357.6164238354, 38607.0, 37135.07162320964, 37279.627203727614, 37647.81176094102, 38318.80840595779, 38474.807625961694, 32449.51325730163, 37233.62766372302, 37460.62539374681, 37474.0, 37871.0, 32839.0, 33820.15449613681, 33879.491807623395, 33919.83040084784, 34143.0, 22384.0, 24562.877185613957, 24801.379965501008, 24977.0, 25406.364840879127], "value": 19201.032409919662, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.20276971275206, 370.3777653542048, 378.9298979688756, 382.5676985006942, 393.47078179848114, 20084.799152008476, 20844.062017209224, 22068.0, 22097.889510552446, 22191.001404936775, 11655.0, 11932.940335298312, 12013.879861201385, 12063.51745930164, 12126.69683257919, 5240.842774716755, 5546.91679624806, 5559.499645031946, 5582.972085139569, 5599.468050535193, 5263.868403289929, 5455.645383050109, 5457.481539253785, 5498.120300751881, 5546.805861794838, 5411.783528658849, 5483.945160548404, 5497.175423686439, 5497.835064948058, 5513.421090785449, 5332.720147164691, 5487.6158668893195, 5974.312954010279, 6081.1790408294755, 6083.117947897575, 5336.359636843604, 5373.946260537384, 5375.381831089436, 5382.434844341366, 5388.110961691316, 24632.0, 25265.36836579082, 25473.23580292594, 25852.35369115787, 25914.352141196432, 2045.8158765711157, 2084.8957552122333, 2311.9653205201935, 2406.747291534381, 2879.934424263015, 9983.450910199936, 10289.588416463332, 10304.793904121876, 11708.0, 16051.839481605151, 1857.2106854586746, 1918.980810191894, 1972.556174860645, 2039.377989713137, 2056.0, 124121.0, 125999.0, 127393.0, 127647.0, 128402.0, 10944.975179591802, 11120.610778622871, 11191.992720655016, 11428.885711142948, 11566.248193867372, 14264.714705705828, 14291.071080379743, 14347.92826035863, 14348.713025739427, 14381.7842732357, 8338.24955753985, 8452.408331416742, 8570.871436928452, 8622.223999840044, 8625.627952313038, 8309.626066827008, 8425.368097392597, 8476.576171191417, 8626.309895208493, 8643.135686431306, 4422.601965823092, 4457.799399027052, 4475.888102797456, 4521.073179998092, 4558.88602784933, 1502.0311898825414, 1588.3011474950983, 1611.9516414507584, 1623.7497127212216, 1960.823525882649, 796.8645330293864, 814.1410811593707, 840.0297656207091, 908.7319240823973, 967.0812727908515, 19396.04588333407, 21391.25130620421, 21441.142354305965, 21449.46376340573, 21560.137594496045, 938.7840796616816, 953.3136141977765, 958.6596758150896, 962.5705826847127, 980.4656462228103, 9273.304502162366, 9819.558119884623, 11280.492377843017, 11337.03635191018, 11406.600768973047, 481225.0, 546767.0, 570262.0, 572902.0, 583481.0, 129887.0, 131926.34036829753, 134230.0, 135532.0, 138113.0, 1000.5497526113132, 1023.1047833145997, 1028.6554004408458, 1048.449563978902, 1050.6742909698019, 13157.34213289351, 17303.82696173022, 18117.637647246716, 18902.7164592534, 18915.054247287855, 41637.0, 50361.0, 51580.484195157565, 52028.47971520388, 52088.739556301975, 72045.63977180081, 72185.63907180431, 72227.58293128142, 72675.90986135106, 73372.89347257643, 6456.806295811133, 7658.770236892902, 7895.763127106196, 7978.162292959156, 8056.637451314587, 9416.811663766823, 12637.93681031589, 12871.871281287067, 13029.674258143243, 13083.345832708135, 8057.798555035936, 9284.442933424016, 10028.849567256642, 10885.510152043336, 11040.5031773572, 10581.735456613646, 10617.575296988034, 10617.946910265708, 10780.191485638452, 10914.836277455686, 11102.333859968428, 11170.441477925908, 11180.217384782987, 11215.60745373908, 11415.315081095161, 7832.490888092256, 8051.798705032187, 8087.797805054921, 8172.918270817454, 8216.0, 10467.214958877963, 10611.151107911193, 10723.624673136403, 10927.071198948179, 11060.723481913017], "value": 9258.232120854775, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1423.2527922840507, 1560.1575149419311, 1766.3994241957732, 1857.721341798729, 1911.8183772541613, 7966.0, 8554.743357699272, 8731.738047858575, 9095.818083638324, 9122.771930701727, 8736.694215702451, 8796.340274479408, 8962.596683149257, 8965.686200982967, 8971.82056358874, 2398.2445529658103, 2410.963835542464, 2427.5509030829267, 2431.3678443604613, 2442.3636163770316, 2398.640203969401, 2417.576924038295, 2438.4391589934326, 2439.817013723969, 2445.400876785181, 2412.0834083048417, 2414.9517009659885, 2426.6481360202847, 2442.829001969863, 2443.9755602443925, 2364.2079903232266, 2401.2076014915124, 2416.1905761569897, 2419.14120487228, 2420.7337192908676, 1982.3359174676357, 2379.7263314718857, 2392.6530653055383, 2402.0631953538136, 2408.3497455687043, 8814.86777698335, 8898.288136949028, 8983.10168983103, 8985.146411090936, 8995.595198216097, 4288.742675439484, 4835.105505481462, 5000.0999820032375, 5203.453637368059, 5295.258663787073, 3352.7820691654965, 3495.615482296945, 3586.7847929124073, 3654.214343916071, 3660.68884144848, 1066.2376400873336, 1106.955721771128, 1107.8227483602584, 1116.101538261699, 1778.5820332221917, 11186.832197517044, 11498.942505287503, 11501.942490287578, 11673.649790506299, 11730.472128754227, 4669.279958820845, 4778.354922085544, 4852.927206091911, 4897.3878265216845, 4910.410750709938, 9982.750431239278, 10020.396736522122, 10032.197424206046, 10033.498325083863, 10054.798904021878, 5441.700706461183, 5449.891002180014, 5465.726713664301, 5466.758628962186, 5473.31583552056, 4471.396361491222, 4801.063792560417, 4909.533594308535, 4946.530079642428, 4985.501449854985, 3936.6653834424396, 3979.144483935968, 4078.9592104079175, 4085.4893138357706, 4148.149629325981, 1321.7356528694108, 1324.417256407197, 1331.8335208098988, 1335.0441603051577, 1341.812495941099, 762.0525676993228, 780.3172224303735, 896.8744225996332, 904.7828521155008, 946.6923249943658, 4947.82682606107, 5249.895002099936, 5778.88442231153, 5824.0390335595, 5909.734061967221, 447.5142526811021, 455.5353539389804, 456.9588737013685, 464.6515113664751, 467.61889060415655, 3831.2529056834205, 3895.844166233319, 3992.0, 4002.5597184309704, 4003.7797921114034, 10470.528826202839, 10860.945695271474, 10861.782764344669, 10867.83698244527, 10895.182861285435, 10479.790404192026, 10530.31552949056, 10620.681379558626, 10743.033127018605, 10743.355398676105, 8061.51630902136, 8134.430589858772, 8196.508209507449, 8218.21926916942, 8236.341092712568, 5682.77268909239, 5774.653520788766, 5778.797742079007, 5784.50831679312, 5792.21805056312, 9545.904540954501, 9908.653197138066, 9989.800203996025, 10050.94465081156, 10086.546105425126, 10217.33587316822, 10225.84661230097, 10242.48787560604, 10297.02178293061, 10395.32430392022, 5609.887802244014, 6897.0, 7419.777406677593, 7527.661255243636, 7602.277783610548, 8349.0, 8359.707410240613, 8458.450200736932, 8458.661653533789, 8465.957670211856, 7172.820679483055, 7408.222136675787, 7540.547567145989, 7551.924480755342, 7675.155732869492, 7356.632168391452, 7409.036825212688, 7516.47384683067, 7517.736879209201, 7519.924800752141, 6978.406835419046, 6985.476089293222, 7034.050403195503, 7049.400800931979, 7052.541584796972, 4519.367288579667, 4684.180268452939, 4968.2050871861775, 5025.321581586585, 5025.824096156617, 4105.4662893823615, 4699.976500117615, 4893.975530122327, 4998.550130488274, 5088.363954505687], "value": 4525.707121955023, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.46993820936945, 300.5987007345194, 300.85107871603554, 312.85295910921866, 314.1314266054359, 4311.870643880681, 5430.5384042356445, 5546.833594992152, 5614.0, 5621.044422448178, 5487.368952570456, 5565.554755619551, 5577.44225577442, 5586.24585680933, 5601.551875849932, 3586.7847929124337, 3877.9529527027826, 4030.2544029354517, 4288.949207444172, 4292.7121863441, 3452.7915229669666, 3847.7883716395727, 4255.723283015099, 4280.464941882265, 4290.0, 3415.667889523088, 4085.079168394597, 4102.815373308208, 4106.609872062149, 4116.835326586933, 3738.7009039276927, 4107.568705285947, 4119.404774991766, 4119.567445418218, 4163.97918010411, 3332.266901281714, 3372.9831350843333, 3531.99338188615, 3566.8216589170697, 3583.928321433557, 4433.9113217735785, 5045.571126454256, 5250.264962905197, 5268.473152684739, 5321.627486075976, 4743.501932297094, 4745.0, 4750.216214324632, 4759.095771803346, 4762.880927976828, 4823.2282834746275, 4941.777620007108, 5157.664751791159, 5699.088145896637, 5832.825015249549, 3143.104215298652, 3541.698955588778, 3628.9818550907075, 3663.6336366363416, 3953.960460395388, 5282.894342113136, 5619.578531610146, 5722.370539240722, 6194.1018552310115, 6201.503879689614, 3960.6039396060164, 3978.1844721831953, 3978.6419222270133, 3978.8660231833787, 4000.739951903117, 3219.2917558137174, 3990.20195960809, 4014.538328092307, 4021.3967904814513, 4030.0730831908827, 4735.810567577328, 4742.5731684148595, 4765.690230135099, 4765.928511072337, 4819.95180048195, 5412.105762983003, 5933.516620844789, 5949.077892926603, 5953.940460595425, 5957.344692083867, 1272.2303006681009, 1297.8961683065331, 1343.5297645824078, 1360.9183448993092, 1374.2647683489486, 766.5209244222361, 768.5043147170156, 924.4915296586851, 925.6069615229171, 927.2535608834818, 4303.139372125587, 4474.284114541658, 4562.931556026662, 4811.687240329367, 5119.820806271762, 5010.69935803853, 5926.199963005025, 5946.762129514771, 5947.881042379128, 5976.641401515923, 5162.328897243335, 5193.065248255275, 5211.530962213343, 5394.1929453633475, 5400.486953739389, 2176.6190916589535, 2272.5114100468477, 2604.791616670662, 2681.839089654627, 2683.7718793902345, 4245.469316335458, 4348.891277718019, 5221.791128354823, 5241.68549887008, 5290.418054014055, 4537.410136682211, 4749.453812811571, 4764.595009424169, 5208.791648334024, 5219.399769026534, 4510.015593139008, 4584.862454126315, 4961.776720047678, 5016.724080175552, 5211.400688920823, 4296.914061718686, 4661.762354070133, 5037.5214354636255, 5059.5952323814745, 5079.339685840817, 4638.93041604383, 4977.341653884465, 5015.623828212826, 5409.675419474844, 5916.970415147896, 5188.7405629719115, 5295.470452954673, 6144.477719393902, 6335.968320158369, 6345.682715864096, 3337.6829201225846, 3595.658412450813, 3901.6098390160755, 4028.43601895729, 4038.1318016626565, 5305.522502974751, 5689.175069614966, 6044.879102418015, 6072.514198864169, 6202.627842329294, 5777.32457587295, 5904.202932604044, 5922.111683247547, 5936.209981308778, 5952.226210592596, 5905.970470147794, 5949.6430214187285, 5958.6424814511265, 5974.940250597612, 5985.25184351956, 4747.409617778083, 4832.540908613676, 5400.972995134999, 5685.299482745828, 5826.7763769608855, 5873.911891321719, 5902.199829052181, 5909.261342332208, 5925.614835035709, 5958.672273025025, 4908.730019848943, 5459.372172200247, 5772.921748170739, 5799.2750906136735, 5806.767729290781], "value": 4066.852172042314, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.5484489926446, 719.7804669575777, 725.9092613423322, 765.334159281425, 809.3686924199123, 15097.320620572073, 16205.351785928564, 16218.189090545455, 16221.675566488693, 16259.187040647965, 14296.857031429683, 14676.26618669065, 14697.926510367433, 14815.703685926275, 14933.925330373333, 821.3716506872247, 822.7696245051395, 850.3792231670868, 863.1886027134505, 864.723288547665, 685.2017399729309, 732.8534293141394, 869.3740506835069, 871.4684042733927, 872.821071680304, 893.9553022348889, 900.5137225898008, 913.2328843771231, 932.2961164320963, 932.4172392254841, 880.5773228850123, 927.8561822917391, 928.4382948316239, 929.8791157149561, 930.2836815651978, 677.4648028057828, 692.6952141057918, 693.4175292754061, 696.2202333386639, 697.7557854750847, 14972.326245318987, 15005.324760385809, 15058.774118388234, 15064.171470569114, 15067.773983390258, 14497.637559061002, 14517.419303227858, 14540.491082812157, 14784.112953222733, 14876.851231487655, 11830.822537661941, 11937.164398492108, 11979.94010029953, 12264.38678066093, 12539.56111536101, 2976.9106926792233, 3857.7492462989817, 4016.6585840203616, 4017.8995525111814, 4031.3348297530874, 117726.41136794347, 120916.39541802322, 121544.39227803893, 121823.0, 122017.77982220153, 10954.507047182897, 11129.888701112885, 11438.714032149097, 11456.255343402652, 11727.0, 18960.52598685044, 19686.803131968783, 20268.493287667927, 22023.45835791511, 22737.0, 7501.924980750123, 7713.19011503784, 8176.509409435453, 8415.663373465115, 8427.536485493234, 4483.30508771141, 4509.616682582017, 4541.250693635579, 4547.7498737569085, 4720.386349774507, 3581.516495273157, 3668.5781135169796, 3698.130939229279, 3714.832832522489, 3723.087843478311, 662.3442791636245, 705.1679018757812, 739.752183018684, 745.8060904164847, 746.5707218349362, 595.1311085814673, 607.3410349770548, 644.9903251451232, 681.8329509270161, 684.5995092870727, 9068.682596109236, 9414.419136329387, 9596.088371604686, 9706.805863882682, 9858.162056225157, 543.4103997163044, 604.3291945940003, 619.3527763487167, 675.3314218923329, 690.0994202565699, 4396.494403143615, 4560.0, 4596.678232523691, 4687.414073240845, 4732.455767586703, 46497.535024649995, 47242.76378618085, 121110.0, 123663.0, 125838.0, 90075.09924900798, 125101.0, 127075.0, 127815.0, 127990.0, 108881.0, 109513.45243273892, 110900.0, 115513.0, 116318.4184079091, 9672.903270967481, 10030.849537256801, 10034.749131271778, 10057.49712514386, 10065.69802905914, 59960.0, 61159.388406115366, 61163.69418152881, 63075.6846215766, 63341.0, 88443.11556884348, 91324.0, 93901.0, 95481.0, 97163.0, 12760.220310291936, 12829.294388808705, 12982.221066736027, 13178.275194864374, 13364.064515483822, 14585.489507867174, 14644.414223430944, 14762.926185369004, 14796.704065918837, 14896.329665164876, 13468.769402707067, 13528.0, 13726.22267381915, 14047.297635117999, 14268.714625707635, 10995.615153469591, 13420.798688019493, 13592.300787872586, 13645.727085458433, 13733.656658583615, 13252.668683282995, 13306.40121194568, 13499.595012149652, 13921.303934803016, 13980.370883310072, 11051.0, 11268.71788720281, 11274.84304394738, 11483.425828708698, 11487.885121149016, 11168.441577920908, 11239.269447485887, 11487.770244594894, 11499.597514086967, 11515.136364772843], "value": 7828.927674647899, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1629.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 142.0, 171.0, 141.0, 118.0, 117.0, 142.0, 97.0, 116.0, 179.0], "value": 133.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 111.0, 135.0, 162.0, 132.0, 150.0, 156.0, 147.0, 178.0, 114.0], "value": 143.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [216.0, 246.0, 200.0, 202.0, 195.0, 201.0, 190.0, 199.0, 194.0, 202.0], "value": 204.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 82.0, 77.0, 146.0, 60.0, 58.0, 61.0, 88.0, 157.0, 69.0], "value": 87.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 91.0, 109.0, 71.0, 59.0, 110.0, 105.0, 81.0, 102.0, 108.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 89.0, 85.0, 120.0, 92.0, 89.0, 92.0, 79.0, 132.0, 88.0], "value": 95.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 96.0, 121.0, 150.0, 150.0, 96.0, 96.0, 96.0, 102.0, 149.0], "value": 116.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 101.0, 146.0, 129.0, 91.0, 93.0, 91.0, 109.0, 145.0], "value": 109.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 57.0, 57.0, 59.0, 59.0, 58.0, 57.0, 57.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 72.0, 108.0, 112.0, 87.0, 72.0, 71.0, 72.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 111.0, 104.0, 105.0, 91.0, 104.0, 108.0, 79.0, 95.0], "value": 97.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 155.0, 143.0, 139.0, 141.0, 140.0, 141.0, 141.0, 180.0, 137.0], "value": 147.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 175.0, 172.0, 173.0, 182.0, 209.0, 231.0, 208.0, 238.0, 184.0], "value": 194.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 69.0, 68.0, 72.0, 69.0, 68.0, 82.0, 90.0, 89.0], "value": 74.3, "unit": "score"}]}]} 14:06:00 INFO - Return code: 0 14:06:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:06:00 ERROR - # TBPL SUCCESS # 14:06:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:06:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:06:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:06:00 INFO - 2016-08-31 14:06:00.945 screenresolution[1665:10433] starting screenresolution argv=screenresolution get 14:06:00 INFO - 2016-08-31 14:06:00.947 screenresolution[1665:10433] Display 0: 1600x1200x32@60 14:06:00 INFO - 2016-08-31 14:06:00.953 screenresolution[1666:10436] starting screenresolution argv=screenresolution list 14:06:00 INFO - Available Modes on Display 0 14:06:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:06:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:06:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:06:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:06:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:06:01 INFO - Intel Iris: 14:06:01 INFO - Chipset Model: Intel Iris 14:06:01 INFO - Type: GPU 14:06:01 INFO - Bus: Built-In 14:06:01 INFO - VRAM (Dynamic, Max): 1536 MB 14:06:01 INFO - Vendor: Intel (0x8086) 14:06:01 INFO - Device ID: 0x0a2e 14:06:01 INFO - Revision ID: 0x0009 14:06:01 INFO - Displays: 14:06:01 INFO - Display: 14:06:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:06:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:06:01 INFO - Display Serial Number: 1600x1200 60 14:06:01 INFO - Main Display: Yes 14:06:01 INFO - Mirror: Off 14:06:01 INFO - Online: Yes 14:06:01 INFO - Rotation: Supported 14:06:01 INFO - Return code: 0 14:06:01 INFO - Running post-action listener: _resource_record_post_action 14:06:01 INFO - [mozharness: 2016-08-31 21:06:01.187427Z] Finished run-tests step (success) 14:06:01 INFO - Running post-run listener: _resource_record_post_run 14:06:01 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 38388736; Write bytes: 708421120; Read time: 401; Write time: 2184 14:06:01 INFO - TinderboxPrint: CPU usage
54.6% 14:06:01 INFO - TinderboxPrint: I/O read bytes / time
38,388,736 / 401 14:06:01 INFO - TinderboxPrint: I/O write bytes / time
708,421,120 / 2,184 14:06:01 INFO - TinderboxPrint: CPU idle
2,201.1 (45.4%) 14:06:01 INFO - TinderboxPrint: CPU system
980.4 (20.2%) 14:06:01 INFO - TinderboxPrint: CPU user
1,664.2 (34.3%) 14:06:01 INFO - TinderboxPrint: Swap in / out
444,727,296 / 0 14:06:01 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 394656256; Write bytes: 389109760; Read time: 29406; Write time: 742 14:06:01 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 36578304; Write bytes: 298532352; Read time: 382; Write time: 1403 14:06:01 INFO - Running post-run listener: _upload_blobber_files 14:06:01 INFO - Blob upload gear active. 14:06:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:06:01 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 14:06:01 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'] 14:06:01 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 14:06:02 INFO - (blobuploader) - INFO - Open directory for files ... 14:06:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:06:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:06:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:06:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:06:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:06:02 INFO - (blobuploader) - INFO - Done attempting. 14:06:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:06:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:06:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:06:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:06:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:06:03 INFO - (blobuploader) - INFO - Done attempting. 14:06:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:06:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:06:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:06:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:06:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:06:06 INFO - (blobuploader) - INFO - Done attempting. 14:06:06 INFO - (blobuploader) - INFO - Iteration through files over. 14:06:06 INFO - Return code: 0 14:06:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:06:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:06:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d73ce74df3f0bb65407df63ecdbdc2a65b45e51fb1aef6927588dae9e6e507ee59e6ff57b80cf7d811b0186f9bf56ca42ca689237c1b11de43c345d73946186", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac4515fc8fbd11bd2faa0438b1f9112189926a153956e82c20d19af2acec9b1af2ac0f3b7e4207012af6e1d79c6ca0ee08cda7c814331b69008262d5c8c913be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7efa6f631a90ad73ccb049f75800ff8ff3b1d2b0e831d81286f6d6b30d6d40ad5ce493e7bb23a68b33eb4909ec5747579f8d6c0ce8b808bf886ee6215eb074bf"} 14:06:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:06:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:06:06 INFO - Contents: 14:06:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d73ce74df3f0bb65407df63ecdbdc2a65b45e51fb1aef6927588dae9e6e507ee59e6ff57b80cf7d811b0186f9bf56ca42ca689237c1b11de43c345d73946186", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac4515fc8fbd11bd2faa0438b1f9112189926a153956e82c20d19af2acec9b1af2ac0f3b7e4207012af6e1d79c6ca0ee08cda7c814331b69008262d5c8c913be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7efa6f631a90ad73ccb049f75800ff8ff3b1d2b0e831d81286f6d6b30d6d40ad5ce493e7bb23a68b33eb4909ec5747579f8d6c0ce8b808bf886ee6215eb074bf"} 14:06:06 INFO - Running post-run listener: copy_logs_to_upload_dir 14:06:06 INFO - Copying logs to upload dir... 14:06:06 INFO - mkdir: /builds/slave/test/build/upload/logs 14:06:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.367409 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-31 14:06:06.319334) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 14:06:06.324138) ========= 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.ctdsr4I433/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.fvTrk6wD4a/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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/1d73ce74df3f0bb65407df63ecdbdc2a65b45e51fb1aef6927588dae9e6e507ee59e6ff57b80cf7d811b0186f9bf56ca42ca689237c1b11de43c345d73946186", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac4515fc8fbd11bd2faa0438b1f9112189926a153956e82c20d19af2acec9b1af2ac0f3b7e4207012af6e1d79c6ca0ee08cda7c814331b69008262d5c8c913be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7efa6f631a90ad73ccb049f75800ff8ff3b1d2b0e831d81286f6d6b30d6d40ad5ce493e7bb23a68b33eb4909ec5747579f8d6c0ce8b808bf886ee6215eb074bf"} build_url:https://queue.taskcluster.net/v1/task/MXrpaP-tRTWIWlJDGZ1mBw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011084 build_url: 'https://queue.taskcluster.net/v1/task/MXrpaP-tRTWIWlJDGZ1mBw/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/1d73ce74df3f0bb65407df63ecdbdc2a65b45e51fb1aef6927588dae9e6e507ee59e6ff57b80cf7d811b0186f9bf56ca42ca689237c1b11de43c345d73946186", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac4515fc8fbd11bd2faa0438b1f9112189926a153956e82c20d19af2acec9b1af2ac0f3b7e4207012af6e1d79c6ca0ee08cda7c814331b69008262d5c8c913be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7efa6f631a90ad73ccb049f75800ff8ff3b1d2b0e831d81286f6d6b30d6d40ad5ce493e7bb23a68b33eb4909ec5747579f8d6c0ce8b808bf886ee6215eb074bf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 14:06:06.357065) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 14:06:06.357431) ========= 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.ctdsr4I433/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.fvTrk6wD4a/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.005235 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 14:06:06.407039) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 14:06:06.407384) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 14:06:06.407764) ========= ========= Total master_lag: 0.18 =========