builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0328 starttime: 1470437576.74 results: success (0) buildid: 20160805133321 builduid: 6071a390e3014922a92793306bffd4c5 revision: 43f25602dac0aed6aafd8cfc9f9d45b2d047e791 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 15:52:56.741037) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 15:52:56.741468) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 15:52:56.741757) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 15:52:56.769352) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 15:52:56.769722) ========= 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.qX8LY5qEds/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.PnKL3i0mmr/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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-05 15:52:56-- 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% 18.9M=0.001s 2016-08-05 15:52:56 (18.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127492 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 15:52:56.919512) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 15:52:56.921161) ========= 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.qX8LY5qEds/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.PnKL3i0mmr/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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.025872 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 15:52:56.969498) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 15:52:56.969971) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 43f25602dac0aed6aafd8cfc9f9d45b2d047e791 --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 43f25602dac0aed6aafd8cfc9f9d45b2d047e791 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qX8LY5qEds/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.PnKL3i0mmr/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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-05 15:52:57,053 truncating revision to first 12 chars 2016-08-05 15:52:57,053 Setting DEBUG logging. 2016-08-05 15:52:57,053 attempt 1/10 2016-08-05 15:52:57,053 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/43f25602dac0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-05 15:52:57,887 unpacking tar archive at: mozilla-central-43f25602dac0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.114519 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 15:52:58.107674) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 15:52:58.108035) ========= script_repo_revision: 43f25602dac0aed6aafd8cfc9f9d45b2d047e791 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 15:52:58.108458) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 15:52:58.108740) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 15:52:58.126962) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-05 15:52:58.127347) ========= /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.qX8LY5qEds/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.PnKL3i0mmr/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 15:52:58 INFO - MultiFileLogger online at 20160805 15:52:58 in /builds/slave/test 15:52:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:52:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:52:58 INFO - {'append_to_log': False, 15:52:58 INFO - 'base_work_dir': '/builds/slave/test', 15:52:58 INFO - 'blob_upload_branch': 'Firefox', 15:52:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:52:58 INFO - 'branch': 'Firefox', 15:52:58 INFO - 'buildbot_json_path': 'buildprops.json', 15:52:58 INFO - 'config_files': ('talos/mac_config.py',), 15:52:58 INFO - 'default_actions': ('clobber', 15:52:58 INFO - 'read-buildbot-config', 15:52:58 INFO - 'download-and-extract', 15:52:58 INFO - 'populate-webroot', 15:52:58 INFO - 'create-virtualenv', 15:52:58 INFO - 'install', 15:52:58 INFO - 'run-tests'), 15:52:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:52:58 INFO - 'download_minidump_stackwalk': True, 15:52:58 INFO - 'download_symbols': 'ondemand', 15:52:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:52:58 INFO - 'tooltool.py': '/tools/tooltool.py', 15:52:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:52:58 INFO - '/tools/misc-python/virtualenv.py')}, 15:52:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:52:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:52:58 INFO - 'installer_path': 'installer.exe', 15:52:58 INFO - 'log_level': 'info', 15:52:58 INFO - 'log_name': 'talos', 15:52:58 INFO - 'log_to_console': True, 15:52:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:52:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:52:58 INFO - 'opt_config_files': (), 15:52:58 INFO - 'pip_index': False, 15:52:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:52:58 INFO - 'cmd': ('bash', 15:52:58 INFO - '-c', 15:52:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:52:58 INFO - 'enabled': True, 15:52:58 INFO - 'halt_on_failure': False, 15:52:58 INFO - 'name': 'check_screen_resolution'},), 15:52:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:52:58 INFO - 'cmd': ('bash', 15:52:58 INFO - '-c', 15:52:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:52:58 INFO - 'enabled': True, 15:52:58 INFO - 'halt_on_failure': False, 15:52:58 INFO - 'name': 'check_screen_resolution'},), 15:52:58 INFO - 'run_cmd_checks_enabled': True, 15:52:58 INFO - 'sps_profile': False, 15:52:58 INFO - 'sps_profile_interval': 0, 15:52:58 INFO - 'suite': 'dromaeojs-e10s', 15:52:58 INFO - 'system_bits': '32', 15:52:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:52:58 INFO - 'title': 't-yosemite-r7-0328', 15:52:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:52:58 INFO - 'use_talos_json': True, 15:52:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:52:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:52:58 INFO - 'work_dir': 'build'} 15:52:58 INFO - [mozharness: 2016-08-05 22:52:58.324972Z] Running clobber step. 15:52:58 INFO - Running pre-action listener: _resource_record_pre_action 15:52:58 INFO - Running main action method: clobber 15:52:58 INFO - rmtree: /builds/slave/test/build 15:52:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:53:00 INFO - Running post-action listener: _resource_record_post_action 15:53:00 INFO - [mozharness: 2016-08-05 22:53:00.368274Z] Finished clobber step (success) 15:53:00 INFO - [mozharness: 2016-08-05 22:53:00.368429Z] Running read-buildbot-config step. 15:53:00 INFO - Running pre-action listener: _resource_record_pre_action 15:53:00 INFO - Running main action method: read_buildbot_config 15:53:00 INFO - Using buildbot properties: 15:53:00 INFO - { 15:53:00 INFO - "project": "", 15:53:00 INFO - "product": "firefox", 15:53:00 INFO - "script_repo_revision": "production", 15:53:00 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 15:53:00 INFO - "repository": "", 15:53:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 15:53:00 INFO - "buildid": "20160805133321", 15:53:00 INFO - "pgo_build": "False", 15:53:00 INFO - "basedir": "/builds/slave/test", 15:53:00 INFO - "buildnumber": 8, 15:53:00 INFO - "slavename": "t-yosemite-r7-0328", 15:53:00 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 15:53:00 INFO - "platform": "yosemite_r7", 15:53:00 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:53:00 INFO - "branch": "mozilla-central", 15:53:00 INFO - "repo_path": "mozilla-central", 15:53:00 INFO - "revision": "43f25602dac0aed6aafd8cfc9f9d45b2d047e791", 15:53:00 INFO - "stage_platform": "macosx64", 15:53:00 INFO - "builduid": "6071a390e3014922a92793306bffd4c5", 15:53:00 INFO - "slavebuilddir": "test" 15:53:00 INFO - } 15:53:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 15:53:00 INFO - Running post-action listener: _resource_record_post_action 15:53:00 INFO - [mozharness: 2016-08-05 22:53:00.371780Z] Finished read-buildbot-config step (success) 15:53:00 INFO - [mozharness: 2016-08-05 22:53:00.371878Z] Running download-and-extract step. 15:53:00 INFO - Running pre-action listener: _resource_record_pre_action 15:53:00 INFO - Running main action method: download_and_extract 15:53:00 INFO - mkdir: /builds/slave/test/build/tests 15:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:00 INFO - trying https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 15:53:00 INFO - Downloading https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 15:53:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 15:53:01 INFO - Downloaded 1199 bytes. 15:53:01 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 15:53:01 INFO - Using the following test package requirements: 15:53:01 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 15:53:01 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:53:01 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 15:53:01 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:53:01 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 15:53:01 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:53:01 INFO - u'jsshell-mac.zip'], 15:53:01 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:53:01 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 15:53:01 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 15:53:01 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:53:01 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 15:53:01 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:53:01 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 15:53:01 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:53:01 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 15:53:01 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:53:01 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 15:53:01 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:01 INFO - trying https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 15:53:01 INFO - Downloading https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 15:53:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:53:02 INFO - Downloaded 16321041 bytes. 15:53:02 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 15:53:09 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:53:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:09 INFO - trying https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 15:53:09 INFO - Downloading https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 15:53:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:53:10 INFO - Downloaded 16321041 bytes. 15:53:10 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 15:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:17 INFO - trying https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 15:53:17 INFO - Downloading https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 15:53:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:53:18 INFO - Downloaded 14413723 bytes. 15:53:18 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 15:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:18 INFO - trying https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 15:53:18 INFO - Downloading https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 15:53:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 15:53:22 INFO - Downloaded 111875700 bytes. 15:53:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 15:53:22 INFO - mkdir: /builds/slave/test/properties 15:53:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:53:22 INFO - Writing to file /builds/slave/test/properties/build_url 15:53:22 INFO - Contents: 15:53:22 INFO - build_url:https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 15:53:23 INFO - Running post-action listener: _resource_record_post_action 15:53:23 INFO - Running post-action listener: set_extra_try_arguments 15:53:23 INFO - [mozharness: 2016-08-05 22:53:23.772574Z] Finished download-and-extract step (success) 15:53:23 INFO - [mozharness: 2016-08-05 22:53:23.772706Z] Running populate-webroot step. 15:53:23 INFO - Running pre-action listener: _resource_record_pre_action 15:53:23 INFO - Running main action method: populate_webroot 15:53:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:53:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:53:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:53:23 INFO - '--tppagecycles', 15:53:23 INFO - '7'], 15:53:23 INFO - 'tests': ['tsvgm']}}, 15:53:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:53:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:53:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:53:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:53:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:53:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:53:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:23 INFO - 'talos_options': ['--disable-e10s'], 15:53:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:53:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:53:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:23 INFO - 'talos_options': ['--disable-e10s'], 15:53:23 INFO - 'tests': ['damp', 'tps']}, 15:53:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:23 INFO - 'tests': ['damp', 'tps']}, 15:53:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:53:23 INFO - 'tests': ['dromaeo_dom']}, 15:53:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:53:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:53:23 INFO - 'tests': ['basic_compositor_video']}, 15:53:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:53:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:53:23 INFO - 'tests': ['a11yr', 15:53:23 INFO - 'ts_paint', 15:53:23 INFO - 'tpaint', 15:53:23 INFO - 'sessionrestore', 15:53:23 INFO - 'sessionrestore_no_auto_restore', 15:53:23 INFO - 'tabpaint']}, 15:53:23 INFO - 'other-e10s': {'tests': ['a11yr', 15:53:23 INFO - 'ts_paint', 15:53:23 INFO - 'tpaint', 15:53:23 INFO - 'sessionrestore', 15:53:23 INFO - 'sessionrestore_no_auto_restore', 15:53:23 INFO - 'tabpaint']}, 15:53:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:53:23 INFO - 'ts_paint', 15:53:23 INFO - 'tpaint', 15:53:23 INFO - 'sessionrestore', 15:53:23 INFO - 'sessionrestore_no_auto_restore', 15:53:23 INFO - 'tabpaint']}, 15:53:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:53:23 INFO - 'ts_paint', 15:53:23 INFO - 'tpaint', 15:53:23 INFO - 'sessionrestore', 15:53:23 INFO - 'sessionrestore_no_auto_restore', 15:53:23 INFO - 'tabpaint']}, 15:53:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:53:23 INFO - 'tests': ['a11yr', 15:53:23 INFO - 'ts_paint', 15:53:23 INFO - 'tpaint', 15:53:23 INFO - 'sessionrestore', 15:53:23 INFO - 'sessionrestore_no_auto_restore', 15:53:23 INFO - 'tabpaint']}, 15:53:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:53:23 INFO - 'tests': ['a11yr', 15:53:23 INFO - 'ts_paint', 15:53:23 INFO - 'tpaint', 15:53:23 INFO - 'sessionrestore', 15:53:23 INFO - 'sessionrestore_no_auto_restore', 15:53:23 INFO - 'tabpaint']}, 15:53:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:53:23 INFO - 'tests': ['tsvgx', 15:53:23 INFO - 'tsvgr_opacity', 15:53:23 INFO - 'tart', 15:53:23 INFO - 'tscrollx', 15:53:23 INFO - 'cart']}, 15:53:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:53:23 INFO - 'tsvgr_opacity', 15:53:23 INFO - 'tart', 15:53:23 INFO - 'tscrollx', 15:53:23 INFO - 'cart']}, 15:53:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:23 INFO - 'talos_options': ['--disable-e10s'], 15:53:23 INFO - 'tests': ['tp5o']}, 15:53:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:23 INFO - 'tests': ['tp5o']}, 15:53:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:23 INFO - 'talos_options': ['--disable-e10s', 15:53:23 INFO - '--xperf_path', 15:53:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:53:23 INFO - 'tests': ['tp5n']}, 15:53:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:23 INFO - 'talos_options': ['--xperf_path', 15:53:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:53:23 INFO - 'tests': ['tp5n']}}, 15:53:23 INFO - 'talos.zip': {'path': '', 15:53:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:53:23 INFO - Running post-action listener: _resource_record_post_action 15:53:23 INFO - [mozharness: 2016-08-05 22:53:23.791874Z] Finished populate-webroot step (success) 15:53:23 INFO - [mozharness: 2016-08-05 22:53:23.792001Z] Running create-virtualenv step. 15:53:23 INFO - Running pre-action listener: _resource_record_pre_action 15:53:23 INFO - Running main action method: create_virtualenv 15:53:23 INFO - Creating virtualenv /builds/slave/test/build/venv 15:53:23 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:53:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:53:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:53:23 INFO - Using real prefix '/tools/python27' 15:53:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:53:24 INFO - Installing distribute.............................................................................................................................................................................................done. 15:53:27 INFO - Installing pip.................done. 15:53:27 INFO - Return code: 0 15:53:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:27 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 0x104ff3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105088618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff502c904e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f57d30>, '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 0x104cbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f4fb20>, '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.qX8LY5qEds/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.PnKL3i0mmr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:53:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:53:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX8LY5qEds/Render', 15:53:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:27 INFO - 'HOME': '/Users/cltbld', 15:53:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:27 INFO - 'LOGNAME': 'cltbld', 15:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:27 INFO - 'MOZ_NO_REMOTE': '1', 15:53:27 INFO - 'NO_EM_RESTART': '1', 15:53:27 INFO - 'PAGER': '/bin/cat', 15:53:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:27 INFO - 'PWD': '/builds/slave/test', 15:53:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:27 INFO - 'SHELL': '/bin/bash', 15:53:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PnKL3i0mmr/Listeners', 15:53:27 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 15:53:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:27 INFO - 'USER': 'cltbld', 15:53:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:27 INFO - 'XPC_FLAGS': '0x0', 15:53:27 INFO - 'XPC_SERVICE_NAME': '0', 15:53:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:53:27 INFO - Cleaning up... 15:53:27 INFO - Return code: 0 15:53:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:27 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 0x104ff3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105088618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff502c904e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f57d30>, '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 0x104cbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f4fb20>, '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.qX8LY5qEds/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.PnKL3i0mmr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:53:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:53:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX8LY5qEds/Render', 15:53:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:27 INFO - 'HOME': '/Users/cltbld', 15:53:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:27 INFO - 'LOGNAME': 'cltbld', 15:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:27 INFO - 'MOZ_NO_REMOTE': '1', 15:53:27 INFO - 'NO_EM_RESTART': '1', 15:53:27 INFO - 'PAGER': '/bin/cat', 15:53:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:27 INFO - 'PWD': '/builds/slave/test', 15:53:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:27 INFO - 'SHELL': '/bin/bash', 15:53:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PnKL3i0mmr/Listeners', 15:53:27 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 15:53:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:27 INFO - 'USER': 'cltbld', 15:53:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:27 INFO - 'XPC_FLAGS': '0x0', 15:53:27 INFO - 'XPC_SERVICE_NAME': '0', 15:53:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:28 INFO - Downloading/unpacking psutil>=3.1.1 15:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:53:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:30 INFO - Installing collected packages: psutil 15:53:30 INFO - Running setup.py install for psutil 15:53:31 INFO - building 'psutil._psutil_osx' extension 15:53:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 15:53:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:53:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:53:31 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 15:53:31 INFO - building 'psutil._psutil_posix' extension 15:53:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 15:53:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:53:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:53:31 INFO - ^ 15:53:31 INFO - 1 warning generated. 15:53:31 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 15:53:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:32 INFO - Successfully installed psutil 15:53:32 INFO - Cleaning up... 15:53:32 INFO - Return code: 0 15:53:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:32 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 0x104ff3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105088618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff502c904e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f57d30>, '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 0x104cbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f4fb20>, '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.qX8LY5qEds/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.PnKL3i0mmr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:53:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:53:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:53:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX8LY5qEds/Render', 15:53:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:32 INFO - 'HOME': '/Users/cltbld', 15:53:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:32 INFO - 'LOGNAME': 'cltbld', 15:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:32 INFO - 'MOZ_NO_REMOTE': '1', 15:53:32 INFO - 'NO_EM_RESTART': '1', 15:53:32 INFO - 'PAGER': '/bin/cat', 15:53:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:32 INFO - 'PWD': '/builds/slave/test', 15:53:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:32 INFO - 'SHELL': '/bin/bash', 15:53:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PnKL3i0mmr/Listeners', 15:53:32 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 15:53:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:32 INFO - 'USER': 'cltbld', 15:53:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:32 INFO - 'XPC_FLAGS': '0x0', 15:53:32 INFO - 'XPC_SERVICE_NAME': '0', 15:53:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:53: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 15:53: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 15:53: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 15:53: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 15:53: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 15:53: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 15:53:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:53:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:53:34 INFO - Installing collected packages: mozsystemmonitor 15:53:34 INFO - Running setup.py install for mozsystemmonitor 15:53:35 INFO - Successfully installed mozsystemmonitor 15:53:35 INFO - Cleaning up... 15:53:35 INFO - Return code: 0 15:53:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:35 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 0x104ff3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105088618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff502c904e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f57d30>, '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 0x104cbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f4fb20>, '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.qX8LY5qEds/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.PnKL3i0mmr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:53:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:53:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:53:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX8LY5qEds/Render', 15:53:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:35 INFO - 'HOME': '/Users/cltbld', 15:53:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:35 INFO - 'LOGNAME': 'cltbld', 15:53:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:35 INFO - 'MOZ_NO_REMOTE': '1', 15:53:35 INFO - 'NO_EM_RESTART': '1', 15:53:35 INFO - 'PAGER': '/bin/cat', 15:53:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:35 INFO - 'PWD': '/builds/slave/test', 15:53:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:35 INFO - 'SHELL': '/bin/bash', 15:53:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PnKL3i0mmr/Listeners', 15:53:35 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 15:53:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:35 INFO - 'USER': 'cltbld', 15:53:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:35 INFO - 'XPC_FLAGS': '0x0', 15:53:35 INFO - 'XPC_SERVICE_NAME': '0', 15:53:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:35 INFO - Downloading/unpacking jsonschema==2.5.1 15:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:53:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:38 INFO - Downloading functools32-3.2.3-2.tar.gz 15:53:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:53:38 INFO - warning: no files found matching '*.txt' 15:53:38 INFO - no previously-included directories found matching 'build' 15:53:38 INFO - no previously-included directories found matching 'dist' 15:53:38 INFO - no previously-included directories found matching '.git*' 15:53:38 INFO - Installing collected packages: jsonschema, functools32 15:53:38 INFO - Running setup.py install for functools32 15:53:38 INFO - warning: no files found matching '*.txt' 15:53:38 INFO - no previously-included directories found matching 'build' 15:53:38 INFO - no previously-included directories found matching 'dist' 15:53:38 INFO - no previously-included directories found matching '.git*' 15:53:38 INFO - Successfully installed jsonschema functools32 15:53:38 INFO - Cleaning up... 15:53:38 INFO - Return code: 0 15:53:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:53: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')]} 15:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53: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')]} 15:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:38 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 0x104ff3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105088618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff502c904e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f57d30>, '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 0x104cbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f4fb20>, '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.qX8LY5qEds/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.PnKL3i0mmr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:53:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:53:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:53:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX8LY5qEds/Render', 15:53:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:38 INFO - 'HOME': '/Users/cltbld', 15:53:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:38 INFO - 'LOGNAME': 'cltbld', 15:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:38 INFO - 'MOZ_NO_REMOTE': '1', 15:53:38 INFO - 'NO_EM_RESTART': '1', 15:53:38 INFO - 'PAGER': '/bin/cat', 15:53:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:38 INFO - 'PWD': '/builds/slave/test', 15:53:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:38 INFO - 'SHELL': '/bin/bash', 15:53:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PnKL3i0mmr/Listeners', 15:53:38 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 15:53:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:38 INFO - 'USER': 'cltbld', 15:53:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:38 INFO - 'XPC_FLAGS': '0x0', 15:53:38 INFO - 'XPC_SERVICE_NAME': '0', 15:53:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:53:38 INFO - Cleaning up... 15:53:38 INFO - Return code: 0 15:53:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:53: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')]} 15:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53: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')]} 15:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:38 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 0x104ff3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105088618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff502c904e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f57d30>, '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 0x104cbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f4fb20>, '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.qX8LY5qEds/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.PnKL3i0mmr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:53:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:53:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:53:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX8LY5qEds/Render', 15:53:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:38 INFO - 'HOME': '/Users/cltbld', 15:53:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:38 INFO - 'LOGNAME': 'cltbld', 15:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:38 INFO - 'MOZ_NO_REMOTE': '1', 15:53:38 INFO - 'NO_EM_RESTART': '1', 15:53:38 INFO - 'PAGER': '/bin/cat', 15:53:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:38 INFO - 'PWD': '/builds/slave/test', 15:53:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:38 INFO - 'SHELL': '/bin/bash', 15:53:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PnKL3i0mmr/Listeners', 15:53:38 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 15:53:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:38 INFO - 'USER': 'cltbld', 15:53:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:38 INFO - 'XPC_FLAGS': '0x0', 15:53:38 INFO - 'XPC_SERVICE_NAME': '0', 15:53:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:39 INFO - Downloading/unpacking blobuploader==1.2.4 15:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:41 INFO - Downloading blobuploader-1.2.4.tar.gz 15:53:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:53:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:53:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:42 INFO - Downloading docopt-0.6.1.tar.gz 15:53:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:53:42 INFO - Installing collected packages: blobuploader, requests, docopt 15:53:42 INFO - Running setup.py install for blobuploader 15:53:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:53:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:53:43 INFO - Running setup.py install for requests 15:53:43 INFO - Running setup.py install for docopt 15:53:43 INFO - Successfully installed blobuploader requests docopt 15:53:43 INFO - Cleaning up... 15:53:43 INFO - Return code: 0 15:53:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53: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')]} 15:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53: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')]} 15:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:43 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 0x104ff3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105088618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff502c904e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f57d30>, '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 0x104cbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f4fb20>, '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.qX8LY5qEds/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.PnKL3i0mmr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:53:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:53:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:53:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX8LY5qEds/Render', 15:53:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:43 INFO - 'HOME': '/Users/cltbld', 15:53:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:43 INFO - 'LOGNAME': 'cltbld', 15:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:43 INFO - 'MOZ_NO_REMOTE': '1', 15:53:43 INFO - 'NO_EM_RESTART': '1', 15:53:43 INFO - 'PAGER': '/bin/cat', 15:53:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:43 INFO - 'PWD': '/builds/slave/test', 15:53:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:43 INFO - 'SHELL': '/bin/bash', 15:53:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PnKL3i0mmr/Listeners', 15:53:43 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 15:53:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:43 INFO - 'USER': 'cltbld', 15:53:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:43 INFO - 'XPC_FLAGS': '0x0', 15:53:43 INFO - 'XPC_SERVICE_NAME': '0', 15:53:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:53:44 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-Do_2N0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:53:44 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-WnlD5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:53:44 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-FHA_xc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:53:44 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-mge2S0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:53:44 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-tyBrCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:53:44 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-k5pmkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:53:44 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-ZNXAk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:53:44 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-JeQXwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:53:44 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-E2trWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:53:44 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-Xg0RJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:53:45 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-kJpoJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:53:45 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-nGL4FI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:53:45 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-h7RXNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:53:45 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-4lqdUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:45 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-8D1AIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:53:45 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-NyzBqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:53:45 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-SnvMK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:53:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:53:45 INFO - Running setup.py install for manifestparser 15:53:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:53:45 INFO - Running setup.py install for mozcrash 15:53:46 INFO - Running setup.py install for mozdebug 15:53:46 INFO - Running setup.py install for mozdevice 15:53:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:53:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:53:46 INFO - Running setup.py install for mozfile 15:53:46 INFO - Running setup.py install for mozhttpd 15:53:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:53:46 INFO - Running setup.py install for mozinfo 15:53:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:53:46 INFO - Running setup.py install for mozInstall 15:53:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:53:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:53:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:53:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:53:46 INFO - Running setup.py install for mozleak 15:53:47 INFO - Running setup.py install for mozlog 15:53:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:53:47 INFO - Running setup.py install for moznetwork 15:53:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:53:47 INFO - Running setup.py install for mozprocess 15:53:47 INFO - Running setup.py install for mozprofile 15:53:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:53:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:53:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:53:47 INFO - Running setup.py install for mozrunner 15:53:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:53:47 INFO - Running setup.py install for mozscreenshot 15:53:48 INFO - Running setup.py install for moztest 15:53:48 INFO - Running setup.py install for mozversion 15:53:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:53:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:53:48 INFO - Cleaning up... 15:53:48 INFO - Return code: 0 15:53:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53: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')]} 15:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53: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')]} 15:53:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:48 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 0x104ff3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105088618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff502c904e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f57d30>, '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 0x104cbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f4fb20>, '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.qX8LY5qEds/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.PnKL3i0mmr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:53:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:53:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:53:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX8LY5qEds/Render', 15:53:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:48 INFO - 'HOME': '/Users/cltbld', 15:53:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:48 INFO - 'LOGNAME': 'cltbld', 15:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:48 INFO - 'MOZ_NO_REMOTE': '1', 15:53:48 INFO - 'NO_EM_RESTART': '1', 15:53:48 INFO - 'PAGER': '/bin/cat', 15:53:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:48 INFO - 'PWD': '/builds/slave/test', 15:53:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:48 INFO - 'SHELL': '/bin/bash', 15:53:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PnKL3i0mmr/Listeners', 15:53:48 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 15:53:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:48 INFO - 'USER': 'cltbld', 15:53:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:48 INFO - 'XPC_FLAGS': '0x0', 15:53:48 INFO - 'XPC_SERVICE_NAME': '0', 15:53:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:53:49 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-Hxf5Yv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:53:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:53:49 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-bG3d2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:53:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:53:49 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-o8cI1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:53:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:53:49 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-41fYEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:53:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:53:49 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-4zVk_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:53:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:53:49 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-9Wmwdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:53:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:53:49 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-tWmqll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:53:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:53:49 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-hA7TDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:53:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:53:49 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-pmKEhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:53:50 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-m7wVCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:53:50 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-dSQOym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:53:50 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-Gy12lf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:53:50 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-CHCMVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:53:50 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-v7QBvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:50 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-TX_hup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:53:50 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-dYpE_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:53:50 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-u1JEEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:53:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:53 INFO - Downloading blessings-1.6.tar.gz 15:53:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:53:53 INFO - Installing collected packages: blessings 15:53:53 INFO - Running setup.py install for blessings 15:53:54 INFO - Successfully installed blessings 15:53:54 INFO - Cleaning up... 15:53:54 INFO - Return code: 0 15:53:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:53:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:53:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:53:54 INFO - Reading from file tmpfile_stdout 15:53:54 INFO - Current package versions: 15:53:54 INFO - blessings == 1.6 15:53:54 INFO - blobuploader == 1.2.4 15:53:54 INFO - docopt == 0.6.1 15:53:54 INFO - functools32 == 3.2.3-2 15:53:54 INFO - jsonschema == 2.5.1 15:53:54 INFO - manifestparser == 1.1 15:53:54 INFO - mozInstall == 1.12 15:53:54 INFO - mozcrash == 0.17 15:53:54 INFO - mozdebug == 0.1 15:53:54 INFO - mozdevice == 0.48 15:53:54 INFO - mozfile == 1.2 15:53:54 INFO - mozhttpd == 0.7 15:53:54 INFO - mozinfo == 0.9 15:53:54 INFO - mozleak == 0.1 15:53:54 INFO - mozlog == 3.3 15:53:54 INFO - moznetwork == 0.27 15:53:54 INFO - mozprocess == 0.23 15:53:54 INFO - mozprofile == 0.28 15:53:54 INFO - mozrunner == 6.12 15:53:54 INFO - mozscreenshot == 0.1 15:53:54 INFO - mozsystemmonitor == 0.3 15:53:54 INFO - moztest == 0.7 15:53:54 INFO - mozversion == 1.4 15:53:54 INFO - psutil == 3.1.1 15:53:54 INFO - requests == 1.2.3 15:53:54 INFO - wsgiref == 0.1.2 15:53:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:54 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 0x104ff3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105088618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff502c904e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f57d30>, '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 0x104cbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f4fb20>, '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.qX8LY5qEds/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.PnKL3i0mmr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:53:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:53:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:53:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX8LY5qEds/Render', 15:53:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:54 INFO - 'HOME': '/Users/cltbld', 15:53:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:54 INFO - 'LOGNAME': 'cltbld', 15:53:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:54 INFO - 'MOZ_NO_REMOTE': '1', 15:53:54 INFO - 'NO_EM_RESTART': '1', 15:53:54 INFO - 'PAGER': '/bin/cat', 15:53:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:54 INFO - 'PWD': '/builds/slave/test', 15:53:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:54 INFO - 'SHELL': '/bin/bash', 15:53:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PnKL3i0mmr/Listeners', 15:53:54 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 15:53:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:54 INFO - 'USER': 'cltbld', 15:53:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:54 INFO - 'XPC_FLAGS': '0x0', 15:53:54 INFO - 'XPC_SERVICE_NAME': '0', 15:53:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:53:54 INFO - Cleaning up... 15:53:54 INFO - Return code: 0 15:53:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:54 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 0x104ff3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105088618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff502c904e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f57d30>, '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 0x104cbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f4fb20>, '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.qX8LY5qEds/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.PnKL3i0mmr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:53:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:53:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:53:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX8LY5qEds/Render', 15:53:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:54 INFO - 'HOME': '/Users/cltbld', 15:53:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:54 INFO - 'LOGNAME': 'cltbld', 15:53:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:54 INFO - 'MOZ_NO_REMOTE': '1', 15:53:54 INFO - 'NO_EM_RESTART': '1', 15:53:54 INFO - 'PAGER': '/bin/cat', 15:53:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:54 INFO - 'PWD': '/builds/slave/test', 15:53:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:54 INFO - 'SHELL': '/bin/bash', 15:53:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PnKL3i0mmr/Listeners', 15:53:54 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 15:53:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:54 INFO - 'USER': 'cltbld', 15:53:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:54 INFO - 'XPC_FLAGS': '0x0', 15:53:54 INFO - 'XPC_SERVICE_NAME': '0', 15:53:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:53:54 INFO - Cleaning up... 15:53:54 INFO - Return code: 0 15:53:54 INFO - Running post-action listener: _resource_record_post_action 15:53:54 INFO - Running post-action listener: _start_resource_monitoring 15:53:54 INFO - Starting resource monitoring. 15:53:54 INFO - [mozharness: 2016-08-05 22:53:54.981255Z] Finished create-virtualenv step (success) 15:53:54 INFO - [mozharness: 2016-08-05 22:53:54.982268Z] Running install step. 15:53:54 INFO - Running pre-action listener: _resource_record_pre_action 15:53:54 INFO - Running main action method: install 15:53:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:53:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:53:55 INFO - Reading from file tmpfile_stdout 15:53:55 INFO - Detecting whether we're running mozinstall >=1.0... 15:53:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:53:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:53:55 INFO - Reading from file tmpfile_stdout 15:53:55 INFO - Output received: 15:53:55 INFO - Usage: mozinstall [options] installer 15:53:55 INFO - Options: 15:53:55 INFO - -h, --help show this help message and exit 15:53:55 INFO - -d DEST, --destination=DEST 15:53:55 INFO - Directory to install application into. [default: 15:53:55 INFO - "/builds/slave/test"] 15:53:55 INFO - --app=APP Application being installed. [default: firefox] 15:53:55 INFO - mkdir: /builds/slave/test/build/application 15:53:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:53:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:54:29 INFO - Reading from file tmpfile_stdout 15:54:29 INFO - Output received: 15:54:29 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:54:29 INFO - Running post-action listener: _resource_record_post_action 15:54:29 INFO - [mozharness: 2016-08-05 22:54:29.740254Z] Finished install step (success) 15:54:29 INFO - [mozharness: 2016-08-05 22:54:29.740424Z] Running run-tests step. 15:54:29 INFO - Running pre-action listener: _resource_record_pre_action 15:54:29 INFO - Running main action method: run_tests 15:54:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:54:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:54:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:54:29 INFO - 2016-08-05 15:54:29.755 screenresolution[1645:7545] starting screenresolution argv=screenresolution get 15:54:29 INFO - 2016-08-05 15:54:29.757 screenresolution[1645:7545] Display 0: 1600x1200x32@60 15:54:29 INFO - 2016-08-05 15:54:29.764 screenresolution[1646:7547] starting screenresolution argv=screenresolution list 15:54:29 INFO - Available Modes on Display 0 15:54:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:54:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:54:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:54:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:54:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:54:29 INFO - Intel Iris: 15:54:29 INFO - Chipset Model: Intel Iris 15:54:29 INFO - Type: GPU 15:54:29 INFO - Bus: Built-In 15:54:29 INFO - VRAM (Dynamic, Max): 1536 MB 15:54:29 INFO - Vendor: Intel (0x8086) 15:54:29 INFO - Device ID: 0x0a2e 15:54:29 INFO - Revision ID: 0x0009 15:54:29 INFO - Displays: 15:54:29 INFO - Display: 15:54:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:54:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:54:29 INFO - Display Serial Number: 1600x1200 60 15:54:29 INFO - Main Display: Yes 15:54:29 INFO - Mirror: Off 15:54:29 INFO - Online: Yes 15:54:29 INFO - Rotation: Supported 15:54:29 INFO - Return code: 0 15:54:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:54:30 INFO - Python 2.7.3 15:54:30 INFO - Return code: 0 15:54:30 INFO - grabbing minidump binary from tooltool 15:54:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:54:30 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 0x104f57d30>, '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 0x104cbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f4fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:54:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:54:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 15:54:30 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:54:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:54:30 INFO - Return code: 0 15:54:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:54:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:54:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:54:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:54:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:54:30 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/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0328', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:54:30 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/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0328 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:54:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX8LY5qEds/Render', 15:54:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:54:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:54:30 INFO - 'HOME': '/Users/cltbld', 15:54:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:54:30 INFO - 'LOGNAME': 'cltbld', 15:54:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:54:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:30 INFO - 'MOZ_NO_REMOTE': '1', 15:54:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:54:30 INFO - 'NO_EM_RESTART': '1', 15:54:30 INFO - 'PAGER': '/bin/cat', 15:54:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:30 INFO - 'PWD': '/builds/slave/test', 15:54:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:54:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:54:30 INFO - 'SHELL': '/bin/bash', 15:54:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PnKL3i0mmr/Listeners', 15:54:30 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 15:54:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:54:30 INFO - 'USER': 'cltbld', 15:54:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:54:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:30 INFO - 'XPC_FLAGS': '0x0', 15:54:30 INFO - 'XPC_SERVICE_NAME': '0', 15:54:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:54:30 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/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0328', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:54:30 INFO - mozversion application_buildid: 20160805133321 15:54:30 INFO - mozversion application_changeset: 43f25602dac0aed6aafd8cfc9f9d45b2d047e791 15:54:30 INFO - mozversion application_display_name: Nightly 15:54:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:54:30 INFO - mozversion application_name: Firefox 15:54:30 INFO - mozversion application_remotingname: firefox 15:54:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:54:30 INFO - mozversion application_vendor: Mozilla 15:54:30 INFO - mozversion application_version: 51.0a1 15:54:30 INFO - mozversion platform_buildid: 20160805133321 15:54:30 INFO - mozversion platform_changeset: 43f25602dac0aed6aafd8cfc9f9d45b2d047e791 15:54:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:54:30 INFO - mozversion platform_version: 51.0a1 15:54:30 INFO - using testdate: 1470437670 15:54:30 INFO - actual date: 1470437670 15:54:30 INFO - starting webserver on 'localhost:49266' 15:54:30 INFO - SUITE-START | Running 2 tests 15:54:30 INFO - TEST-START | dromaeo_css 15:54:30 INFO - operating with platform_type : mac_ 15:54:30 INFO - Initialising browser for dromaeo_css test... 15:54:30 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/tmpvhZ4np/profile http://localhost:49266/getInfo.html) 15:54:33 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 15:54:33 INFO - PROCESS | 1656 | colorDepth:24 15:54:33 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 15:54:33 INFO - PROCESS | 1656 | __metrics 15:54:33 ERROR - PROCESS | 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:54:33 INFO - TEST-INFO | 1656: exit 0 15:54:33 INFO - Browser initialized. 15:54:33 INFO - Running cycle 1/1 for dromaeo_css test... 15:54:33 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/tmpvhZ4np/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:54:46 INFO - PROCESS | 1659 | RSS: Main: 254685184 15:54:46 INFO - PROCESS | 1659 | 15:55:35 INFO - PROCESS | 1659 | 1470437735790 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:57:47 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 15:57:49 INFO - PROCESS | 1659 | RSS: Main: 267476992 15:57:49 INFO - PROCESS | 1659 | 16:00:51 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 16:00:52 INFO - PROCESS | 1659 | RSS: Main: 281739264 16:00:52 INFO - PROCESS | 1659 | 16:03:54 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 16:03:54 INFO - PROCESS | 1659 | RSS: Main: 288317440 16:03:54 INFO - PROCESS | 1659 | 16:06:56 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 16:06:57 INFO - PROCESS | 1659 | RSS: Main: 287240192 16:06:57 INFO - PROCESS | 1659 | 16:10:00 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 16:10:00 INFO - PROCESS | 1659 | RSS: Main: 292794368 16:10:00 INFO - PROCESS | 1659 | 16:13:03 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 16:13:03 INFO - PROCESS | 1659 | RSS: Main: 297025536 16:13:03 INFO - PROCESS | 1659 | 16:13:03 INFO - PROCESS | 1659 | __start_tp_report 16:13:03 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 16:13:03 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 16:13:03 INFO - PROCESS | 1659 | |i|pagename|runs| 16:13:03 INFO - PROCESS | 1659 | |0;dojo.html;2810.817296875703;3369.477730951702;3456.2396272819988;3504.334176506465;3509.736769742269;5134.537891589756;5595.524380427663;5791.652500849952;5890.116482527623;5955.702214889249;5478.945210547893;5576.33084029917;5898.292204935403;5911.379305172959;5945.554083443748;5291.68249905005;5373.623846330758;5388.595855310848;5442.319710036246;5475.5072043516075;5427.185922111676;5434.239206511092;5472.315960504937;5491.780328786844;5547.611667183299;5281.603879709037;5285.86785330366;5373.892522149574;5416.729163541847;5445.673259604397;5390.97304513475;5392.137258038734;5393.002294575516;5420.457954204588;5423.755930983115;4286.914261714779;5088.465711100355;5247.239150323182;5259.21111833228;5322.547583455411;5637.605367624268;5914.083317085859;5924.348321684654;5930.288365396137;5999.160117583542;6213.502919766408;6224.906626400608;6224.9688751556405;6272.717727702265;6283.931731605638;6198.2252218472695;6271.780487682955;6280.528960327993;6292.961661325876;6295.748170073191;5604.9911016016695;5899.705014749288;5941.22764040672;5963.880722385615;6056.121862329937;5776.508996735324;6378.107065010902;6381.329960354189;6400.199975003125;6402.071699603532;6098.401972603781;6190.164327815777;6205.906911396332;6225.906611400833;6268.247810262797;6194.194754681953;6209.813705588839;6223.813285601439;6305.369463053658;6324.146240257598;6221.160143380585;6247.968760156261;6248.9062664060075;6261.686915654199;6274.592151510228;6121.81881567809;6244.438000579969;6251;6253.6873156342;6257.2804127525915;5006.998600279959;5011.473795251519;5026.84919452417;5041.924371134436;5084.161113416245;4471.06107717383;4501.729896206172;4506.932396014063;4516.299973504112;4518.209313370213;5758.193852860602;5860.267466566679;5890.116482527569;5922.437368449991;5982.910256346158;6178.5366097542865;6184.350643182491;6226;6276.246850377984;6299.212598425197;4929.507049295042;5903.645781253139;5939.46544810969;5966.343702192756;5996.280446346466;5467.1799230115;5554.833354999357;5565.582581306418;5569.0254205513875;5578.135389014709;6374.904376434357;6376.936230637634;6383.329750376237;6481.935180648133;6498.545101843015;6190;6246.781362652286;6266.780662676967;6268.686565671789;6272.40412160844;6318.8736225274315;6426.871462570629;6463.870722585616;6515.804525864231;6538.346165383614;6192.3807619239515;6229.595076320024;6243.906341404791;6306.968465157828;6315.147455093504;6245.531585131224;6255.968720156552;6264.655443950626;6267;6267.811965641038;5210;6099.908501372394;6256.186695729526;6260.655663938527;6270.843228919131;4474.955250447584;6142.652254521386;6180.721867516063;6249.625022498664;6269.937300627118;5991.610545314541;6014.278286605635;6057.636541807506;6159.907601385893;6164.969175154096;6106.32830388648;6217.658028808278;6240.937590624036;6246.9062964054665;6288;4970.254461830755;4989.675671081513;6076.422739839708;6133.304060594526;6145.9692701536205 16:13:03 INFO - PROCESS | 1659 | |1;ext.html;490.6148673291466;529.6768970927736;541.2963147907719;545.2965674280177;567.7728908436627;37825.865224043286;40451.59548404515;40557;40570;40693.38959915596;42039.57960420395;42305.15389692204;42435.787821060854;42553.57446425535;42616.78691606545;9414;9697.757556061084;9715.077067678594;9715.222782177409;9736.561854716554;9544.236461083097;9598;9635.759106022371;9647.614095436174;9660.227181825472;9611.375260608072;9646.324757266993;9649.565769540388;9656.420614763101;9676.419414835133;9544.33189676723;9585.904140958572;9598.95200523993;9605.807883842284;9609.471479068718;9635.470049147294;9657.71026869195;9718.368306060083;9729.027097290285;9777.511124443748;38753.80623096895;39487.60512394868;39708.80145599283;39741;39874.60125398738;3344.365611003199;3394.8132852693093;3469.1847415857255;3472.2534655049035;3851.691864650821;32183.19542011445;32741.836290818632;32807.50788738171;33027.504587430965;33333.33333333344;3245.2535916739284;3268.7548433867555;3294.7528935329947;3300.389427955836;3402.2004828865197;424762.8761856202;495243;495650;500598;503035;59332.70333648391;59669.701651491465;59742.40257597368;59744;59876.40123598708;28416;29653.555196672067;32754;36425.817870910476;36524.26951460956;16198.838011619733;16370.508884733477;16378.099204543865;16409;16413.67172656564;12441.75116497665;12446.25322480654;12530.937345313398;12544.937275313565;12547.435365408579;19255.903720481307;19371.727748691166;19409.61180776405;19483.318083866998;19535.34749227224;7969.481983671043;8130.837383252302;8165.836683266301;8174.3460523158;8195.46729462583;733.3729661139755;921.3826736086838;992.7815880506278;1062.4528367890543;1096.1176253116319;22543.549129017327;26713.599296010576;30265.697343026728;30831.383372332428;31108.066757997298;910.1626503616689;950.6720181537358;1050.7583255851198;1110.5779803674552;1167.3579531257774;11282.887171128348;12994.935025325001;13253.000059702734;13513.324333783468;13600.31998400076;687302;694783;694809;695242;695614;42691.14617707628;43372.349414758806;43801.56198438039;43910;43996.780016099714;1355.979660305096;1387.5421111033336;1393.4704812171512;1402.677384201619;1412.1244828206577;29928;29964.550531741606;30379.848100759355;30507.84746076344;30517.694823051486;51880.740596296775;52287.47712522826;52388.47611523836;52422.73788631032;52513.7374313126;582457;585547;585631;586434.0678296582;587353;23146.53706925886;27063.729362706123;27220.72779272182;27233.91064357483;27237.72762272352;39621.2075758489;48173.75913120412;48760.75619621879;50060;50061;39946.80026599965;40215.99460013523;41494.377584336864;41769;41872.79063604662;32540.674593253763;34862.477062844584;39439.80280098581;39888.6038988634;41036;28329.71670283353;38250.42624360581;39219.21561568695;39660;41273.79363103165;30755.384892302478;34835.303293934485;35409.29181416306;36063.27873442569;36363.45454818233;26161.345966350993;26260.737392626594;26424.0751573694;26505.60241596416;26972 16:13:03 INFO - PROCESS | 1659 | |2;jquery.html;375.75575875680806;383.12456037953274;386.17551527488814;395.85749130313064;408.62202462721996;19927.800721992775;21226.57546849066;21678.24126155585;21955.780442195573;22044.33866983991;20811.479713007182;20827.27104551341;20839.374818755423;20893.791062089374;21149.471263218427;5926.081143108023;6023.337432882401;6157.969210153943;6224.751009959597;6248.812535623916;4220.767857767822;6081.391860813906;6159.445649891509;6501.382368674968;6820.31796820319;6783.389494945454;6811.727530898758;6820.93179068208;6830.077939478157;6843.213030501482;6596.802095937105;6835.28229535899;6836.1113055302985;6846.418054465352;6847.349501797371;5766.192733017381;5937.990541607937;5980.880382392371;5980.910286345708;5984.8503787405225;20442.897785510977;22903.08387664508;23985;26410.73589264102;26480.470390592272;2350.764923507653;2489.950200995988;2494.2018554062706;2986.2982199183175;3083.9977007472435;15511.301991410413;15623.375064997386;15685.764713529306;15985.520434386986;16344.264508097163;1885.6982882738696;1895.7630296212974;1916.1281616864294;1923.6438310990857;1932.420273917819;92557;99268;100247.49876250573;100641;101715.49142254316;10638.627648032436;10802.135829133651;10918.126549875991;11101.500432480558;11193.048590869867;13742.381592828347;13772;13813.963952703387;13828.686274803878;13843.861561384258;8615.784605384915;8664.393492455594;8678.6528538859;8704.608292626846;8750.69372571957;7129.3583577478275;8643.265322447536;8707.869381959275;8720.127987201357;8919.687810926587;6163.952128138228;6325.8734825304155;6687.732490700415;6784.0841486399695;6832.965835170792;1408.3732738931078;1598.5444148417646;1689.4255952976048;1854.6754317994296;1889.9244030238635;802.9357651387875;882.6292956958093;932.6828878181451;939.8674597110465;1012.8227560177087;20511.58976820455;21175.576488470146;21400.571988560143;21510.677339839916;21564.35306940794;889.1952782731638;964.1322809471532;980.6224603527551;985.1773768903046;1043.3479075577764;8859.3798434109;10788.676339709822;11096.889031109748;11315.547378104948;11454.427278636034;473089;547025;547411;578556.1072194612;579387;93464;109956;116149.4192529032;120289;120813;818.2840014986887;986.6201512417771;1010.3836659637615;1011.9747006324901;1013.9290249682599;15527.611809704847;19029;19065.951372674637;19073.71389429132;19124.33064842724;50024.74987625039;50534;51281.48718512767;51923.74038129785;57548.71225643845;81196.59401702954;82128.58935705523;82879.5856020716;83647;84323;7124.358807707331;7304.687889701441;7508.924910750822;7697.615119243904;8210.384221183316;10961.835572466578;11193.216474846682;11268.943655281671;12294.385280735749;12905.870941290843;11077.501512431798;11313.660590182308;11609.709757256136;11647.068234541386;11689.298642081503;9884.555195016384;10763.3541987481;11117.666470005914;11239.831402529133;11287.379194144401;11340.149488788209;11448.313101213955;11610.593629222936;11917.702057448287;11939.582114625946;7997.1203167652675;8056.879146812919;8250.174982501701;8279.917200828155;8430.83138337242;7835.098963619257;10618.681439556825;11060.612878549213;11389.943050285026;11453 16:13:03 INFO - PROCESS | 1659 | |3;mootools.html;1388.5417812122;1498.3631956418524;1563.421534032408;1669.4073603870625;1711.1615308498824;7934.9206507934905;8312.501249925;8468.576571171432;8877.156670116328;8878.955605221972;8483.448575842565;8731.607077681503;8743.825123497527;8752.562371881397;8769.166929141722;2066.7933206679286;2300.148944890393;2372.9169479068237;2376.512814872947;2388.725296590897;2332.8483648562874;2363.52729454109;2381.3332266965276;2383.7497062808416;2393.246127469841;2349.036894873094;2362.161432691387;2369.6800931874236;2386.427257458215;2410;2335.474518233384;2347;2356.8468049576722;2362.0315670574983;2366.0535785685693;2320.164740693349;2343.917962871308;2362.303120579433;2362.4093976505874;2366.148186652804;8676.60955257015;8722.215000649909;8722.738317850475;8739.169778870997;8761.21149096578;5121.308623335839;5216.139337009389;5274.077036518594;5323.733813309319;5340.359156901197;3413.675700808444;3563.518924945125;3573.76770509916;3612.837422315976;3622.130688634735;1063.0698139128262;1096.6655170173094;1100.5432745410644;1108.2906939558688;1124.2299025167786;11473.426328683616;11617;11656.825147622792;11703.88296117045;11715.238509496856;3745.3071181830906;4568.70303430276;4653.278741795028;4756.167670657621;4819;9754.853677194847;9896.059874311928;9900.356476828983;9912.900870991198;9926.007399260016;4443.466783985942;5274.657147285414;5275.788968441219;5284.07528682479;5284.101702710548;4363.585459381354;4573.725576465423;4690.859274221779;4705.858824235278;4834.105690447279;3878.592747761501;3984.601539845992;3995.6403923647013;4048.736832105904;4066.4510291110914;1080.4381721504774;1113.832925061231;1280.4686055287139;1291.5802364231663;1300.902432317561;844.4806444036873;911.5670056723136;911.7811725185908;919.3656377099779;971.0580736685404;5771.278590176228;5960.225170727865;6061.484773794277;6137.478314343331;6160.706251687196;427.35256087028176;428.7791787229517;439.42435409613506;441.66433510532227;443.57195306529354;3364.4616861302075;3499.0202743231935;3505.5793304803587;3807.485989391452;4067.9796601017397;10316.535755891004;10733.409662468483;10787;10828.566857325619;10840.295380800222;9141.497217653094;10632.787344253225;10661.626843060456;10752.40861752611;10755.516001779783;6748.561343512656;7265.455090868206;8070.838583228303;8203.917960820316;8274.544900030436;5970.223870896755;6029.758809647565;6073.726682299219;6093.908591371044;6212.72042758086;10043.296969212377;10064.647737329158;10206.897931020594;10210.132138768287;10222.591096356062;8230.506169629842;9983.301168918106;10196.235282354002;10248.23138264648;10400.895991039994;7110.39561637246;7544.4341674373545;7600.049993750781;7677.654505547152;7718.112417072109;8462.788430289293;8470.15298470148;8531.445456045338;8587.441816281922;8602.311815054905;7589.924100759143;7624.618769061413;7652;7725.266099720518;7785.416093792875;6709.7922373971205;7157.642117894188;7421.443391745749;7452.956586077845;7570.621468926642;6913.3777959983845;7042.366187043191;7074.964625176841;7075.6815943281645;7084.468664850054;4865.464798872192;4929.531694489017;5031.823886163967;5119.769610367468;5184.948150518447;3850.9037274068373;4491.281394976919;5098.5411312982005;5133.076046311699;5226.085435048927 16:13:03 INFO - PROCESS | 1659 | |4;prototype.html;291.1962982169213;297.2316561688036;309.16217051789647;310.79176951442525;314.71203848478643;4455.443069616302;4908.607311415087;5110.591152707784;5488.588355873316;5718.513926316263;5487.38122253935;5555.722153916895;5592.7762889484375;5594.916076258849;5621.943780562193;3383.323335332931;3746.6253374662588;3871.2257548490275;4045.797710114497;4344.415073031541;3451.7238620910393;3920.921581568367;4189.0885834345145;4353.499347575038;4365.432493775805;3662;3855.55661098973;4060.9796951015205;4157.833686652531;4172.937405938914;3282.6013142389074;3705.5923848376656;4027.3153563894207;4166.562510936338;4188.518320393163;3606.1969015492255;3614;3630.146915474861;3631.5823680276844;3635.763675361093;5046.924296135561;5390.4879036491475;5459.508644222039;5469.15228139639;5493.587980901409;3995.2409042281874;4387.714798538085;4765.0946320199055;4775.516731299705;4778.2115950868065;5882.852928676774;5886.852828679274;5895.970520147372;5935.910961335583;5936.298983962287;3780;4027.2146931348398;4054.1080962188566;4058.2289365020847;4073.6537394321517;6223.315435302158;6252.874942501125;6261.812145635593;6267.655278959655;6268.5298602604535;3650.6166852480637;3922.4116382542275;3943.63944439168;4191.952011997001;4193.601607847249;3539.584166333436;4074.6129117733767;4168.791560422027;4216.51510076339;4262.8064142040275;4236.703430759879;4845.830395936126;4877.975610121926;4879.609631229493;4889.877753056131;5702.429757024264;5901.822945311647;5905.261842269716;5942.940570594239;6000.549958753111;1107.3189988157226;1335.7977819962111;1388.3270658856054;1435.9497417590544;1449.311577000916;742.1131747561612;847.631280393031;887.8490656588395;895.7223260789176;895.8297923394534;3619.7647152934974;3922.431027588987;4057.756534607874;4502.482214545369;4537.387452693844;4257.957420425818;4305;4709.281112393952;4905.8226025754275;5024.447310795809;4009.939850902239;4314.676399270004;4374.234508960919;4389.846355377546;4476;2186.486175748698;2929.6777354490987;3196.840157992091;3240.1737556922835;3240.724538414261;6348.396902294275;6370.394812492806;6383.872322553523;6394.401399650087;6407.871842563122;5477.4796394342475;5546.473085056913;6133.473252879523;6303.590266632654;6322.620642761449;5930.318013428425;6190.597611155261;6219.631681030166;6283.905741413882;6295.779647712399;5494.203340515683;5780.508656764054;5913.900565299256;6073.392660733891;6127.234095738033;5865.354810970875;5947.31605865331;5992.831397877547;6009.437546237922;6024.1265016573225;5700.8883267762385;6301.873962520633;6330.683465826598;6333.6748207191595;6355.3644635536075;3722.2927643747603;3791.7676755055268;3939.8030098495533;3986.800659967048;3993.6206060424215;5807;5937.614055086578;5975.056462734574;5996.280446346466;6003.609765365237;4533.778448560248;4771.618270538279;5317.995332637048;5863.296404431496;5976;4983.710750904385;5064.012517559041;5848.678322692293;5857.414258574108;5910.822675319747;5434.396852928317;5490.321484605244;5700.230468886647;5723.885522289447;5783.710814459176;4936.43231028422;5239.899621079616;5427.185922111715;5916;5918.644881307136;5751.511121554715;5763.4812866842185;5774.729559496904;5786.363500014911;5892.734826932884 16:13:03 INFO - PROCESS | 1659 | |5;yui.html;705.1679018757866;709.58489283769;709.8260926073112;727.1673933346318;774.4694884004454;15278.694426111471;15740.449084282052;15903.681926361465;15926.84073159268;15934;12764.936175319133;16157;16191.83808161918;16220.270087846045;16221.91889040556;731.5683746589511;832.2925513313695;858.4377232912452;866.0343716755835;869.9043105258448;694.0872752330669;834.8747687846811;852.4757274276337;856.9785755356135;868.4745728834059;912.0013585124278;912.3020889019905;913.6665117232229;915.0894859614659;915.716128000322;882.1839798186684;901.5627420700955;906.6690657909882;906.8957069936976;907.5552979040289;672.559473544829;672.6199697171082;673.3098573961679;673.3905815237218;674.4199988010307;15291.617709557238;15367.846321536865;15371.461998830098;15386.692266154727;15386.769198462032;10537.473126343652;12347.506099756;12470.251784892935;12514;12750.489980400773;11726.296422214695;11732.765344693144;11831.728735975374;11966.940165299118;12248.755024899541;3795.5824859265736;3810.866619668326;3819.598942111094;3847.288251673421;3942.7634341939574;121952;123792.38103809513;124186.37906810499;125645;126315.57895473707;11048.668539943814;11051.613193538187;11125.054370378608;11160.16298777595;11368.545258189744;18447.631047378978;22363.769992650236;22498.98754556049;22585.4353641157;22744.203952861903;8039.919600804034;8057.6374063167295;8091;8290.544020078833;8334.249917507332;4439.4006809080365;4524.882367014934;4539.614132798749;4540.432445944257;4611.354410382549;3315.983420082884;3639.1811842335264;3762.285165818486;3767.3783825668456;3772.0569857535615;571.5941681406248;658.6180015590945;665.7370338716277;680.7004917836136;693.4244577001077;615.5137441421227;630.4452082167663;646.7089809585706;675.6554157379674;678.064271305605;7807.336376407955;8259.876101858477;8280.917190828015;9405.43567385959;9698.563564639608;594.0673143165276;632.8481164520482;640.9775657852047;646.3278190681732;719.6401799100449;3803.847846086181;4017.517897852218;4045.5145382554283;4098.426220329156;4422.071365013319;140352;165735;170106;174687.12656436636;175542;119254.40372798254;146427;147254;149576;151503.18235679422;127625.36187319004;128284.71715282727;129452;131236;132635.33682331527;8084.919150808417;8468.788280293042;9662.420254784736;10173.186145108226;10256.38461692301;50480;56794;56995;60067.79186497474;62019.689901550206;72141;83011.5849420749;84071;93197.5340123295;95924.52037739767;14518.564443066725;14538.491152809602;14561.490347837775;14681.48614798477;15133.394664213309;14900.62748431298;15534.766978495558;15758.133302668462;15820.28808703634;16303.556650148012;14600.342984565932;14657.340419681354;14666.70666586641;14848;15122.319495622503;14571.271436428347;14595;14614.561563153122;14920.780803580505;15218.467353643013;11204.551817927517;12197.939010304892;13586.660333491742;14052.929735351257;14063.578092656828;11326.433678316216;11333.320000799979;11412.90309761749;11760.823587646364;11860.644180674593;9006.864897026418;10784.406857622593;11545.82681259765;11692.70768230767;11747.88395102464 16:13:03 INFO - PROCESS | 1659 | __end_tp_report 16:13:03 INFO - PROCESS | 1659 | __start_cc_report 16:13:03 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,415 16:13:03 INFO - PROCESS | 1659 | __end_cc_report 16:13:03 INFO - PROCESS | 1659 | __startTimestamp1470438783772__endTimestamp 16:13:03 INFO - PROCESS | 1659 | 16:13:03 INFO - PROCESS | 1659 | ------- Summary: start ------- 16:13:03 INFO - PROCESS | 1659 | Number of tests: 6 16:13:03 INFO - PROCESS | 1659 | 16:13:03 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5798.58 Median:6057.64 stddev:667.86 (11.0%) stddev-sans-first:627.43 16:13:03 INFO - PROCESS | 1659 | Values: 2810.8 3369.5 3456.2 3504.3 3509.7 5134.5 5595.5 5791.7 5890.1 5955.7 5478.9 5576.3 5898.3 5911.4 5945.6 5291.7 5373.6 5388.6 5442.3 5475.5 5427.2 5434.2 5472.3 5491.8 5547.6 5281.6 5285.9 5373.9 5416.7 5445.7 5391.0 5392.1 5393.0 5420.5 5423.8 4286.9 5088.5 5247.2 5259.2 5322.5 5637.6 5914.1 5924.3 5930.3 5999.2 6213.5 6224.9 6225.0 6272.7 6283.9 6198.2 6271.8 6280.5 6293.0 6295.7 5605.0 5899.7 5941.2 5963.9 6056.1 5776.5 6378.1 6381.3 6400.2 6402.1 6098.4 6190.2 6205.9 6225.9 6268.2 6194.2 6209.8 6223.8 6305.4 6324.1 6221.2 6248.0 6248.9 6261.7 6274.6 6121.8 6244.4 6251.0 6253.7 6257.3 5007.0 5011.5 5026.8 5041.9 5084.2 4471.1 4501.7 4506.9 4516.3 4518.2 5758.2 5860.3 5890.1 5922.4 5982.9 6178.5 6184.4 6226.0 6276.2 6299.2 4929.5 5903.6 5939.5 5966.3 5996.3 5467.2 5554.8 5565.6 5569.0 5578.1 6374.9 6376.9 6383.3 6481.9 6498.5 6190.0 6246.8 6266.8 6268.7 6272.4 6318.9 6426.9 6463.9 6515.8 6538.3 6192.4 6229.6 6243.9 6307.0 6315.1 6245.5 6256.0 6264.7 6267.0 6267.8 5210.0 6099.9 6256.2 6260.7 6270.8 4475.0 6142.7 6180.7 6249.6 6269.9 5991.6 6014.3 6057.6 6159.9 6165.0 6106.3 6217.7 6240.9 6246.9 6288.0 4970.3 4989.7 6076.4 6133.3 6146.0 16:13:03 INFO - PROCESS | 1659 | 16:13:03 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:70654.52 Median:40081.40 stddev:159175.39 (397.1%) stddev-sans-first:159534.75 16:13:03 INFO - PROCESS | 1659 | Values: 490.6 529.7 541.3 545.3 567.8 37825.9 40451.6 40557.0 40570.0 40693.4 42039.6 42305.2 42435.8 42553.6 42616.8 9414.0 9697.8 9715.1 9715.2 9736.6 9544.2 9598.0 9635.8 9647.6 9660.2 9611.4 9646.3 9649.6 9656.4 9676.4 9544.3 9585.9 9599.0 9605.8 9609.5 9635.5 9657.7 9718.4 9729.0 9777.5 38753.8 39487.6 39708.8 39741.0 39874.6 3344.4 3394.8 3469.2 3472.3 3851.7 32183.2 32741.8 32807.5 33027.5 33333.3 3245.3 3268.8 3294.8 3300.4 3402.2 424762.9 495243.0 495650.0 500598.0 503035.0 59332.7 59669.7 59742.4 59744.0 59876.4 28416.0 29653.6 32754.0 36425.8 36524.3 16198.8 16370.5 16378.1 16409.0 16413.7 12441.8 12446.3 12530.9 12544.9 12547.4 19255.9 19371.7 19409.6 19483.3 19535.3 7969.5 8130.8 8165.8 8174.3 8195.5 733.4 921.4 992.8 1062.5 1096.1 22543.5 26713.6 30265.7 30831.4 31108.1 910.2 950.7 1050.8 1110.6 1167.4 11282.9 12994.9 13253.0 13513.3 13600.3 687302.0 694783.0 694809.0 695242.0 695614.0 42691.1 43372.3 43801.6 43910.0 43996.8 1356.0 1387.5 1393.5 1402.7 1412.1 29928.0 29964.6 30379.8 30507.8 30517.7 51880.7 52287.5 52388.5 52422.7 52513.7 582457.0 585547.0 585631.0 586434.1 587353.0 23146.5 27063.7 27220.7 27233.9 27237.7 39621.2 48173.8 48760.8 50060.0 50061.0 39946.8 40216.0 41494.4 41769.0 41872.8 32540.7 34862.5 39439.8 39888.6 41036.0 28329.7 38250.4 39219.2 39660.0 41273.8 30755.4 34835.3 35409.3 36063.3 36363.5 26161.3 26260.7 26424.1 26505.6 26972.0 16:13:03 INFO - PROCESS | 1659 | 16:13:03 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:32920.46 Median:26445.60 stddev:90896.89 (343.7%) stddev-sans-first:91119.03 16:13:03 INFO - PROCESS | 1659 | Values: 375.8 383.1 386.2 395.9 408.6 19927.8 21226.6 21678.2 21955.8 22044.3 20811.5 20827.3 20839.4 20893.8 21149.5 5926.1 6023.3 6158.0 6224.8 6248.8 4220.8 6081.4 6159.4 6501.4 6820.3 6783.4 6811.7 6820.9 6830.1 6843.2 6596.8 6835.3 6836.1 6846.4 6847.3 5766.2 5938.0 5980.9 5980.9 5984.9 20442.9 22903.1 23985.0 26410.7 26480.5 2350.8 2490.0 2494.2 2986.3 3084.0 15511.3 15623.4 15685.8 15985.5 16344.3 1885.7 1895.8 1916.1 1923.6 1932.4 92557.0 99268.0 100247.5 100641.0 101715.5 10638.6 10802.1 10918.1 11101.5 11193.0 13742.4 13772.0 13814.0 13828.7 13843.9 8615.8 8664.4 8678.7 8704.6 8750.7 7129.4 8643.3 8707.9 8720.1 8919.7 6164.0 6325.9 6687.7 6784.1 6833.0 1408.4 1598.5 1689.4 1854.7 1889.9 802.9 882.6 932.7 939.9 1012.8 20511.6 21175.6 21400.6 21510.7 21564.4 889.2 964.1 980.6 985.2 1043.3 8859.4 10788.7 11096.9 11315.5 11454.4 473089.0 547025.0 547411.0 578556.1 579387.0 93464.0 109956.0 116149.4 120289.0 120813.0 818.3 986.6 1010.4 1012.0 1013.9 15527.6 19029.0 19066.0 19073.7 19124.3 50024.7 50534.0 51281.5 51923.7 57548.7 81196.6 82128.6 82879.6 83647.0 84323.0 7124.4 7304.7 7508.9 7697.6 8210.4 10961.8 11193.2 11268.9 12294.4 12905.9 11077.5 11313.7 11609.7 11647.1 11689.3 9884.6 10763.4 11117.7 11239.8 11287.4 11340.1 11448.3 11610.6 11917.7 11939.6 7997.1 8056.9 8250.2 8279.9 8430.8 7835.1 10618.7 11060.6 11389.9 11453.0 16:13:03 INFO - PROCESS | 1659 | 16:13:03 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5661.01 Median:4698.36 stddev:3213.88 (68.4%) stddev-sans-first:3206.86 16:13:03 INFO - PROCESS | 1659 | Values: 1388.5 1498.4 1563.4 1669.4 1711.2 7934.9 8312.5 8468.6 8877.2 8879.0 8483.4 8731.6 8743.8 8752.6 8769.2 2066.8 2300.1 2372.9 2376.5 2388.7 2332.8 2363.5 2381.3 2383.7 2393.2 2349.0 2362.2 2369.7 2386.4 2410.0 2335.5 2347.0 2356.8 2362.0 2366.1 2320.2 2343.9 2362.3 2362.4 2366.1 8676.6 8722.2 8722.7 8739.2 8761.2 5121.3 5216.1 5274.1 5323.7 5340.4 3413.7 3563.5 3573.8 3612.8 3622.1 1063.1 1096.7 1100.5 1108.3 1124.2 11473.4 11617.0 11656.8 11703.9 11715.2 3745.3 4568.7 4653.3 4756.2 4819.0 9754.9 9896.1 9900.4 9912.9 9926.0 4443.5 5274.7 5275.8 5284.1 5284.1 4363.6 4573.7 4690.9 4705.9 4834.1 3878.6 3984.6 3995.6 4048.7 4066.5 1080.4 1113.8 1280.5 1291.6 1300.9 844.5 911.6 911.8 919.4 971.1 5771.3 5960.2 6061.5 6137.5 6160.7 427.4 428.8 439.4 441.7 443.6 3364.5 3499.0 3505.6 3807.5 4068.0 10316.5 10733.4 10787.0 10828.6 10840.3 9141.5 10632.8 10661.6 10752.4 10755.5 6748.6 7265.5 8070.8 8203.9 8274.5 5970.2 6029.8 6073.7 6093.9 6212.7 10043.3 10064.6 10206.9 10210.1 10222.6 8230.5 9983.3 10196.2 10248.2 10400.9 7110.4 7544.4 7600.0 7677.7 7718.1 8462.8 8470.2 8531.4 8587.4 8602.3 7589.9 7624.6 7652.0 7725.3 7785.4 6709.8 7157.6 7421.4 7453.0 7570.6 6913.4 7042.4 7075.0 7075.7 7084.5 4865.5 4929.5 5031.8 5119.8 5184.9 3850.9 4491.3 5098.5 5133.1 5226.1 16:13:03 INFO - PROCESS | 1659 | 16:13:03 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4653.94 Median:5035.69 stddev:1499.43 (29.8%) stddev-sans-first:1467.45 16:13:03 INFO - PROCESS | 1659 | Values: 291.2 297.2 309.2 310.8 314.7 4455.4 4908.6 5110.6 5488.6 5718.5 5487.4 5555.7 5592.8 5594.9 5621.9 3383.3 3746.6 3871.2 4045.8 4344.4 3451.7 3920.9 4189.1 4353.5 4365.4 3662.0 3855.6 4061.0 4157.8 4172.9 3282.6 3705.6 4027.3 4166.6 4188.5 3606.2 3614.0 3630.1 3631.6 3635.8 5046.9 5390.5 5459.5 5469.2 5493.6 3995.2 4387.7 4765.1 4775.5 4778.2 5882.9 5886.9 5896.0 5935.9 5936.3 3780.0 4027.2 4054.1 4058.2 4073.7 6223.3 6252.9 6261.8 6267.7 6268.5 3650.6 3922.4 3943.6 4192.0 4193.6 3539.6 4074.6 4168.8 4216.5 4262.8 4236.7 4845.8 4878.0 4879.6 4889.9 5702.4 5901.8 5905.3 5942.9 6000.5 1107.3 1335.8 1388.3 1435.9 1449.3 742.1 847.6 887.8 895.7 895.8 3619.8 3922.4 4057.8 4502.5 4537.4 4258.0 4305.0 4709.3 4905.8 5024.4 4009.9 4314.7 4374.2 4389.8 4476.0 2186.5 2929.7 3196.8 3240.2 3240.7 6348.4 6370.4 6383.9 6394.4 6407.9 5477.5 5546.5 6133.5 6303.6 6322.6 5930.3 6190.6 6219.6 6283.9 6295.8 5494.2 5780.5 5913.9 6073.4 6127.2 5865.4 5947.3 5992.8 6009.4 6024.1 5700.9 6301.9 6330.7 6333.7 6355.4 3722.3 3791.8 3939.8 3986.8 3993.6 5807.0 5937.6 5975.1 5996.3 6003.6 4533.8 4771.6 5318.0 5863.3 5976.0 4983.7 5064.0 5848.7 5857.4 5910.8 5434.4 5490.3 5700.2 5723.9 5783.7 4936.4 5239.9 5427.2 5916.0 5918.6 5751.5 5763.5 5774.7 5786.4 5892.7 16:13:03 INFO - PROCESS | 1659 | 16:13:03 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:26481.00 Median:13030.09 stddev:43920.21 (337.1%) stddev-sans-first:44000.78 16:13:03 INFO - PROCESS | 1659 | Values: 705.2 709.6 709.8 727.2 774.5 15278.7 15740.4 15903.7 15926.8 15934.0 12764.9 16157.0 16191.8 16220.3 16221.9 731.6 832.3 858.4 866.0 869.9 694.1 834.9 852.5 857.0 868.5 912.0 912.3 913.7 915.1 915.7 882.2 901.6 906.7 906.9 907.6 672.6 672.6 673.3 673.4 674.4 15291.6 15367.8 15371.5 15386.7 15386.8 10537.5 12347.5 12470.3 12514.0 12750.5 11726.3 11732.8 11831.7 11966.9 12248.8 3795.6 3810.9 3819.6 3847.3 3942.8 121952.0 123792.4 124186.4 125645.0 126315.6 11048.7 11051.6 11125.1 11160.2 11368.5 18447.6 22363.8 22499.0 22585.4 22744.2 8039.9 8057.6 8091.0 8290.5 8334.2 4439.4 4524.9 4539.6 4540.4 4611.4 3316.0 3639.2 3762.3 3767.4 3772.1 571.6 658.6 665.7 680.7 693.4 615.5 630.4 646.7 675.7 678.1 7807.3 8259.9 8280.9 9405.4 9698.6 594.1 632.8 641.0 646.3 719.6 3803.8 4017.5 4045.5 4098.4 4422.1 140352.0 165735.0 170106.0 174687.1 175542.0 119254.4 146427.0 147254.0 149576.0 151503.2 127625.4 128284.7 129452.0 131236.0 132635.3 8084.9 8468.8 9662.4 10173.2 10256.4 50480.0 56794.0 56995.0 60067.8 62019.7 72141.0 83011.6 84071.0 93197.5 95924.5 14518.6 14538.5 14561.5 14681.5 15133.4 14900.6 15534.8 15758.1 15820.3 16303.6 14600.3 14657.3 14666.7 14848.0 15122.3 14571.3 14595.0 14614.6 14920.8 15218.5 11204.6 12197.9 13586.7 14052.9 14063.6 11326.4 11333.3 11412.9 11760.8 11860.6 9006.9 10784.4 11545.8 11692.7 11747.9 16:13:03 INFO - PROCESS | 1659 | -------- Summary: end -------- 16:13:03 INFO - PROCESS | 1659 | 16:13:04 INFO - TEST-INFO | 1659: exit 0 16:13:04 INFO - TEST-OK | dromaeo_css | took 1114072ms 16:13:04 INFO - TEST-START | kraken 16:13:04 INFO - operating with platform_type : mac_ 16:13:04 INFO - Initialising browser for kraken test... 16:13:04 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/tmpAXfH3U/profile http://localhost:49266/getInfo.html) 16:13:07 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 16:13:07 INFO - PROCESS | 1668 | colorDepth:24 16:13:07 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 16:13:07 INFO - PROCESS | 1668 | __metrics 16:13:07 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 16:13:07 INFO - TEST-INFO | 1668: exit 0 16:13:07 INFO - Browser initialized. 16:13:07 INFO - Running cycle 1/1 for kraken test... 16:13:07 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/tmpAXfH3U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:13:19 INFO - PROCESS | 1670 | RSS: Main: 254349312 16:13:19 INFO - PROCESS | 1670 | 16:13:22 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 16:13:23 INFO - PROCESS | 1670 | RSS: Main: 267436032 16:13:23 INFO - PROCESS | 1670 | 16:13:26 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 16:13:26 INFO - PROCESS | 1670 | RSS: Main: 276279296 16:13:26 INFO - PROCESS | 1670 | 16:13:30 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 16:13:30 INFO - PROCESS | 1670 | RSS: Main: 279302144 16:13:30 INFO - PROCESS | 1670 | 16:13:33 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 16:13:33 INFO - PROCESS | 1670 | RSS: Main: 280674304 16:13:33 INFO - PROCESS | 1670 | 16:13:35 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:13:36 INFO - PROCESS | 1670 | RSS: Main: 282394624 16:13:36 INFO - PROCESS | 1670 | 16:13:39 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 16:13:40 INFO - PROCESS | 1670 | RSS: Main: 282251264 16:13:40 INFO - PROCESS | 1670 | 16:13:43 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 16:13:43 INFO - PROCESS | 1670 | RSS: Main: 282726400 16:13:43 INFO - PROCESS | 1670 | 16:13:46 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 16:13:47 INFO - PROCESS | 1670 | RSS: Main: 282730496 16:13:47 INFO - PROCESS | 1670 | 16:13:49 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:13:49 INFO - PROCESS | 1670 | RSS: Main: 282537984 16:13:49 INFO - PROCESS | 1670 | 16:13:51 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:13:52 INFO - PROCESS | 1670 | RSS: Main: 282935296 16:13:52 INFO - PROCESS | 1670 | 16:13:54 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:13:55 INFO - PROCESS | 1670 | RSS: Main: 282988544 16:13:55 INFO - PROCESS | 1670 | 16:13:58 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:13:58 INFO - PROCESS | 1670 | RSS: Main: 282992640 16:13:58 INFO - PROCESS | 1670 | 16:14:02 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:14:02 INFO - PROCESS | 1670 | RSS: Main: 283041792 16:14:02 INFO - PROCESS | 1670 | 16:14:04 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 16:14:04 INFO - PROCESS | 1670 | RSS: Main: 284241920 16:14:04 INFO - PROCESS | 1670 | 16:14:04 INFO - PROCESS | 1670 | __start_tp_report 16:14:04 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 16:14:04 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 16:14:04 INFO - PROCESS | 1670 | |i|pagename|runs| 16:14:04 INFO - PROCESS | 1670 | |0;ai-astar;105;117;108;118;118;118;116;115;129;118 16:14:04 INFO - PROCESS | 1670 | |1;audio-beat-detection;146;111;135;162;131;169;151;133;171;146 16:14:04 INFO - PROCESS | 1670 | |2;audio-dft;200;213;222;206;197;210;201;200;197;236 16:14:04 INFO - PROCESS | 1670 | |3;audio-fft;73;91;106;138;84;86;85;60;136;64 16:14:04 INFO - PROCESS | 1670 | |4;audio-oscillator;77;99;124;101;102;73;140;60;80;101 16:14:04 INFO - PROCESS | 1670 | |5;imaging-gaussian-blur;78;129;95;132;133;106;93;90;80;130 16:14:04 INFO - PROCESS | 1670 | |6;imaging-darkroom;138;98;96;105;97;97;97;97;107;127 16:14:04 INFO - PROCESS | 1670 | |7;imaging-desaturate;91;95;90;91;95;90;78;152;149;91 16:14:04 INFO - PROCESS | 1670 | |8;json-parse-financial;55;56;58;57;57;57;56;58;54;55 16:14:04 INFO - PROCESS | 1670 | |9;json-stringify-tinderbox;69;74;79;69;75;85;74;73;75;73 16:14:04 INFO - PROCESS | 1670 | |10;stanford-crypto-aes;89;87;83;88;86;85;86;91;85;83 16:14:04 INFO - PROCESS | 1670 | |11;stanford-crypto-ccm;168;157;152;139;136;137;132;155;135;164 16:14:04 INFO - PROCESS | 1670 | |12;stanford-crypto-pbkdf2;233;213;164;221;238;172;203;234;169;175 16:14:04 INFO - PROCESS | 1670 | |13;stanford-crypto-sha256-iterative;66;64;64;67;67;68;68;67;83;85 16:14:04 INFO - PROCESS | 1670 | __end_tp_report 16:14:04 INFO - PROCESS | 1670 | __start_cc_report 16:14:04 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,1072 16:14:04 INFO - PROCESS | 1670 | __end_cc_report 16:14:04 INFO - PROCESS | 1670 | __startTimestamp1470438844694__endTimestamp 16:14:04 INFO - PROCESS | 1670 | 16:14:04 INFO - PROCESS | 1670 | ------- Summary: start ------- 16:14:04 INFO - PROCESS | 1670 | Number of tests: 14 16:14:04 INFO - PROCESS | 1670 | 16:14:04 INFO - PROCESS | 1670 | [#0] ai-astar Cycles:10 Average:116.20 Median:118.00 stddev:6.43 (5.4%) stddev-sans-first:5.39 16:14:04 INFO - PROCESS | 1670 | Values: 105.0 117.0 108.0 118.0 118.0 118.0 116.0 115.0 129.0 118.0 16:14:04 INFO - PROCESS | 1670 | 16:14:04 INFO - PROCESS | 1670 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:148.50 stddev:18.77 (12.6%) stddev-sans-first:19.91 16:14:04 INFO - PROCESS | 1670 | Values: 146.0 111.0 135.0 162.0 131.0 169.0 151.0 133.0 171.0 146.0 16:14:04 INFO - PROCESS | 1670 | 16:14:04 INFO - PROCESS | 1670 | [#2] audio-dft Cycles:10 Average:208.20 Median:208.00 stddev:12.61 (6.1%) stddev-sans-first:13.02 16:14:04 INFO - PROCESS | 1670 | Values: 200.0 213.0 222.0 206.0 197.0 210.0 201.0 200.0 197.0 236.0 16:14:04 INFO - PROCESS | 1670 | 16:14:04 INFO - PROCESS | 1670 | [#3] audio-fft Cycles:10 Average:92.30 Median:78.50 stddev:27.01 (34.4%) stddev-sans-first:27.73 16:14:04 INFO - PROCESS | 1670 | Values: 73.0 91.0 106.0 138.0 84.0 86.0 85.0 60.0 136.0 64.0 16:14:04 INFO - PROCESS | 1670 | 16:14:04 INFO - PROCESS | 1670 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:66.50 stddev:24.17 (36.3%) stddev-sans-first:24.67 16:14:04 INFO - PROCESS | 1670 | Values: 77.0 99.0 124.0 101.0 102.0 73.0 140.0 60.0 80.0 101.0 16:14:04 INFO - PROCESS | 1670 | 16:14:04 INFO - PROCESS | 1670 | [#5] imaging-gaussian-blur Cycles:10 Average:106.60 Median:79.00 stddev:22.39 (28.3%) stddev-sans-first:21.22 16:14:04 INFO - PROCESS | 1670 | Values: 78.0 129.0 95.0 132.0 133.0 106.0 93.0 90.0 80.0 130.0 16:14:04 INFO - PROCESS | 1670 | 16:14:04 INFO - PROCESS | 1670 | [#6] imaging-darkroom Cycles:10 Average:105.90 Median:97.00 stddev:14.74 (15.2%) stddev-sans-first:10.06 16:14:04 INFO - PROCESS | 1670 | Values: 138.0 98.0 96.0 105.0 97.0 97.0 97.0 97.0 107.0 127.0 16:14:04 INFO - PROCESS | 1670 | 16:14:04 INFO - PROCESS | 1670 | [#7] imaging-desaturate Cycles:10 Average:102.20 Median:91.00 stddev:25.89 (28.5%) stddev-sans-first:27.14 16:14:04 INFO - PROCESS | 1670 | Values: 91.0 95.0 90.0 91.0 95.0 90.0 78.0 152.0 149.0 91.0 16:14:04 INFO - PROCESS | 1670 | 16:14:04 INFO - PROCESS | 1670 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:57.00 stddev:1.34 (2.3%) stddev-sans-first:1.33 16:14:04 INFO - PROCESS | 1670 | Values: 55.0 56.0 58.0 57.0 57.0 57.0 56.0 58.0 54.0 55.0 16:14:04 INFO - PROCESS | 1670 | 16:14:04 INFO - PROCESS | 1670 | [#9] json-stringify-tinderbox Cycles:10 Average:74.60 Median:74.50 stddev:4.67 (6.3%) stddev-sans-first:4.49 16:14:04 INFO - PROCESS | 1670 | Values: 69.0 74.0 79.0 69.0 75.0 85.0 74.0 73.0 75.0 73.0 16:14:04 INFO - PROCESS | 1670 | 16:14:04 INFO - PROCESS | 1670 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:86.50 stddev:2.54 (2.9%) stddev-sans-first:2.50 16:14:04 INFO - PROCESS | 1670 | Values: 89.0 87.0 83.0 88.0 86.0 85.0 86.0 91.0 85.0 83.0 16:14:04 INFO - PROCESS | 1670 | 16:14:04 INFO - PROCESS | 1670 | [#11] stanford-crypto-ccm Cycles:10 Average:147.50 Median:153.50 stddev:13.21 (8.6%) stddev-sans-first:11.74 16:14:04 INFO - PROCESS | 1670 | Values: 168.0 157.0 152.0 139.0 136.0 137.0 132.0 155.0 135.0 164.0 16:14:04 INFO - PROCESS | 1670 | 16:14:04 INFO - PROCESS | 1670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:202.20 Median:217.00 stddev:29.68 (13.7%) stddev-sans-first:29.31 16:14:04 INFO - PROCESS | 1670 | Values: 233.0 213.0 164.0 221.0 238.0 172.0 203.0 234.0 169.0 175.0 16:14:04 INFO - PROCESS | 1670 | 16:14:04 INFO - PROCESS | 1670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:67.50 stddev:7.58 (11.2%) stddev-sans-first:7.91 16:14:04 INFO - PROCESS | 1670 | Values: 66.0 64.0 64.0 67.0 67.0 68.0 68.0 67.0 83.0 85.0 16:14:04 INFO - PROCESS | 1670 | -------- Summary: end -------- 16:14:04 INFO - PROCESS | 1670 | 16:14:05 INFO - TEST-INFO | 1670: exit 0 16:14:05 INFO - TEST-OK | kraken | took 61142ms 16:14:05 INFO - SUITE-END | took 1175s 16:14:05 INFO - Completed test suite (00:19:35) 16:14:05 INFO - javascript benchmark 16:14:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7393.049319428753, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2810.817296875703, 3369.477730951702, 3456.2396272819988, 3504.334176506465, 3509.736769742269, 5134.537891589756, 5595.524380427663, 5791.652500849952, 5890.116482527623, 5955.702214889249, 5478.945210547893, 5576.33084029917, 5898.292204935403, 5911.379305172959, 5945.554083443748, 5291.68249905005, 5373.623846330758, 5388.595855310848, 5442.319710036246, 5475.5072043516075, 5427.185922111676, 5434.239206511092, 5472.315960504937, 5491.780328786844, 5547.611667183299, 5281.603879709037, 5285.86785330366, 5373.892522149574, 5416.729163541847, 5445.673259604397, 5390.97304513475, 5392.137258038734, 5393.002294575516, 5420.457954204588, 5423.755930983115, 4286.914261714779, 5088.465711100355, 5247.239150323182, 5259.21111833228, 5322.547583455411, 5637.605367624268, 5914.083317085859, 5924.348321684654, 5930.288365396137, 5999.160117583542, 6213.502919766408, 6224.906626400608, 6224.9688751556405, 6272.717727702265, 6283.931731605638, 6198.2252218472695, 6271.780487682955, 6280.528960327993, 6292.961661325876, 6295.748170073191, 5604.9911016016695, 5899.705014749288, 5941.22764040672, 5963.880722385615, 6056.121862329937, 5776.508996735324, 6378.107065010902, 6381.329960354189, 6400.199975003125, 6402.071699603532, 6098.401972603781, 6190.164327815777, 6205.906911396332, 6225.906611400833, 6268.247810262797, 6194.194754681953, 6209.813705588839, 6223.813285601439, 6305.369463053658, 6324.146240257598, 6221.160143380585, 6247.968760156261, 6248.9062664060075, 6261.686915654199, 6274.592151510228, 6121.81881567809, 6244.438000579969, 6251.0, 6253.6873156342, 6257.2804127525915, 5006.998600279959, 5011.473795251519, 5026.84919452417, 5041.924371134436, 5084.161113416245, 4471.06107717383, 4501.729896206172, 4506.932396014063, 4516.299973504112, 4518.209313370213, 5758.193852860602, 5860.267466566679, 5890.116482527569, 5922.437368449991, 5982.910256346158, 6178.5366097542865, 6184.350643182491, 6226.0, 6276.246850377984, 6299.212598425197, 4929.507049295042, 5903.645781253139, 5939.46544810969, 5966.343702192756, 5996.280446346466, 5467.1799230115, 5554.833354999357, 5565.582581306418, 5569.0254205513875, 5578.135389014709, 6374.904376434357, 6376.936230637634, 6383.329750376237, 6481.935180648133, 6498.545101843015, 6190.0, 6246.781362652286, 6266.780662676967, 6268.686565671789, 6272.40412160844, 6318.8736225274315, 6426.871462570629, 6463.870722585616, 6515.804525864231, 6538.346165383614, 6192.3807619239515, 6229.595076320024, 6243.906341404791, 6306.968465157828, 6315.147455093504, 6245.531585131224, 6255.968720156552, 6264.655443950626, 6267.0, 6267.811965641038, 5210.0, 6099.908501372394, 6256.186695729526, 6260.655663938527, 6270.843228919131, 4474.955250447584, 6142.652254521386, 6180.721867516063, 6249.625022498664, 6269.937300627118, 5991.610545314541, 6014.278286605635, 6057.636541807506, 6159.907601385893, 6164.969175154096, 6106.32830388648, 6217.658028808278, 6240.937590624036, 6246.9062964054665, 6288.0, 4970.254461830755, 4989.675671081513, 6076.422739839708, 6133.304060594526, 6145.9692701536205], "value": 5757.326352843077, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.6148673291466, 529.6768970927736, 541.2963147907719, 545.2965674280177, 567.7728908436627, 37825.865224043286, 40451.59548404515, 40557.0, 40570.0, 40693.38959915596, 42039.57960420395, 42305.15389692204, 42435.787821060854, 42553.57446425535, 42616.78691606545, 9414.0, 9697.757556061084, 9715.077067678594, 9715.222782177409, 9736.561854716554, 9544.236461083097, 9598.0, 9635.759106022371, 9647.614095436174, 9660.227181825472, 9611.375260608072, 9646.324757266993, 9649.565769540388, 9656.420614763101, 9676.419414835133, 9544.33189676723, 9585.904140958572, 9598.95200523993, 9605.807883842284, 9609.471479068718, 9635.470049147294, 9657.71026869195, 9718.368306060083, 9729.027097290285, 9777.511124443748, 38753.80623096895, 39487.60512394868, 39708.80145599283, 39741.0, 39874.60125398738, 3344.365611003199, 3394.8132852693093, 3469.1847415857255, 3472.2534655049035, 3851.691864650821, 32183.19542011445, 32741.836290818632, 32807.50788738171, 33027.504587430965, 33333.33333333344, 3245.2535916739284, 3268.7548433867555, 3294.7528935329947, 3300.389427955836, 3402.2004828865197, 424762.8761856202, 495243.0, 495650.0, 500598.0, 503035.0, 59332.70333648391, 59669.701651491465, 59742.40257597368, 59744.0, 59876.40123598708, 28416.0, 29653.555196672067, 32754.0, 36425.817870910476, 36524.26951460956, 16198.838011619733, 16370.508884733477, 16378.099204543865, 16409.0, 16413.67172656564, 12441.75116497665, 12446.25322480654, 12530.937345313398, 12544.937275313565, 12547.435365408579, 19255.903720481307, 19371.727748691166, 19409.61180776405, 19483.318083866998, 19535.34749227224, 7969.481983671043, 8130.837383252302, 8165.836683266301, 8174.3460523158, 8195.46729462583, 733.3729661139755, 921.3826736086838, 992.7815880506278, 1062.4528367890543, 1096.1176253116319, 22543.549129017327, 26713.599296010576, 30265.697343026728, 30831.383372332428, 31108.066757997298, 910.1626503616689, 950.6720181537358, 1050.7583255851198, 1110.5779803674552, 1167.3579531257774, 11282.887171128348, 12994.935025325001, 13253.000059702734, 13513.324333783468, 13600.31998400076, 687302.0, 694783.0, 694809.0, 695242.0, 695614.0, 42691.14617707628, 43372.349414758806, 43801.56198438039, 43910.0, 43996.780016099714, 1355.979660305096, 1387.5421111033336, 1393.4704812171512, 1402.677384201619, 1412.1244828206577, 29928.0, 29964.550531741606, 30379.848100759355, 30507.84746076344, 30517.694823051486, 51880.740596296775, 52287.47712522826, 52388.47611523836, 52422.73788631032, 52513.7374313126, 582457.0, 585547.0, 585631.0, 586434.0678296582, 587353.0, 23146.53706925886, 27063.729362706123, 27220.72779272182, 27233.91064357483, 27237.72762272352, 39621.2075758489, 48173.75913120412, 48760.75619621879, 50060.0, 50061.0, 39946.80026599965, 40215.99460013523, 41494.377584336864, 41769.0, 41872.79063604662, 32540.674593253763, 34862.477062844584, 39439.80280098581, 39888.6038988634, 41036.0, 28329.71670283353, 38250.42624360581, 39219.21561568695, 39660.0, 41273.79363103165, 30755.384892302478, 34835.303293934485, 35409.29181416306, 36063.27873442569, 36363.45454818233, 26161.345966350993, 26260.737392626594, 26424.0751573694, 26505.60241596416, 26972.0], "value": 19590.57605078544, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.75575875680806, 383.12456037953274, 386.17551527488814, 395.85749130313064, 408.62202462721996, 19927.800721992775, 21226.57546849066, 21678.24126155585, 21955.780442195573, 22044.33866983991, 20811.479713007182, 20827.27104551341, 20839.374818755423, 20893.791062089374, 21149.471263218427, 5926.081143108023, 6023.337432882401, 6157.969210153943, 6224.751009959597, 6248.812535623916, 4220.767857767822, 6081.391860813906, 6159.445649891509, 6501.382368674968, 6820.31796820319, 6783.389494945454, 6811.727530898758, 6820.93179068208, 6830.077939478157, 6843.213030501482, 6596.802095937105, 6835.28229535899, 6836.1113055302985, 6846.418054465352, 6847.349501797371, 5766.192733017381, 5937.990541607937, 5980.880382392371, 5980.910286345708, 5984.8503787405225, 20442.897785510977, 22903.08387664508, 23985.0, 26410.73589264102, 26480.470390592272, 2350.764923507653, 2489.950200995988, 2494.2018554062706, 2986.2982199183175, 3083.9977007472435, 15511.301991410413, 15623.375064997386, 15685.764713529306, 15985.520434386986, 16344.264508097163, 1885.6982882738696, 1895.7630296212974, 1916.1281616864294, 1923.6438310990857, 1932.420273917819, 92557.0, 99268.0, 100247.49876250573, 100641.0, 101715.49142254316, 10638.627648032436, 10802.135829133651, 10918.126549875991, 11101.500432480558, 11193.048590869867, 13742.381592828347, 13772.0, 13813.963952703387, 13828.686274803878, 13843.861561384258, 8615.784605384915, 8664.393492455594, 8678.6528538859, 8704.608292626846, 8750.69372571957, 7129.3583577478275, 8643.265322447536, 8707.869381959275, 8720.127987201357, 8919.687810926587, 6163.952128138228, 6325.8734825304155, 6687.732490700415, 6784.0841486399695, 6832.965835170792, 1408.3732738931078, 1598.5444148417646, 1689.4255952976048, 1854.6754317994296, 1889.9244030238635, 802.9357651387875, 882.6292956958093, 932.6828878181451, 939.8674597110465, 1012.8227560177087, 20511.58976820455, 21175.576488470146, 21400.571988560143, 21510.677339839916, 21564.35306940794, 889.1952782731638, 964.1322809471532, 980.6224603527551, 985.1773768903046, 1043.3479075577764, 8859.3798434109, 10788.676339709822, 11096.889031109748, 11315.547378104948, 11454.427278636034, 473089.0, 547025.0, 547411.0, 578556.1072194612, 579387.0, 93464.0, 109956.0, 116149.4192529032, 120289.0, 120813.0, 818.2840014986887, 986.6201512417771, 1010.3836659637615, 1011.9747006324901, 1013.9290249682599, 15527.611809704847, 19029.0, 19065.951372674637, 19073.71389429132, 19124.33064842724, 50024.74987625039, 50534.0, 51281.48718512767, 51923.74038129785, 57548.71225643845, 81196.59401702954, 82128.58935705523, 82879.5856020716, 83647.0, 84323.0, 7124.358807707331, 7304.687889701441, 7508.924910750822, 7697.615119243904, 8210.384221183316, 10961.835572466578, 11193.216474846682, 11268.943655281671, 12294.385280735749, 12905.870941290843, 11077.501512431798, 11313.660590182308, 11609.709757256136, 11647.068234541386, 11689.298642081503, 9884.555195016384, 10763.3541987481, 11117.666470005914, 11239.831402529133, 11287.379194144401, 11340.149488788209, 11448.313101213955, 11610.593629222936, 11917.702057448287, 11939.582114625946, 7997.1203167652675, 8056.879146812919, 8250.174982501701, 8279.917200828155, 8430.83138337242, 7835.098963619257, 10618.681439556825, 11060.612878549213, 11389.943050285026, 11453.0], "value": 9770.877841733483, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1388.5417812122, 1498.3631956418524, 1563.421534032408, 1669.4073603870625, 1711.1615308498824, 7934.9206507934905, 8312.501249925, 8468.576571171432, 8877.156670116328, 8878.955605221972, 8483.448575842565, 8731.607077681503, 8743.825123497527, 8752.562371881397, 8769.166929141722, 2066.7933206679286, 2300.148944890393, 2372.9169479068237, 2376.512814872947, 2388.725296590897, 2332.8483648562874, 2363.52729454109, 2381.3332266965276, 2383.7497062808416, 2393.246127469841, 2349.036894873094, 2362.161432691387, 2369.6800931874236, 2386.427257458215, 2410.0, 2335.474518233384, 2347.0, 2356.8468049576722, 2362.0315670574983, 2366.0535785685693, 2320.164740693349, 2343.917962871308, 2362.303120579433, 2362.4093976505874, 2366.148186652804, 8676.60955257015, 8722.215000649909, 8722.738317850475, 8739.169778870997, 8761.21149096578, 5121.308623335839, 5216.139337009389, 5274.077036518594, 5323.733813309319, 5340.359156901197, 3413.675700808444, 3563.518924945125, 3573.76770509916, 3612.837422315976, 3622.130688634735, 1063.0698139128262, 1096.6655170173094, 1100.5432745410644, 1108.2906939558688, 1124.2299025167786, 11473.426328683616, 11617.0, 11656.825147622792, 11703.88296117045, 11715.238509496856, 3745.3071181830906, 4568.70303430276, 4653.278741795028, 4756.167670657621, 4819.0, 9754.853677194847, 9896.059874311928, 9900.356476828983, 9912.900870991198, 9926.007399260016, 4443.466783985942, 5274.657147285414, 5275.788968441219, 5284.07528682479, 5284.101702710548, 4363.585459381354, 4573.725576465423, 4690.859274221779, 4705.858824235278, 4834.105690447279, 3878.592747761501, 3984.601539845992, 3995.6403923647013, 4048.736832105904, 4066.4510291110914, 1080.4381721504774, 1113.832925061231, 1280.4686055287139, 1291.5802364231663, 1300.902432317561, 844.4806444036873, 911.5670056723136, 911.7811725185908, 919.3656377099779, 971.0580736685404, 5771.278590176228, 5960.225170727865, 6061.484773794277, 6137.478314343331, 6160.706251687196, 427.35256087028176, 428.7791787229517, 439.42435409613506, 441.66433510532227, 443.57195306529354, 3364.4616861302075, 3499.0202743231935, 3505.5793304803587, 3807.485989391452, 4067.9796601017397, 10316.535755891004, 10733.409662468483, 10787.0, 10828.566857325619, 10840.295380800222, 9141.497217653094, 10632.787344253225, 10661.626843060456, 10752.40861752611, 10755.516001779783, 6748.561343512656, 7265.455090868206, 8070.838583228303, 8203.917960820316, 8274.544900030436, 5970.223870896755, 6029.758809647565, 6073.726682299219, 6093.908591371044, 6212.72042758086, 10043.296969212377, 10064.647737329158, 10206.897931020594, 10210.132138768287, 10222.591096356062, 8230.506169629842, 9983.301168918106, 10196.235282354002, 10248.23138264648, 10400.895991039994, 7110.39561637246, 7544.4341674373545, 7600.049993750781, 7677.654505547152, 7718.112417072109, 8462.788430289293, 8470.15298470148, 8531.445456045338, 8587.441816281922, 8602.311815054905, 7589.924100759143, 7624.618769061413, 7652.0, 7725.266099720518, 7785.416093792875, 6709.7922373971205, 7157.642117894188, 7421.443391745749, 7452.956586077845, 7570.621468926642, 6913.3777959983845, 7042.366187043191, 7074.964625176841, 7075.6815943281645, 7084.468664850054, 4865.464798872192, 4929.531694489017, 5031.823886163967, 5119.769610367468, 5184.948150518447, 3850.9037274068373, 4491.281394976919, 5098.5411312982005, 5133.076046311699, 5226.085435048927], "value": 4462.460833228024, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.1962982169213, 297.2316561688036, 309.16217051789647, 310.79176951442525, 314.71203848478643, 4455.443069616302, 4908.607311415087, 5110.591152707784, 5488.588355873316, 5718.513926316263, 5487.38122253935, 5555.722153916895, 5592.7762889484375, 5594.916076258849, 5621.943780562193, 3383.323335332931, 3746.6253374662588, 3871.2257548490275, 4045.797710114497, 4344.415073031541, 3451.7238620910393, 3920.921581568367, 4189.0885834345145, 4353.499347575038, 4365.432493775805, 3662.0, 3855.55661098973, 4060.9796951015205, 4157.833686652531, 4172.937405938914, 3282.6013142389074, 3705.5923848376656, 4027.3153563894207, 4166.562510936338, 4188.518320393163, 3606.1969015492255, 3614.0, 3630.146915474861, 3631.5823680276844, 3635.763675361093, 5046.924296135561, 5390.4879036491475, 5459.508644222039, 5469.15228139639, 5493.587980901409, 3995.2409042281874, 4387.714798538085, 4765.0946320199055, 4775.516731299705, 4778.2115950868065, 5882.852928676774, 5886.852828679274, 5895.970520147372, 5935.910961335583, 5936.298983962287, 3780.0, 4027.2146931348398, 4054.1080962188566, 4058.2289365020847, 4073.6537394321517, 6223.315435302158, 6252.874942501125, 6261.812145635593, 6267.655278959655, 6268.5298602604535, 3650.6166852480637, 3922.4116382542275, 3943.63944439168, 4191.952011997001, 4193.601607847249, 3539.584166333436, 4074.6129117733767, 4168.791560422027, 4216.51510076339, 4262.8064142040275, 4236.703430759879, 4845.830395936126, 4877.975610121926, 4879.609631229493, 4889.877753056131, 5702.429757024264, 5901.822945311647, 5905.261842269716, 5942.940570594239, 6000.549958753111, 1107.3189988157226, 1335.7977819962111, 1388.3270658856054, 1435.9497417590544, 1449.311577000916, 742.1131747561612, 847.631280393031, 887.8490656588395, 895.7223260789176, 895.8297923394534, 3619.7647152934974, 3922.431027588987, 4057.756534607874, 4502.482214545369, 4537.387452693844, 4257.957420425818, 4305.0, 4709.281112393952, 4905.8226025754275, 5024.447310795809, 4009.939850902239, 4314.676399270004, 4374.234508960919, 4389.846355377546, 4476.0, 2186.486175748698, 2929.6777354490987, 3196.840157992091, 3240.1737556922835, 3240.724538414261, 6348.396902294275, 6370.394812492806, 6383.872322553523, 6394.401399650087, 6407.871842563122, 5477.4796394342475, 5546.473085056913, 6133.473252879523, 6303.590266632654, 6322.620642761449, 5930.318013428425, 6190.597611155261, 6219.631681030166, 6283.905741413882, 6295.779647712399, 5494.203340515683, 5780.508656764054, 5913.900565299256, 6073.392660733891, 6127.234095738033, 5865.354810970875, 5947.31605865331, 5992.831397877547, 6009.437546237922, 6024.1265016573225, 5700.8883267762385, 6301.873962520633, 6330.683465826598, 6333.6748207191595, 6355.3644635536075, 3722.2927643747603, 3791.7676755055268, 3939.8030098495533, 3986.800659967048, 3993.6206060424215, 5807.0, 5937.614055086578, 5975.056462734574, 5996.280446346466, 6003.609765365237, 4533.778448560248, 4771.618270538279, 5317.995332637048, 5863.296404431496, 5976.0, 4983.710750904385, 5064.012517559041, 5848.678322692293, 5857.414258574108, 5910.822675319747, 5434.396852928317, 5490.321484605244, 5700.230468886647, 5723.885522289447, 5783.710814459176, 4936.43231028422, 5239.899621079616, 5427.185922111715, 5916.0, 5918.644881307136, 5751.511121554715, 5763.4812866842185, 5774.729559496904, 5786.363500014911, 5892.734826932884], "value": 4173.060067745118, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.1679018757866, 709.58489283769, 709.8260926073112, 727.1673933346318, 774.4694884004454, 15278.694426111471, 15740.449084282052, 15903.681926361465, 15926.84073159268, 15934.0, 12764.936175319133, 16157.0, 16191.83808161918, 16220.270087846045, 16221.91889040556, 731.5683746589511, 832.2925513313695, 858.4377232912452, 866.0343716755835, 869.9043105258448, 694.0872752330669, 834.8747687846811, 852.4757274276337, 856.9785755356135, 868.4745728834059, 912.0013585124278, 912.3020889019905, 913.6665117232229, 915.0894859614659, 915.716128000322, 882.1839798186684, 901.5627420700955, 906.6690657909882, 906.8957069936976, 907.5552979040289, 672.559473544829, 672.6199697171082, 673.3098573961679, 673.3905815237218, 674.4199988010307, 15291.617709557238, 15367.846321536865, 15371.461998830098, 15386.692266154727, 15386.769198462032, 10537.473126343652, 12347.506099756, 12470.251784892935, 12514.0, 12750.489980400773, 11726.296422214695, 11732.765344693144, 11831.728735975374, 11966.940165299118, 12248.755024899541, 3795.5824859265736, 3810.866619668326, 3819.598942111094, 3847.288251673421, 3942.7634341939574, 121952.0, 123792.38103809513, 124186.37906810499, 125645.0, 126315.57895473707, 11048.668539943814, 11051.613193538187, 11125.054370378608, 11160.16298777595, 11368.545258189744, 18447.631047378978, 22363.769992650236, 22498.98754556049, 22585.4353641157, 22744.203952861903, 8039.919600804034, 8057.6374063167295, 8091.0, 8290.544020078833, 8334.249917507332, 4439.4006809080365, 4524.882367014934, 4539.614132798749, 4540.432445944257, 4611.354410382549, 3315.983420082884, 3639.1811842335264, 3762.285165818486, 3767.3783825668456, 3772.0569857535615, 571.5941681406248, 658.6180015590945, 665.7370338716277, 680.7004917836136, 693.4244577001077, 615.5137441421227, 630.4452082167663, 646.7089809585706, 675.6554157379674, 678.064271305605, 7807.336376407955, 8259.876101858477, 8280.917190828015, 9405.43567385959, 9698.563564639608, 594.0673143165276, 632.8481164520482, 640.9775657852047, 646.3278190681732, 719.6401799100449, 3803.847846086181, 4017.517897852218, 4045.5145382554283, 4098.426220329156, 4422.071365013319, 140352.0, 165735.0, 170106.0, 174687.12656436636, 175542.0, 119254.40372798254, 146427.0, 147254.0, 149576.0, 151503.18235679422, 127625.36187319004, 128284.71715282727, 129452.0, 131236.0, 132635.33682331527, 8084.919150808417, 8468.788280293042, 9662.420254784736, 10173.186145108226, 10256.38461692301, 50480.0, 56794.0, 56995.0, 60067.79186497474, 62019.689901550206, 72141.0, 83011.5849420749, 84071.0, 93197.5340123295, 95924.52037739767, 14518.564443066725, 14538.491152809602, 14561.490347837775, 14681.48614798477, 15133.394664213309, 14900.62748431298, 15534.766978495558, 15758.133302668462, 15820.28808703634, 16303.556650148012, 14600.342984565932, 14657.340419681354, 14666.70666586641, 14848.0, 15122.319495622503, 14571.271436428347, 14595.0, 14614.561563153122, 14920.780803580505, 15218.467353643013, 11204.551817927517, 12197.939010304892, 13586.660333491742, 14052.929735351257, 14063.578092656828, 11326.433678316216, 11333.320000799979, 11412.90309761749, 11760.823587646364, 11860.644180674593, 9006.864897026418, 10784.406857622593, 11545.82681259765, 11692.70768230767, 11747.88395102464], "value": 7955.461343792813, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1609.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 117.0, 108.0, 118.0, 118.0, 118.0, 116.0, 115.0, 129.0, 118.0], "value": 116.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 111.0, 135.0, 162.0, 131.0, 169.0, 151.0, 133.0, 171.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 213.0, 222.0, 206.0, 197.0, 210.0, 201.0, 200.0, 197.0, 236.0], "value": 208.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 91.0, 106.0, 138.0, 84.0, 86.0, 85.0, 60.0, 136.0, 64.0], "value": 92.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 99.0, 124.0, 101.0, 102.0, 73.0, 140.0, 60.0, 80.0, 101.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 129.0, 95.0, 132.0, 133.0, 106.0, 93.0, 90.0, 80.0, 130.0], "value": 106.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 98.0, 96.0, 105.0, 97.0, 97.0, 97.0, 97.0, 107.0, 127.0], "value": 105.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 95.0, 90.0, 91.0, 95.0, 90.0, 78.0, 152.0, 149.0, 91.0], "value": 102.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 58.0, 57.0, 57.0, 57.0, 56.0, 58.0, 54.0, 55.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 79.0, 69.0, 75.0, 85.0, 74.0, 73.0, 75.0, 73.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 83.0, 88.0, 86.0, 85.0, 86.0, 91.0, 85.0, 83.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 157.0, 152.0, 139.0, 136.0, 137.0, 132.0, 155.0, 135.0, 164.0], "value": 147.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [233.0, 213.0, 164.0, 221.0, 238.0, 172.0, 203.0, 234.0, 169.0, 175.0], "value": 202.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 67.0, 67.0, 68.0, 68.0, 67.0, 83.0, 85.0], "value": 69.9, "unit": "score"}]}]} 16:14:05 INFO - Return code: 0 16:14:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:14:05 ERROR - # TBPL SUCCESS # 16:14:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:14:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:14:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:14:05 INFO - 2016-08-05 16:14:05.992 screenresolution[1675:10493] starting screenresolution argv=screenresolution get 16:14:05 INFO - 2016-08-05 16:14:05.995 screenresolution[1675:10493] Display 0: 1600x1200x32@60 16:14:06 INFO - 2016-08-05 16:14:06.001 screenresolution[1676:10496] starting screenresolution argv=screenresolution list 16:14:06 INFO - Available Modes on Display 0 16:14:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:14:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:14:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:14:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:14:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:14:06 INFO - Intel Iris: 16:14:06 INFO - Chipset Model: Intel Iris 16:14:06 INFO - Type: GPU 16:14:06 INFO - Bus: Built-In 16:14:06 INFO - VRAM (Dynamic, Max): 1536 MB 16:14:06 INFO - Vendor: Intel (0x8086) 16:14:06 INFO - Device ID: 0x0a2e 16:14:06 INFO - Revision ID: 0x0009 16:14:06 INFO - Displays: 16:14:06 INFO - Display: 16:14:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:14:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:14:06 INFO - Display Serial Number: 1600x1200 60 16:14:06 INFO - Main Display: Yes 16:14:06 INFO - Mirror: Off 16:14:06 INFO - Online: Yes 16:14:06 INFO - Rotation: Supported 16:14:06 INFO - Return code: 0 16:14:06 INFO - Running post-action listener: _resource_record_post_action 16:14:06 INFO - [mozharness: 2016-08-05 23:14:06.233681Z] Finished run-tests step (success) 16:14:06 INFO - Running post-run listener: _resource_record_post_run 16:14:06 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 37078016; Write bytes: 711860736; Read time: 242; Write time: 2088 16:14:06 INFO - TinderboxPrint: CPU usage
54.4% 16:14:06 INFO - TinderboxPrint: I/O read bytes / time
37,078,016 / 242 16:14:06 INFO - TinderboxPrint: I/O write bytes / time
711,860,736 / 2,088 16:14:06 INFO - TinderboxPrint: CPU idle
2,209.4 (45.6%) 16:14:06 INFO - TinderboxPrint: CPU system
979.4 (20.2%) 16:14:06 INFO - TinderboxPrint: CPU user
1,652.9 (34.1%) 16:14:06 INFO - TinderboxPrint: Swap in / out
443,981,824 / 0 16:14:06 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 397404672; Write bytes: 386795008; Read time: 29630; Write time: 865 16:14:06 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 30800896; Write bytes: 301882368; Read time: 183; Write time: 1170 16:14:06 INFO - Running post-run listener: _upload_blobber_files 16:14:06 INFO - Blob upload gear active. 16:14:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:14:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:14:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:14:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:14:07 INFO - (blobuploader) - INFO - Open directory for files ... 16:14:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:14:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:14:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:14:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:14:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:14:07 INFO - (blobuploader) - INFO - Done attempting. 16:14:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:14:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:14:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:14:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:14:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:14:08 INFO - (blobuploader) - INFO - Done attempting. 16:14:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:14:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:14:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:14:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:14:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:14:11 INFO - (blobuploader) - INFO - Done attempting. 16:14:11 INFO - (blobuploader) - INFO - Iteration through files over. 16:14:11 INFO - Return code: 0 16:14:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:14:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:14:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a7f7daebce511f55da6bde91f60852cfbfaa2904b9ffbe23f542ddd8c756dbf524d40b3b6ece42b288e8f7daddac54416cc1f6ed4d6ece855357281ba52c7f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6863005dae543add2eb29628c8d1628e7c3dd4d1fc4f775002d0aa07ba37b5e0b3d65713c77926b00a06156e341f532b24400ce9e0937663a2bde7ec24dfadcb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5fa6622574afee9d2ab5eaf193c45e1505f052b045ee398d89c2a65e0cdef5df9dfeb27921c6394dd5e684ec4023bc6f72f9c16a5d131adf1125bbc605e773f"} 16:14:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:14:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:14:11 INFO - Contents: 16:14:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a7f7daebce511f55da6bde91f60852cfbfaa2904b9ffbe23f542ddd8c756dbf524d40b3b6ece42b288e8f7daddac54416cc1f6ed4d6ece855357281ba52c7f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6863005dae543add2eb29628c8d1628e7c3dd4d1fc4f775002d0aa07ba37b5e0b3d65713c77926b00a06156e341f532b24400ce9e0937663a2bde7ec24dfadcb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5fa6622574afee9d2ab5eaf193c45e1505f052b045ee398d89c2a65e0cdef5df9dfeb27921c6394dd5e684ec4023bc6f72f9c16a5d131adf1125bbc605e773f"} 16:14:11 INFO - Running post-run listener: copy_logs_to_upload_dir 16:14:11 INFO - Copying logs to upload dir... 16:14:11 INFO - mkdir: /builds/slave/test/build/upload/logs 16:14:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.161652 ========= master_lag: 0.19 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-05 16:14:11.476039) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 16:14:11.481013) ========= 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.qX8LY5qEds/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.PnKL3i0mmr/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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/3a7f7daebce511f55da6bde91f60852cfbfaa2904b9ffbe23f542ddd8c756dbf524d40b3b6ece42b288e8f7daddac54416cc1f6ed4d6ece855357281ba52c7f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6863005dae543add2eb29628c8d1628e7c3dd4d1fc4f775002d0aa07ba37b5e0b3d65713c77926b00a06156e341f532b24400ce9e0937663a2bde7ec24dfadcb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5fa6622574afee9d2ab5eaf193c45e1505f052b045ee398d89c2a65e0cdef5df9dfeb27921c6394dd5e684ec4023bc6f72f9c16a5d131adf1125bbc605e773f"} build_url:https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010938 build_url: 'https://queue.taskcluster.net/v1/task/OWxODCAUSyuEvvO6xdsHQQ/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/3a7f7daebce511f55da6bde91f60852cfbfaa2904b9ffbe23f542ddd8c756dbf524d40b3b6ece42b288e8f7daddac54416cc1f6ed4d6ece855357281ba52c7f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6863005dae543add2eb29628c8d1628e7c3dd4d1fc4f775002d0aa07ba37b5e0b3d65713c77926b00a06156e341f532b24400ce9e0937663a2bde7ec24dfadcb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5fa6622574afee9d2ab5eaf193c45e1505f052b045ee398d89c2a65e0cdef5df9dfeb27921c6394dd5e684ec4023bc6f72f9c16a5d131adf1125bbc605e773f"}' ========= master_lag: 0.45 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 16:14:11.944455) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-08-05 16:14:11.945222) ========= 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.qX8LY5qEds/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.PnKL3i0mmr/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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.005338 ========= master_lag: 4.60 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-08-05 16:14:16.546068) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 16:14:16.546382) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 16:14:16.547952) ========= ========= Total master_lag: 5.30 =========