builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0232 starttime: 1487785468.78 results: success (0) buildid: 20170222080928 builduid: b3a5c38c4763487e98d67fcc066aa45b revision: 7abeac2f2d668554f0093fc0bdb1488f9a77d16e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 09:44:28.777596) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 09:44:28.778078) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 09:44:28.778352) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 09:44:28.803543) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 09:44:28.803948) ========= 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.pnhsSqP8KQ/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.qf8OVzSLGe/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 --2017-02-22 09:44:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 164M=0s 2017-02-22 09:44:29 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.301367 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 09:44:29.126954) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 09:44:29.127264) ========= 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.pnhsSqP8KQ/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.qf8OVzSLGe/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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.025390 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 09:44:29.220574) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-22 09:44:29.220916) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7abeac2f2d668554f0093fc0bdb1488f9a77d16e --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 7abeac2f2d668554f0093fc0bdb1488f9a77d16e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pnhsSqP8KQ/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.qf8OVzSLGe/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 2017-02-22 09:44:29,331 truncating revision to first 12 chars 2017-02-22 09:44:29,331 Setting DEBUG logging. 2017-02-22 09:44:29,331 attempt 1/10 2017-02-22 09:44:29,331 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7abeac2f2d66?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-22 09:44:30,891 unpacking tar archive at: mozilla-central-7abeac2f2d66/testing/mozharness/ program finished with exit code 0 elapsedTime=1.847516 ========= master_lag: 0.15 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-22 09:44:31.216620) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 09:44:31.216948) ========= script_repo_revision: 7abeac2f2d668554f0093fc0bdb1488f9a77d16e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 09:44:31.217363) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 09:44:31.217691) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 09:44:31.235593) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-02-22 09:44:31.235959) ========= /tools/buildbot/bin/python -u 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', '-u', '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.pnhsSqP8KQ/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.qf8OVzSLGe/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:44:31 INFO - MultiFileLogger online at 20170222 09:44:31 in /builds/slave/test 09:44:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:44:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:44:31 INFO - {'append_to_log': False, 09:44:31 INFO - 'base_work_dir': '/builds/slave/test', 09:44:31 INFO - 'blob_upload_branch': 'Firefox', 09:44:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:44:31 INFO - 'branch': 'Firefox', 09:44:31 INFO - 'buildbot_json_path': 'buildprops.json', 09:44:31 INFO - 'config_files': ('talos/mac_config.py',), 09:44:31 INFO - 'default_actions': ('clobber', 09:44:31 INFO - 'read-buildbot-config', 09:44:31 INFO - 'download-and-extract', 09:44:31 INFO - 'populate-webroot', 09:44:31 INFO - 'create-virtualenv', 09:44:31 INFO - 'install', 09:44:31 INFO - 'run-tests'), 09:44:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:44:31 INFO - 'download_minidump_stackwalk': True, 09:44:31 INFO - 'download_symbols': 'ondemand', 09:44:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:44:31 INFO - 'tooltool.py': '/tools/tooltool.py', 09:44:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:44:31 INFO - '/tools/misc-python/virtualenv.py')}, 09:44:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:44:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:44:31 INFO - 'gecko_profile': False, 09:44:31 INFO - 'gecko_profile_interval': 0, 09:44:31 INFO - 'installer_path': 'installer.exe', 09:44:31 INFO - 'log_level': 'info', 09:44:31 INFO - 'log_name': 'talos', 09:44:31 INFO - 'log_to_console': True, 09:44:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:44:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:44:31 INFO - 'opt_config_files': (), 09:44:31 INFO - 'pip_index': False, 09:44:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:44:31 INFO - 'cmd': ('bash', 09:44:31 INFO - '-c', 09:44:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:44:31 INFO - 'enabled': True, 09:44:31 INFO - 'halt_on_failure': False, 09:44:31 INFO - 'name': 'check_screen_resolution'},), 09:44:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:44:31 INFO - 'cmd': ('bash', 09:44:31 INFO - '-c', 09:44:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:44:31 INFO - 'enabled': True, 09:44:31 INFO - 'halt_on_failure': False, 09:44:31 INFO - 'name': 'check_screen_resolution'},), 09:44:31 INFO - 'run_cmd_checks_enabled': True, 09:44:31 INFO - 'suite': 'dromaeojs-e10s', 09:44:31 INFO - 'system_bits': '32', 09:44:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:44:31 INFO - 'title': 't-yosemite-r7-0232', 09:44:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:44:31 INFO - 'use_talos_json': True, 09:44:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:44:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:44:31 INFO - 'work_dir': 'build'} 09:44:31 INFO - [mozharness: 2017-02-22 17:44:31.455665Z] Running clobber step. 09:44:31 INFO - Running pre-action listener: _resource_record_pre_action 09:44:31 INFO - Running main action method: clobber 09:44:31 INFO - rmtree: /builds/slave/test/build 09:44:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:44:33 INFO - Running post-action listener: _resource_record_post_action 09:44:33 INFO - [mozharness: 2017-02-22 17:44:33.940229Z] Finished clobber step (success) 09:44:33 INFO - [mozharness: 2017-02-22 17:44:33.941055Z] Running read-buildbot-config step. 09:44:33 INFO - Running pre-action listener: _resource_record_pre_action 09:44:33 INFO - Running main action method: read_buildbot_config 09:44:33 INFO - Using buildbot properties: 09:44:33 INFO - { 09:44:33 INFO - "project": "", 09:44:33 INFO - "product": "firefox", 09:44:33 INFO - "script_repo_revision": "production", 09:44:33 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 09:44:33 INFO - "repository": "", 09:44:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 09:44:33 INFO - "buildid": "20170222080928", 09:44:33 INFO - "pgo_build": "False", 09:44:33 INFO - "basedir": "/builds/slave/test", 09:44:33 INFO - "buildnumber": 93, 09:44:33 INFO - "slavename": "t-yosemite-r7-0232", 09:44:33 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:44:33 INFO - "platform": "yosemite_r7", 09:44:33 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:44:33 INFO - "branch": "mozilla-central", 09:44:33 INFO - "repo_path": "mozilla-central", 09:44:33 INFO - "revision": "7abeac2f2d668554f0093fc0bdb1488f9a77d16e", 09:44:33 INFO - "stage_platform": "macosx64", 09:44:33 INFO - "builduid": "b3a5c38c4763487e98d67fcc066aa45b", 09:44:33 INFO - "slavebuilddir": "test" 09:44:33 INFO - } 09:44:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 09:44:33 INFO - Running post-action listener: _resource_record_post_action 09:44:33 INFO - [mozharness: 2017-02-22 17:44:33.948664Z] Finished read-buildbot-config step (success) 09:44:33 INFO - [mozharness: 2017-02-22 17:44:33.948895Z] Running download-and-extract step. 09:44:33 INFO - Running pre-action listener: _resource_record_pre_action 09:44:33 INFO - Running main action method: download_and_extract 09:44:33 INFO - mkdir: /builds/slave/test/build/tests 09:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:44:33 INFO - trying https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 09:44:33 INFO - Downloading https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 09:44:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 09:44:35 INFO - Downloaded 1199 bytes. 09:44:35 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 09:44:35 INFO - Using the following test package requirements: 09:44:35 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 09:44:35 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:44:35 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 09:44:35 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:44:35 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 09:44:35 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:44:35 INFO - u'jsshell-mac.zip'], 09:44:35 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:44:35 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 09:44:35 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 09:44:35 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:44:35 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 09:44:35 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:44:35 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 09:44:35 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:44:35 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 09:44:35 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:44:35 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 09:44:35 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:44:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 09:44:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:44:35 INFO - Fetch https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 09:44:36 INFO - Expected file size: 51467815 09:44:36 INFO - Obtained file size: 51467815 09:44:52 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:44:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 09:44:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:44:52 INFO - Fetch https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 09:44:54 INFO - Expected file size: 51467815 09:44:54 INFO - Obtained file size: 51467815 09:45:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 09:45:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:45:09 INFO - Fetch https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 09:45:11 INFO - Expected file size: 14404319 09:45:11 INFO - Obtained file size: 14404319 09:45:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:11 INFO - trying https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 09:45:11 INFO - Downloading https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 09:45:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 09:45:13 INFO - Downloaded 74796646 bytes. 09:45:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 09:45:13 INFO - mkdir: /builds/slave/test/properties 09:45:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:45:13 INFO - Writing to file /builds/slave/test/properties/build_url 09:45:13 INFO - Contents: 09:45:13 INFO - build_url:https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 09:45:14 INFO - Running post-action listener: _resource_record_post_action 09:45:14 INFO - Running post-action listener: set_extra_try_arguments 09:45:14 INFO - [mozharness: 2017-02-22 17:45:14.227928Z] Finished download-and-extract step (success) 09:45:14 INFO - [mozharness: 2017-02-22 17:45:14.228061Z] Running populate-webroot step. 09:45:14 INFO - Running pre-action listener: _resource_record_pre_action 09:45:14 INFO - Running main action method: populate_webroot 09:45:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:45:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:45:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:45:14 INFO - '--tppagecycles', 09:45:14 INFO - '7'], 09:45:14 INFO - 'tests': ['tsvgm']}}, 09:45:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:45:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:45:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:45:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:45:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:45:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:45:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:45:14 INFO - 'talos_options': ['--disable-e10s'], 09:45:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:45:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:45:14 INFO - 'talos_options': ['--disable-e10s'], 09:45:14 INFO - 'tests': ['damp', 'tps']}, 09:45:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:45:14 INFO - 'tests': ['damp', 'tps']}, 09:45:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:45:14 INFO - 'tests': ['dromaeo_dom']}, 09:45:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:45:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:45:14 INFO - 'tests': ['basic_compositor_video']}, 09:45:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:45:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:45:14 INFO - 'tests': ['a11yr', 09:45:14 INFO - 'ts_paint', 09:45:14 INFO - 'tpaint', 09:45:14 INFO - 'sessionrestore', 09:45:14 INFO - 'sessionrestore_no_auto_restore', 09:45:14 INFO - 'tabpaint']}, 09:45:14 INFO - 'other-e10s': {'tests': ['a11yr', 09:45:14 INFO - 'ts_paint', 09:45:14 INFO - 'tpaint', 09:45:14 INFO - 'sessionrestore', 09:45:14 INFO - 'sessionrestore_no_auto_restore', 09:45:14 INFO - 'tabpaint']}, 09:45:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:45:14 INFO - 'ts_paint', 09:45:14 INFO - 'tpaint', 09:45:14 INFO - 'sessionrestore', 09:45:14 INFO - 'sessionrestore_no_auto_restore', 09:45:14 INFO - 'tabpaint']}, 09:45:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:45:14 INFO - 'ts_paint', 09:45:14 INFO - 'tpaint', 09:45:14 INFO - 'sessionrestore', 09:45:14 INFO - 'sessionrestore_no_auto_restore', 09:45:14 INFO - 'tabpaint']}, 09:45:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:45:14 INFO - 'tests': ['a11yr', 09:45:14 INFO - 'ts_paint', 09:45:14 INFO - 'tpaint', 09:45:14 INFO - 'sessionrestore', 09:45:14 INFO - 'sessionrestore_no_auto_restore', 09:45:14 INFO - 'tabpaint']}, 09:45:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:45:14 INFO - 'tests': ['a11yr', 09:45:14 INFO - 'ts_paint', 09:45:14 INFO - 'tpaint', 09:45:14 INFO - 'sessionrestore', 09:45:14 INFO - 'sessionrestore_no_auto_restore', 09:45:14 INFO - 'tabpaint']}, 09:45:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:45:14 INFO - 'tests': ['tsvgx', 09:45:14 INFO - 'tsvgr_opacity', 09:45:14 INFO - 'tart', 09:45:14 INFO - 'tscrollx', 09:45:14 INFO - 'cart', 09:45:14 INFO - 'tsvg_static']}, 09:45:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:45:14 INFO - 'tsvgr_opacity', 09:45:14 INFO - 'tart', 09:45:14 INFO - 'tscrollx', 09:45:14 INFO - 'cart', 09:45:14 INFO - 'tsvg_static']}, 09:45:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:45:14 INFO - 'talos_options': ['--disable-e10s'], 09:45:14 INFO - 'tests': ['tp5o']}, 09:45:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:45:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:45:14 INFO - 'talos_options': ['--disable-e10s', 09:45:14 INFO - '--xperf_path', 09:45:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:14 INFO - 'tests': ['tp5n']}, 09:45:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:45:14 INFO - 'talos_options': ['--xperf_path', 09:45:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:14 INFO - 'tests': ['tp5n']}}, 09:45:14 INFO - 'talos.zip': {'path': '', 09:45:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:45:14 INFO - Running post-action listener: _resource_record_post_action 09:45:14 INFO - [mozharness: 2017-02-22 17:45:14.246654Z] Finished populate-webroot step (success) 09:45:14 INFO - [mozharness: 2017-02-22 17:45:14.246771Z] Running create-virtualenv step. 09:45:14 INFO - Running pre-action listener: _resource_record_pre_action 09:45:14 INFO - Running main action method: create_virtualenv 09:45:14 INFO - Creating virtualenv /builds/slave/test/build/venv 09:45:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:45:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:45:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:45:14 INFO - Using real prefix '/tools/python27' 09:45:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:45:15 INFO - Installing distribute.............................................................................................................................................................................................done. 09:45:17 INFO - Installing pip.................done. 09:45:17 INFO - Return code: 0 09:45:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:45:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:45:18 INFO - Reading from file tmpfile_stdout 09:45:18 INFO - Output received: 09:45:18 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:45:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fbfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd703468850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9d9d30>, '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 0x10f900db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9cebe8>, '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.pnhsSqP8KQ/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.qf8OVzSLGe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:45:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:45:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:45:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pnhsSqP8KQ/Render', 09:45:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:18 INFO - 'HOME': '/Users/cltbld', 09:45:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:18 INFO - 'LOGNAME': 'cltbld', 09:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:18 INFO - 'MOZ_NO_REMOTE': '1', 09:45:18 INFO - 'NO_EM_RESTART': '1', 09:45:18 INFO - 'PAGER': '/bin/cat', 09:45:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:18 INFO - 'PWD': '/builds/slave/test', 09:45:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:18 INFO - 'SHELL': '/bin/bash', 09:45:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qf8OVzSLGe/Listeners', 09:45:18 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 09:45:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:18 INFO - 'USER': 'cltbld', 09:45:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:18 INFO - 'XPC_FLAGS': '0x0', 09:45:18 INFO - 'XPC_SERVICE_NAME': '0', 09:45:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:45:18 INFO - Cleaning up... 09:45:18 INFO - Return code: 0 09:45:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fbfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd703468850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9d9d30>, '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 0x10f900db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9cebe8>, '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.pnhsSqP8KQ/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.qf8OVzSLGe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:45:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:45:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:45:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pnhsSqP8KQ/Render', 09:45:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:18 INFO - 'HOME': '/Users/cltbld', 09:45:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:18 INFO - 'LOGNAME': 'cltbld', 09:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:18 INFO - 'MOZ_NO_REMOTE': '1', 09:45:18 INFO - 'NO_EM_RESTART': '1', 09:45:18 INFO - 'PAGER': '/bin/cat', 09:45:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:18 INFO - 'PWD': '/builds/slave/test', 09:45:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:18 INFO - 'SHELL': '/bin/bash', 09:45:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qf8OVzSLGe/Listeners', 09:45:18 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 09:45:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:18 INFO - 'USER': 'cltbld', 09:45:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:18 INFO - 'XPC_FLAGS': '0x0', 09:45:18 INFO - 'XPC_SERVICE_NAME': '0', 09:45:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:18 INFO - Downloading/unpacking psutil>=3.1.1 09:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:45:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:22 INFO - Installing collected packages: psutil 09:45:22 INFO - Running setup.py install for psutil 09:45:22 INFO - building 'psutil._psutil_osx' extension 09:45:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:45:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:45:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:45:23 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:45:23 INFO - building 'psutil._psutil_posix' extension 09:45:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:45:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:45:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:45:23 INFO - ^ 09:45:23 INFO - 1 warning generated. 09:45:23 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:45:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:23 INFO - Successfully installed psutil 09:45:23 INFO - Cleaning up... 09:45:23 INFO - Return code: 0 09:45:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:23 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 0x10fbfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd703468850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9d9d30>, '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 0x10f900db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9cebe8>, '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.pnhsSqP8KQ/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.qf8OVzSLGe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:45:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:45:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:45:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pnhsSqP8KQ/Render', 09:45:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:23 INFO - 'HOME': '/Users/cltbld', 09:45:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:23 INFO - 'LOGNAME': 'cltbld', 09:45:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:23 INFO - 'MOZ_NO_REMOTE': '1', 09:45:23 INFO - 'NO_EM_RESTART': '1', 09:45:23 INFO - 'PAGER': '/bin/cat', 09:45:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:23 INFO - 'PWD': '/builds/slave/test', 09:45:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:23 INFO - 'SHELL': '/bin/bash', 09:45:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qf8OVzSLGe/Listeners', 09:45:23 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 09:45:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:23 INFO - 'USER': 'cltbld', 09:45:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:23 INFO - 'XPC_FLAGS': '0x0', 09:45:23 INFO - 'XPC_SERVICE_NAME': '0', 09:45:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:45:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:45:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:45:26 INFO - Installing collected packages: mozsystemmonitor 09:45:26 INFO - Running setup.py install for mozsystemmonitor 09:45:26 INFO - Successfully installed mozsystemmonitor 09:45:26 INFO - Cleaning up... 09:45:26 INFO - Return code: 0 09:45:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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')]} 09:45:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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', '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 0x10fbfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd703468850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9d9d30>, '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 0x10f900db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9cebe8>, '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.pnhsSqP8KQ/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.qf8OVzSLGe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:45: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:45: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 jsonschema==2.5.1 09:45:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pnhsSqP8KQ/Render', 09:45:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:27 INFO - 'HOME': '/Users/cltbld', 09:45:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:27 INFO - 'LOGNAME': 'cltbld', 09:45:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:27 INFO - 'MOZ_NO_REMOTE': '1', 09:45:27 INFO - 'NO_EM_RESTART': '1', 09:45:27 INFO - 'PAGER': '/bin/cat', 09:45:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:27 INFO - 'PWD': '/builds/slave/test', 09:45:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:27 INFO - 'SHELL': '/bin/bash', 09:45:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qf8OVzSLGe/Listeners', 09:45:27 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 09:45:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:27 INFO - 'USER': 'cltbld', 09:45:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:27 INFO - 'XPC_FLAGS': '0x0', 09:45:27 INFO - 'XPC_SERVICE_NAME': '0', 09:45:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:27 INFO - Downloading/unpacking jsonschema==2.5.1 09:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:45:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:31 INFO - Downloading functools32-3.2.3-2.tar.gz 09:45:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:45:31 INFO - warning: no files found matching '*.txt' 09:45:31 INFO - no previously-included directories found matching 'build' 09:45:31 INFO - no previously-included directories found matching 'dist' 09:45:31 INFO - no previously-included directories found matching '.git*' 09:45:31 INFO - Installing collected packages: jsonschema, functools32 09:45:31 INFO - Running setup.py install for functools32 09:45:31 INFO - warning: no files found matching '*.txt' 09:45:31 INFO - no previously-included directories found matching 'build' 09:45:31 INFO - no previously-included directories found matching 'dist' 09:45:31 INFO - no previously-included directories found matching '.git*' 09:45:31 INFO - Successfully installed jsonschema functools32 09:45:31 INFO - Cleaning up... 09:45:31 INFO - Return code: 0 09:45:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:31 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 0x10fbfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd703468850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9d9d30>, '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 0x10f900db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9cebe8>, '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.pnhsSqP8KQ/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.qf8OVzSLGe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:45:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:45:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:45:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pnhsSqP8KQ/Render', 09:45:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:31 INFO - 'HOME': '/Users/cltbld', 09:45:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:31 INFO - 'LOGNAME': 'cltbld', 09:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:31 INFO - 'MOZ_NO_REMOTE': '1', 09:45:31 INFO - 'NO_EM_RESTART': '1', 09:45:31 INFO - 'PAGER': '/bin/cat', 09:45:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:31 INFO - 'PWD': '/builds/slave/test', 09:45:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:31 INFO - 'SHELL': '/bin/bash', 09:45:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qf8OVzSLGe/Listeners', 09:45:31 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 09:45:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:31 INFO - 'USER': 'cltbld', 09:45:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:31 INFO - 'XPC_FLAGS': '0x0', 09:45:31 INFO - 'XPC_SERVICE_NAME': '0', 09:45:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:45:31 INFO - Cleaning up... 09:45:31 INFO - Return code: 0 09:45:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:31 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 0x10fbfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd703468850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9d9d30>, '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 0x10f900db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9cebe8>, '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.pnhsSqP8KQ/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.qf8OVzSLGe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:45:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:45:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:45:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pnhsSqP8KQ/Render', 09:45:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:31 INFO - 'HOME': '/Users/cltbld', 09:45:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:31 INFO - 'LOGNAME': 'cltbld', 09:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:31 INFO - 'MOZ_NO_REMOTE': '1', 09:45:31 INFO - 'NO_EM_RESTART': '1', 09:45:31 INFO - 'PAGER': '/bin/cat', 09:45:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:31 INFO - 'PWD': '/builds/slave/test', 09:45:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:31 INFO - 'SHELL': '/bin/bash', 09:45:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qf8OVzSLGe/Listeners', 09:45:31 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 09:45:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:31 INFO - 'USER': 'cltbld', 09:45:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:31 INFO - 'XPC_FLAGS': '0x0', 09:45:31 INFO - 'XPC_SERVICE_NAME': '0', 09:45:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:32 INFO - Downloading/unpacking blobuploader==1.2.4 09:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:34 INFO - Downloading blobuploader-1.2.4.tar.gz 09:45:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:45:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:45:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45:35 INFO - Downloading docopt-0.6.1.tar.gz 09:45:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:45:36 INFO - Installing collected packages: blobuploader, requests, docopt 09:45:36 INFO - Running setup.py install for blobuploader 09:45:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:45:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:45:36 INFO - Running setup.py install for requests 09:45:36 INFO - Running setup.py install for docopt 09:45:36 INFO - Successfully installed blobuploader requests docopt 09:45:36 INFO - Cleaning up... 09:45:36 INFO - Return code: 0 09:45:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:36 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 0x10fbfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd703468850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9d9d30>, '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 0x10f900db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9cebe8>, '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.pnhsSqP8KQ/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.qf8OVzSLGe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:45:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:45:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:45:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pnhsSqP8KQ/Render', 09:45:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:36 INFO - 'HOME': '/Users/cltbld', 09:45:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:36 INFO - 'LOGNAME': 'cltbld', 09:45:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:36 INFO - 'MOZ_NO_REMOTE': '1', 09:45:36 INFO - 'NO_EM_RESTART': '1', 09:45:36 INFO - 'PAGER': '/bin/cat', 09:45:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:36 INFO - 'PWD': '/builds/slave/test', 09:45:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:36 INFO - 'SHELL': '/bin/bash', 09:45:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qf8OVzSLGe/Listeners', 09:45:36 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 09:45:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:36 INFO - 'USER': 'cltbld', 09:45:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:36 INFO - 'XPC_FLAGS': '0x0', 09:45:36 INFO - 'XPC_SERVICE_NAME': '0', 09:45:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:45:37 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-9d788P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:45:37 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-Nfz3D5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:45:37 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-0mSFnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:45:37 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-Mq7bUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:45:37 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-aZlkM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:45:37 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-KRluzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:45:37 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-ENjzgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:45:37 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-EFiswR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:45:38 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-z_hPUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:45:38 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-7XRy7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:45:38 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-7zy8wv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:45:38 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-_WAH2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:45:38 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-lRS75f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:45:38 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-tm_ggU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:38 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-Gd4G0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:45:38 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-0SOfKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:45:38 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-Mqf9F2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:45:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:45:38 INFO - Running setup.py install for manifestparser 09:45:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:45:39 INFO - Running setup.py install for mozcrash 09:45:39 INFO - Running setup.py install for mozdebug 09:45:39 INFO - Running setup.py install for mozdevice 09:45:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:45:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:45:39 INFO - Running setup.py install for mozfile 09:45:39 INFO - Running setup.py install for mozhttpd 09:45:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:45:39 INFO - Running setup.py install for mozinfo 09:45:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:45:39 INFO - Running setup.py install for mozInstall 09:45:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Running setup.py install for mozleak 09:45:40 INFO - Running setup.py install for mozlog 09:45:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Running setup.py install for moznetwork 09:45:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Running setup.py install for mozprocess 09:45:40 INFO - Running setup.py install for mozprofile 09:45:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Running setup.py install for mozrunner 09:45:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:45:41 INFO - Running setup.py install for mozscreenshot 09:45:41 INFO - Running setup.py install for moztest 09:45:41 INFO - Running setup.py install for mozversion 09:45:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:45:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:45:41 INFO - Cleaning up... 09:45:41 INFO - Return code: 0 09:45:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:41 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 0x10fbfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd703468850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9d9d30>, '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 0x10f900db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9cebe8>, '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.pnhsSqP8KQ/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.qf8OVzSLGe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:45:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:45:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pnhsSqP8KQ/Render', 09:45:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:41 INFO - 'HOME': '/Users/cltbld', 09:45:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:41 INFO - 'LOGNAME': 'cltbld', 09:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:41 INFO - 'MOZ_NO_REMOTE': '1', 09:45:41 INFO - 'NO_EM_RESTART': '1', 09:45:41 INFO - 'PAGER': '/bin/cat', 09:45:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:41 INFO - 'PWD': '/builds/slave/test', 09:45:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:41 INFO - 'SHELL': '/bin/bash', 09:45:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qf8OVzSLGe/Listeners', 09:45:41 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 09:45:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:41 INFO - 'USER': 'cltbld', 09:45:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:41 INFO - 'XPC_FLAGS': '0x0', 09:45:41 INFO - 'XPC_SERVICE_NAME': '0', 09:45:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:45:41 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-ChjGSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:45:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:45:41 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-m8W6B_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:45:42 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-xm13Ua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:45:42 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-SPe8ON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:45:42 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-rLy7Kv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:45:42 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-ZYHtsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:45:42 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-3H7jwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:45:42 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-cV0irY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:45:42 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-cogK3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:45:42 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-4mMLJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:45:42 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-htYoOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:45:42 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-lJaL8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:45:43 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-_9dHY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:45:43 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-tSgbb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:43 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-PXYcB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:45:43 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-xc6B9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:45:43 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-Kepg5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:45:43 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:45:43 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:45:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:46 INFO - Downloading blessings-1.6.tar.gz 09:45:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:45:46 INFO - Installing collected packages: blessings 09:45:46 INFO - Running setup.py install for blessings 09:45:46 INFO - Successfully installed blessings 09:45:46 INFO - Cleaning up... 09:45:46 INFO - Return code: 0 09:45:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:45:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:45:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:45:46 INFO - Reading from file tmpfile_stdout 09:45:46 INFO - Current package versions: 09:45:46 INFO - blessings == 1.6 09:45:46 INFO - blobuploader == 1.2.4 09:45:46 INFO - docopt == 0.6.1 09:45:46 INFO - functools32 == 3.2.3-2 09:45:46 INFO - jsonschema == 2.5.1 09:45:46 INFO - manifestparser == 1.1 09:45:46 INFO - mozInstall == 1.12 09:45:46 INFO - mozcrash == 1.0 09:45:46 INFO - mozdebug == 0.1 09:45:46 INFO - mozdevice == 0.49 09:45:46 INFO - mozfile == 1.2 09:45:46 INFO - mozhttpd == 0.7 09:45:46 INFO - mozinfo == 0.9 09:45:46 INFO - mozleak == 0.1 09:45:46 INFO - mozlog == 3.4 09:45:46 INFO - moznetwork == 0.27 09:45:46 INFO - mozprocess == 0.25 09:45:46 INFO - mozprofile == 0.28 09:45:46 INFO - mozrunner == 6.13 09:45:46 INFO - mozscreenshot == 0.1 09:45:46 INFO - mozsystemmonitor == 0.3 09:45:46 INFO - moztest == 0.8 09:45:46 INFO - mozversion == 1.4 09:45:46 INFO - psutil == 3.1.1 09:45:46 INFO - requests == 1.2.3 09:45:46 INFO - wsgiref == 0.1.2 09:45:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:46 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 0x10fbfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd703468850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9d9d30>, '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 0x10f900db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9cebe8>, '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.pnhsSqP8KQ/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.qf8OVzSLGe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:45:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:45:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:45:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pnhsSqP8KQ/Render', 09:45:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:46 INFO - 'HOME': '/Users/cltbld', 09:45:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:46 INFO - 'LOGNAME': 'cltbld', 09:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:46 INFO - 'MOZ_NO_REMOTE': '1', 09:45:46 INFO - 'NO_EM_RESTART': '1', 09:45:46 INFO - 'PAGER': '/bin/cat', 09:45:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:46 INFO - 'PWD': '/builds/slave/test', 09:45:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:46 INFO - 'SHELL': '/bin/bash', 09:45:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qf8OVzSLGe/Listeners', 09:45:46 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 09:45:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:46 INFO - 'USER': 'cltbld', 09:45:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:46 INFO - 'XPC_FLAGS': '0x0', 09:45:46 INFO - 'XPC_SERVICE_NAME': '0', 09:45:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:45:47 INFO - Cleaning up... 09:45:47 INFO - Return code: 0 09:45:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:47 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 0x10fbfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd703468850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9d9d30>, '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 0x10f900db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9cebe8>, '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.pnhsSqP8KQ/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.qf8OVzSLGe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:45:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:45:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pnhsSqP8KQ/Render', 09:45:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:47 INFO - 'HOME': '/Users/cltbld', 09:45:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:47 INFO - 'LOGNAME': 'cltbld', 09:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:47 INFO - 'MOZ_NO_REMOTE': '1', 09:45:47 INFO - 'NO_EM_RESTART': '1', 09:45:47 INFO - 'PAGER': '/bin/cat', 09:45:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:47 INFO - 'PWD': '/builds/slave/test', 09:45:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:47 INFO - 'SHELL': '/bin/bash', 09:45:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qf8OVzSLGe/Listeners', 09:45:47 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 09:45:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:47 INFO - 'USER': 'cltbld', 09:45:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:47 INFO - 'XPC_FLAGS': '0x0', 09:45:47 INFO - 'XPC_SERVICE_NAME': '0', 09:45:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:45:47 INFO - Cleaning up... 09:45:47 INFO - Return code: 0 09:45:47 INFO - Running post-action listener: _resource_record_post_action 09:45:47 INFO - Running post-action listener: _start_resource_monitoring 09:45:47 INFO - Starting resource monitoring. 09:45:47 INFO - [mozharness: 2017-02-22 17:45:47.422723Z] Finished create-virtualenv step (success) 09:45:47 INFO - [mozharness: 2017-02-22 17:45:47.423685Z] Running install step. 09:45:47 INFO - Running pre-action listener: _resource_record_pre_action 09:45:47 INFO - Running main action method: install 09:45:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:45:47 INFO - Reading from file tmpfile_stdout 09:45:47 INFO - Detecting whether we're running mozinstall >=1.0... 09:45:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:45:47 INFO - Reading from file tmpfile_stdout 09:45:47 INFO - Output received: 09:45:47 INFO - Usage: mozinstall [options] installer 09:45:47 INFO - Options: 09:45:47 INFO - -h, --help show this help message and exit 09:45:47 INFO - -d DEST, --destination=DEST 09:45:47 INFO - Directory to install application into. [default: 09:45:47 INFO - "/builds/slave/test"] 09:45:47 INFO - --app=APP Application being installed. [default: firefox] 09:45:47 INFO - mkdir: /builds/slave/test/build/application 09:45:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:46:07 INFO - Reading from file tmpfile_stdout 09:46:07 INFO - Output received: 09:46:07 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:46:07 INFO - Running post-action listener: _resource_record_post_action 09:46:07 INFO - [mozharness: 2017-02-22 17:46:07.759570Z] Finished install step (success) 09:46:07 INFO - [mozharness: 2017-02-22 17:46:07.759680Z] Running run-tests step. 09:46:07 INFO - Running pre-action listener: _resource_record_pre_action 09:46:07 INFO - Running main action method: run_tests 09:46:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:46:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:46:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:46:07 INFO - 2017-02-22 09:46:07.772 screenresolution[1623:7531] starting screenresolution argv=screenresolution get 09:46:07 INFO - 2017-02-22 09:46:07.774 screenresolution[1623:7531] Display 0: 1600x1200x32@60 09:46:07 INFO - 2017-02-22 09:46:07.779 screenresolution[1624:7534] starting screenresolution argv=screenresolution list 09:46:07 INFO - Available Modes on Display 0 09:46:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:46:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:46:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:46:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:46:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:46:07 INFO - Intel Iris: 09:46:07 INFO - Chipset Model: Intel Iris 09:46:07 INFO - Type: GPU 09:46:07 INFO - Bus: Built-In 09:46:07 INFO - VRAM (Dynamic, Max): 1536 MB 09:46:07 INFO - Vendor: Intel (0x8086) 09:46:07 INFO - Device ID: 0x0a2e 09:46:07 INFO - Revision ID: 0x0009 09:46:07 INFO - Displays: 09:46:07 INFO - Display: 09:46:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:46:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:46:07 INFO - Display Serial Number: 1600x1200 60 09:46:07 INFO - Main Display: Yes 09:46:07 INFO - Mirror: Off 09:46:07 INFO - Online: Yes 09:46:07 INFO - Rotation: Supported 09:46:07 INFO - Return code: 0 09:46:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:46:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:46:08 INFO - Python 2.7.3 09:46:08 INFO - Return code: 0 09:46:08 INFO - grabbing minidump binary from tooltool 09:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:08 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 0x10f9d9d30>, '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 0x10f900db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9cebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:46:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:46:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:46:08 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:46:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:46:08 INFO - Return code: 0 09:46:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:46:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:46:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:46:08 INFO - ENV: RUST_BACKTRACE is now 1 09:46:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:46:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:46:08 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/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0232', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:46:08 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/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0232 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:46:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pnhsSqP8KQ/Render', 09:46:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:08 INFO - 'HOME': '/Users/cltbld', 09:46:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:08 INFO - 'LOGNAME': 'cltbld', 09:46:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:46:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:08 INFO - 'MOZ_NO_REMOTE': '1', 09:46:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:46:08 INFO - 'NO_EM_RESTART': '1', 09:46:08 INFO - 'PAGER': '/bin/cat', 09:46:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:08 INFO - 'PWD': '/builds/slave/test', 09:46:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:46:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:08 INFO - 'RUST_BACKTRACE': '1', 09:46:08 INFO - 'SHELL': '/bin/bash', 09:46:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qf8OVzSLGe/Listeners', 09:46:08 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 09:46:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:08 INFO - 'USER': 'cltbld', 09:46:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:08 INFO - 'XPC_FLAGS': '0x0', 09:46:08 INFO - 'XPC_SERVICE_NAME': '0', 09:46:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:08 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/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0232', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:46:08 INFO - mozversion application_buildid: 20170222080928 09:46:08 INFO - mozversion application_changeset: 7abeac2f2d668554f0093fc0bdb1488f9a77d16e 09:46:08 INFO - mozversion application_display_name: Nightly 09:46:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:46:08 INFO - mozversion application_name: Firefox 09:46:08 INFO - mozversion application_remotingname: firefox 09:46:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:46:08 INFO - mozversion application_vendor: Mozilla 09:46:08 INFO - mozversion application_version: 54.0a1 09:46:08 INFO - mozversion platform_buildid: 20170222080928 09:46:08 INFO - mozversion platform_changeset: 7abeac2f2d668554f0093fc0bdb1488f9a77d16e 09:46:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:46:08 INFO - mozversion platform_version: 54.0a1 09:46:08 INFO - using testdate: 1487785568 09:46:08 INFO - actual date: 1487785568 09:46:08 INFO - starting webserver on 'localhost:49241' 09:46:08 INFO - SUITE-START | Running 2 tests 09:46:08 INFO - TEST-START | dromaeo_css 09:46:08 INFO - operating with platform_type : mac_ 09:46:08 INFO - Initialising browser for dromaeo_css test... 09:46:08 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/tmpKokkF4/profile http://localhost:49241/getInfo.html) 09:46:11 INFO - PROCESS | 1634 | 2017-02-22 09:46:11.350 plugin-container[1636:7722] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 09:46:11 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:46:11 INFO - PROCESS | 1634 | 2017-02-22 09:46:11.354 plugin-container[1636:7722] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c23, name = 'com.apple.CFPasteboardClient' 09:46:11 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:46:11 INFO - PROCESS | 1634 | 2017-02-22 09:46:11.354 plugin-container[1636:7722] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:46:11 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 09:46:11 INFO - PROCESS | 1634 | colorDepth:24 09:46:11 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 09:46:11 INFO - PROCESS | 1634 | __metrics 09:46:11 ERROR - PROCESS | 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 09:46:12 INFO - TEST-INFO | 1634: exit 0 09:46:12 INFO - Browser initialized. 09:46:12 INFO - Running cycle 1/1 for dromaeo_css test... 09:46:12 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/tmpKokkF4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:46:15 INFO - PROCESS | 1637 | 2017-02-22 09:46:15.124 plugin-container[1638:7852] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a4f, name = 'com.apple.tsm.portname' 09:46:15 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:46:15 INFO - PROCESS | 1637 | 2017-02-22 09:46:15.125 plugin-container[1638:7852] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 09:46:15 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:46:15 INFO - PROCESS | 1637 | 2017-02-22 09:46:15.125 plugin-container[1638:7852] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:46:24 INFO - PROCESS | 1637 | RSS: Main: 227110912 09:46:24 INFO - PROCESS | 1637 | 09:49:26 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 09:49:28 INFO - PROCESS | 1637 | RSS: Main: 249839616 09:49:28 INFO - PROCESS | 1637 | 09:51:12 INFO - PROCESS | 1637 | ************************* 09:51:12 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 09:51:12 INFO - PROCESS | 1637 | 09:51:12 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:51:12 INFO - PROCESS | 1637 | Full stack: 09:51:12 INFO - PROCESS | 1637 | ************************* 09:52:30 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 09:52:31 INFO - PROCESS | 1637 | RSS: Main: 257536000 09:52:31 INFO - PROCESS | 1637 | 09:55:33 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 09:55:33 INFO - PROCESS | 1637 | RSS: Main: 268861440 09:55:33 INFO - PROCESS | 1637 | 09:58:35 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 09:58:36 INFO - PROCESS | 1637 | RSS: Main: 262164480 09:58:36 INFO - PROCESS | 1637 | 10:01:39 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 10:01:40 INFO - PROCESS | 1637 | RSS: Main: 272220160 10:01:40 INFO - PROCESS | 1637 | 10:04:43 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 10:04:43 INFO - PROCESS | 1637 | RSS: Main: 265908224 10:04:43 INFO - PROCESS | 1637 | 10:04:43 INFO - PROCESS | 1637 | __start_tp_report 10:04:43 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 10:04:43 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 10:04:43 INFO - PROCESS | 1637 | |i|pagename|runs| 10:04:43 INFO - PROCESS | 1637 | |0;dojo.html;2781.4576157649253;3295.637479877213;3325.5510506081687;3357.865685372585;3375.4768010958296;4871.488493708154;5149.459306772791;5588.357338906022;5653.604247702662;5706.7431965561545;4696.976515117428;4987.202047672373;5394.271773310602;5587.7485513151905;5635.549156067515;5023.372078490189;5033.094043072246;5113.693178409308;5169.844904652867;5184.559312458446;5142.768575414116;5154.845354639367;5169.30214421054;5213.218017297417;5213.322268105141;5170.922436163461;5176.197689358137;5208.2968799212185;5217.530422261995;5253.422123566424;150.16059454762475;4391.758453285068;5107.846764597068;5113.51421614946;5158.561522270612;5091.592672586185;5105.846824595231;5121.641485096045;5129.871753206163;5147.22791581262;5416.1063424534905;5587.55299576037;5620.747066381981;5654.491095801398;5689.886202275973;5870.11948207768;5927.199828023205;5992;6109.327973922865;6130.938690613126;6215.844603884894;6229.314775374705;6237.313895471494;6259.311475737665;6270.46701030413;5726.531934511209;5728.77084916607;5752;5756.395578464243;5769.759501707111;4779.808807647724;6022.819315420545;6112.473085128069;6204.658743769046;6255.218097737783;4956.810365512251;5789.015867302569;5990.400959904062;6063.636181829016;6076.361981991916;6157.138000679908;6183.721732522047;6204.193454850841;6212.254529456494;6219.471344935731;5964.940350596438;5966.284045914431;6043.8186854394435;6096.298925623521;6113.113598528189;5084.339035925306;5118.181091025418;6063.120847477091;6107.340534417129;6140.969295153495;4151.46031015966;4804.855854324376;4922.335484709519;4932.506749325039;4949.257611358325;4288.035192081819;4314;4332.393464914914;4377.190219809282;4412.117576484716;5818.389069147764;5819.738111784895;5832.24180856486;5837.970810146007;5853.122031695195;6116.724747386378;6148.9692551536955;6165.691715414211;6167.383261673796;6171.907421388682;5542.224088627595;5553.611247212656;5561.499465048165;5630.18362337467;5635.6618602883955;5379.488948549882;5394.136938089887;5440.238366628675;5469.671819690831;5482.506574408322;6286.811395658046;6287.308396076428;6289.308176100625;6293.465055470245;6311.558190926591;6043.12374705674;6074.817755467343;6099.963006288853;6249.093881387264;6279.780207692709;6148.538859585459;6157.291911430243;6218.440340369389;6241.906371404341;6260;6100.993336099494;6108.633481991094;6123.877522449437;6128.693565321805;6132.448079672851;5954.821355359346;6133.417325354084;6137.754489820357;6170.197874276315;6223.719932603134;5829.183914252093;5888.558358123072;5935.109733540004;5945.494632956247;5950.315713692808;4899.632527560519;5089.338386009795;5825.242718446575;5901.05583106718;5946.613470124428;4711.340412342343;5286.286351342674;5368.731563421891;5466.508014278734;5793.536517078539;5931.762729490944;6036.366181550874;6053.576249662481;6070.2108725865355;6073.817785466443;5672.5745569081655;5736.913946290725;5777.94222057774;5938.287405511366;5953.315368732651 10:04:43 INFO - PROCESS | 1637 | |1;ext.html;454.2391494247135;460.084431980359;473.519377831501;482.3560546670195;491.01306374187874;39180.41229381558;41534.58465415345;41806.16387672245;41901.371479427835;43993.12013759731;43250.351244731355;43389.56610433895;43514.91212719683;43681.56318436815;43741.34387984183;6673.833154171136;7605.087389513266;9373.906260937372;9610.75973100671;9624.80750384992;10726.410047447387;11690.649280521598;11699.35653539055;11898.048156147488;11989.520419183222;9905.860826004993;11815.881841181565;11823.704407389798;11883.643490695249;11923.940380298087;11679.649610511698;11691.532338706484;11767.58813441534;11773.882261177407;11799.115066370057;11595.956363927202;11649.38868950628;11691.064714822794;11756;11761;40934.38598421026;40967;41145.382819257735;41172.58827411717;41266.79366603148;3863.632954869283;3896.8051597420017;3908.55051669056;3909.7263191576603;3974.324364857981;29986.25034374136;30356.54465183024;30742.84628576865;31379.37241255162;31530.527042094385;2907.1714561350127;3004.4892368297224;3020.1845501714415;3020.652624948137;3031.9545206821917;465892;467541;469175.99999999657;471180;472051;46701.29948050782;47917;55276.447235527936;55775.442245577025;56305.87388252212;56155.157672634945;60247.39752602505;60405.75130984222;60432;60463.09305360423;14661.706765864623;14696.632584185481;14888.404463821542;14890.553283401516;14920.626984325261;11236.831447528293;11287.887121128848;11310.321380717183;11316.943415283036;11347.092232621371;15053.247337633074;17194;17654.382096626556;17785;17822.10889455548;7079.115110611174;7394.929419762475;7797.727079552188;7833.960830195812;7879.290863822283;773.8490994256179;789.6762327445834;822.2312138150728;836.983260334802;853.5092321914924;25227.243182704548;27705.44589108247;28191;29966.951156709412;30375.392492150033;1013.9087482126497;1021.9642312519026;1051.8842927277992;1072.3619446429361;1199.9100067494974;15366.791925973253;15618;15645.217739112999;15715;16010.359585616678;617785;618390;620336;620656;621356;59690;60168;60284;60329.698351508836;60333.39666603366;1374.3746595299115;1417.780244062172;1420.155007770375;1420.3821337718125;1424.4444666579834;25354;28301;29540.261493461974;30040.098797036124;30304;50679;51257.48742512527;51679.74160129175;51851.74074129605;55426.445735542125;501228;552292;576009;579957.1002144963;580912;30627.2343191422;31393.587288571613;37355.14383130176;37710.62289377071;37814.48742050287;41297;42034.57965420429;42463.36304955366;42520.78739606282;43172.78413607912;32098.83950580232;33804.32391352209;34815;35414.822925886234;35934.281314374086;27108.72891271062;28873.133805985854;34253.31493370169;35216.11959701028;35964.82017589895;31612.841935790173;32313.838430808635;35488;35670;35726.821365893;29606.851965740032;31262.687373126886;31481;31593.36813263768;31612;18570.7000509963;19622.8037719621;23332;23779.762202377755;23934.28197154088 10:04:43 INFO - PROCESS | 1637 | |2;jquery.html;353.3798184186752;367.0969415238513;382.0830007980846;396.62915174312;414.1241274704;19648.410547683576;20140;21660.89169554152;21852.8907355463;21916.342509724713;11914.344711040889;12006.699832504191;12082.395880205999;12384.00927925766;12413.875861241384;4776.80892764289;5363.704996225206;5597.6641401515835;5604.579656525756;5614.101743721006;4499.820007199708;5574.219609254687;5785.884282314351;6056.576039677225;6127.601705889125;6152.815415537541;6165.290991535986;6172.351903050182;6177.0116781315;6185.690715464231;5673.517750991171;5922.4373684500115;6143.784967526138;6153.138560601519;6162.907556386658;5041.747912604355;5317.308749862493;5980.624456375014;5986.73059712314;6031.673031932968;12798.48806047757;13520;13539.729205415837;13568.932155339258;14855.70288594222;2409.554232466982;2509.874506274697;2539.2255362114547;2553.8084643651614;2567.2169988153605;10243.53904074311;10343.79312413755;11841.348725820077;12197.512099516009;12313.56902508408;1773.0691387021789;1775.4762345108225;1776.786785585725;1777.6533575952694;1797.8921264724027;117475;123177;123231;123595.3820230902;124949;11518.193726439069;11867.16929814922;11893.34586597728;12002.279863208236;12013.459394327276;12610.873891261153;15444.922775386276;15532.45636402743;15565.29956151976;15588.454404095803;8230.465019773696;8344.791380215422;8375.8324833503;8404.20160084791;8479.872801907977;7815;7875.369970402354;7915.802104947307;8042.195780421911;8056.54982103227;4787.40157480315;4840.685355451955;4872.731999740048;4952.579030782352;4964.255361695702;2022.686483595045;2101.1385332014106;2105.968410473844;2117.4071260047212;2119.226482333937;999.1216512955597;1004.8693669822876;1017.2167431078028;1020.7193021918883;1050.2228351020342;20643.69034464484;20929.790702093087;21226.78773212248;21277.255296064563;21296.78703212979;796.7370767646663;1010.2625083688948;1024.5082360467018;1028.9742756430999;1068.1721665709138;9249.583768730423;9563;10043.849342259871;10798.920107989139;10809.513571889283;679598;688486;691235;701263;709702;125681.37159314145;132884;141501;142935;144490;1022.7085280694967;1034.4207243943415;1062.9574817007388;1065.0840277361463;1065.6589891234885;18507.629847403245;19812.20751169937;19831.900840495706;19841.404757857286;19911.502212444226;45601;59333;60136.69931650314;60352.39647603468;60838;73352.63323683347;82427.5878620603;87580;88184.11815882016;88233.1176688225;8016.7194148204535;8103.473274237156;8120.350371970347;8553.572321383781;8556.27271681914;9346.392484488486;12312.26126432417;13264.403101860247;13265.33673316311;13538.323083845571;11238.044766194966;11472.88527114718;11616.186866919235;11678.124140689652;11826.231294965799;10155.187584993331;11326;11347;11666.591669291534;11760.529578816751;11214.327140371604;11266.267692599955;11686.123540734648;11727.237729547553;11881.5841445549;6498.772542960974;8114.553699546582;8326.791830204293;8641.876556047673;8718.694845680371;10442.895571044497;10648.307859989076;10965.50655220501;11156.274842135235;11263.592050993626 10:04:43 INFO - PROCESS | 1637 | |3;mootools.html;1303.1399276477528;1405.6485878530368;1447.51508244738;1456.9490067847628;1480.1193289992455;8093.31206847418;8254.092049874524;8421.494710317385;8535.914640853589;8545.91454085459;7296.306850849174;8496;8554.828903421927;8610;8627.741167764962;2297.896594653236;2327.895244713992;2328.941776455585;2330.673705681206;2334.5214231082587;2288.896999635012;2344.355302291875;2354.1642716835536;2355.0815182079004;2356.564035653401;2303.3205204464725;2308.076769292288;2329.522447898177;2332.731735850382;2339.4034521197154;2233.171739648734;2287.816974642033;2315.351701523576;2318.7681231876845;2323.012719594166;1950.4441234248313;2032.8272096871783;2241.3051953894346;2305.054927479742;2336.0538981712266;8400.117987611275;8503.404761666687;8540.615672294762;8549.40154189207;8573.18554737299;4773.689710168828;4941.283513890502;5086.872828179288;5261.289725886994;5263.973680131613;3428.879989200391;3440.6215316315183;3456.844442000116;3527.4356103023392;3544.9113772155642;1026.5072765072807;1209.08109836524;1227.643983244858;1227.7360367520937;1263.1663102352495;10720.839187412195;10721.195910306758;10772.08437282832;10855.51150198243;10859.457027148612;3481.5822101348;4144.48193975753;4488.438945131858;4491.393661855608;4497.033137875373;8578.828423431496;8630.39587228888;8660.13398660129;8677.52273624944;8678.435901666371;5012.974935125374;5097.949020509747;5101.719405432663;5111.258867464197;5113.8721531961255;4627.5603817637275;4699.436067671902;4747.572718455355;4804.087223427608;4816.181249187576;3055.770817188675;3124.8593813278458;3623.384024715752;3662.5421822272215;3717.20080182762;1151.510607991617;1160.1356989043218;1176.2824676947055;1176.6117181330312;1176.817593273044;848.1518481518482;878.1306506558589;887.1616322575234;917.0600134861687;920.7053742802373;5498.010358135574;5513.972430137904;5582.609217354746;5702.600817942787;5777.133429985536;574.7327492715824;589.2899056636743;590.1207201270076;905.4386280506128;985.9901400986042;3321.568196134487;3664.926701465956;3707.1658876753054;3843.1545060086737;3876.6511014008875;7474.5888976106835;9668.516574171263;9832.213422926148;9842.212622990144;10012.649557265606;9920.702378928643;9978.700638980843;10024.448655324028;10034.498275086216;10058.748531286776;7704;7900.367970562341;7916.920830791733;7932.920670793218;7940.801479962932;4451.399061126836;4460.910781784281;5122.667026643406;5617.859553511195;5641.774329026793;8724.520151391735;8948.910510894808;9162.221211197122;9201.401908875901;9214.677486287948;9220.216281616138;9281.071892810665;9344.719658410258;9350.064993500595;9467.195288400562;5952.523798096228;5986.431289027535;7160.212376638461;7163.06880105583;7207.13514378278;7806.804829879298;7878.881816772639;7879.172686867796;7893.644785984759;7914.881276780968;6536.477081833346;7056.647167641495;7212.783616491513;7213.891791623025;7260.709571617076;7027;7060.152781666233;7138.143422789299;7358.881537885408;7362.558246505227;5479.780808767605;6291.779787707408;6347.270063942521;6417.743290268524;6474.967625161844;4906.460289368095;5052.797888084436;5087.465816089258;5091.261767043832;5129.589632829439;4344.9131017380105;4867.904721437648;4935.8025678972435;4945.406551213733;5231.346081739783 10:04:43 INFO - PROCESS | 1637 | |4;prototype.html;346.3091133189288;348.73670378863955;367.48735513958013;370.1782043862625;374.95875453700086;4818.012307476967;5135.50785465883;5248.5538729208065;5422.783088676458;5509.283793106895;4476.910461790762;4900.632452566063;4943.615787579483;5247.212918062283;5277.498637629419;3394.8981530554124;3482.564679415073;3705.5553333600005;3750.893486421512;4042.3734321180264;3894.687492289094;4043;4105.240530501852;4110.958890411088;4125.814338354781;3968.127012057357;3984.6613037891816;4019.336809426441;4019.9799001004953;4035.8497828118993;3723.7579557328686;3869.9032524186837;3999.5600483946887;4007.3788562772816;4030.496187976503;3188.1551388881967;3420.96579034209;3452.637473065317;3489.7731647442833;3490.685838274542;4967.137323503686;5181.455947125535;5255.421903590602;5280.128778751501;5311.575073994071;3511.6663916928105;3916.5104361954754;4205.537390887031;4295.91408171838;4397.846075387346;5675.34733505648;5681.261436013292;5717.199592057115;5721.942780572224;5760.222369980041;2934.6918573549683;3425.74306926979;3550.6981906537717;3676.761010534307;3870.845166193349;5294.788208471657;5533.114701647717;5587.245721827542;5756.194132821408;5798.913016304801;3279.5244689519886;3479.582450105953;3891.3384724596885;3896.9610303897166;3933.8033098344968;3755.75587586806;3917.2753040686994;3939.9606003940166;3948.3287841067086;3949.822257998397;4023.4970628671417;4291.420658211164;4584.15193189261;4606.0097079128145;4614.377059097046;5647.7176141193595;5684.516816070598;5732.3121225453215;5762.683052432073;5769.451902069297;1109.0960866893456;1267.4106540458731;1280.7182419867613;1284.9678758031123;1303.5763376902544;746.958917259545;812.524673066251;866.7269810009826;868.5700578213698;882.6910581296495;4471.932921006188;4750.738709371018;4925.310456536088;5028.416048944644;5041.924371134436;4935.950640493621;5098.59211263098;5265.842024739264;5325.961437519724;5642.210090587321;3612.753600007993;4256.5953235432235;5010.398752149766;5065.138926382524;5092.159793634083;2652.6153707712274;2807.7332653397893;2856.600075989363;2962.8074175178544;2981.925451863677;4773.904521909542;5106.693598384109;5128.769205385766;5777.851071166225;5901.616394934315;5475.534579560703;5683.318001839723;5724.8282551523525;5738.188287739062;5750.441053731133;4843.1524483216;5420.888717812839;5697.971510142423;5767;5887.940170769217;4778.737169455713;4905.3623029006;5232.921506177487;5694.715264236855;5722.628029178257;4530.478994915627;5362.624616276823;5483.314585676791;5486.954740119112;5497.312835895513;5173.861750414902;5556.861078473071;5836.328822185503;5857.552476197177;5969.432903874125;3843;3887.7667339959694;3910.2570511602703;3915.4126880968083;3929;4617.984043510422;5439.422567455394;5535.750891209986;5676.574256930664;5840.532757379485;5095.821646242363;5355.116405793001;5555.3611334697025;5647.181158732043;5651.43485651448;4819.903601927872;5511.311086114236;5629.634073785191;5638.407967163389;5657.236273103243;4920.31115643803;4974.303597496281;5170.146925757358;5222.817201397933;5628.521575666115;4541.886452838706;5691.26013618227;5694.487496125369;5721.485066344049;5733.913991290051;5174.379074511083;5418.85955047746;5622.453825198103;5634.225219055984;5638.971805140948 10:04:43 INFO - PROCESS | 1637 | |5;yui.html;608.6348191085347;683.2416018219778;759.6885277036416;788.0056823525338;793.2781169136085;10973.902609739032;15010.924945375285;15101.018433801795;15264.618384540392;15292.464763733271;13942;14160.858391416108;14229.217393043378;14341.354639041243;14347;881.8412685716569;889.4085433186955;896.5651658945407;896.977575560613;899.8875140607424;882.4793371910572;886.8093359927615;887.8934527856666;907.850204716221;917.2203626917134;874.8583099055729;889.968851090212;958.8417911044669;960.1023043454358;962.6678795815468;945.1021529546958;951.4814426137772;958.4632605740808;958.7363475044349;960.8270511307961;702.1398786486565;709.8260926073093;711.2816055783644;712.3197346534099;713.678844519968;12703.872961270361;15154.621134471616;15542.844571554253;15563.688726225526;15583.532494025198;13483.460661573525;13704.10923289993;13782.586522404345;13810.861891381059;13826.861731382658;8447.662093516252;9450.33847630666;11343.432828358631;11680.532778688843;11717.824232636518;3247.285597168619;3542.6988705960025;3666.5233519642543;3774.226283611853;3781.9054523636855;78071.60964195199;95038.57442138373;100464.49767751187;101234.99999999926;102205.48897255541;10454.738631534272;10461.84307235392;10482.423466709251;10586.735331616617;11130.443477826077;21645.783542164692;21772.782272177392;21803.454913627287;21939.122435102738;22027;7481.925180748123;7574.204708505527;7647.235276472419;7673.3477654398885;7925.167857375008;4019.678425725935;4109.486314210723;4135.31767258405;4178.979105104516;4361.127774445124;3274.279658475132;3344.7156991655984;3362.9663703362653;3366.124807550055;3383.4924761286006;673.1249375811426;679.4360680635061;680.3332733920786;694.3195668245047;697.8255436140964;630.4515071887396;636.7166610858217;650.8730797494443;670.3497607320891;694.3924066441863;8349.680298288464;9545;9827.606895724233;10153.593856245667;10157.984201579931;589.799468180812;648.5946283572767;681.7102731339161;693.486819753389;705.2527980138178;4899.912147037046;4928.457869634337;4943.2585112233455;4950.975245123824;4960.429550601655;77801;84341.73487397694;84419;103768.44347334796;107753.92246077595;62099.13702588929;76941.23058769453;77339.61330193313;79788.4042319162;85701;35899.56401743953;47509.33717319877;72564;76623;77814.61092694727;8705.952916479182;8959.283257339528;8959.372843901125;8961.7759556009;8985.326100542356;49794.751026246086;49834.50165498299;50216.74891625519;50494;51719.72484402628;54727.72636136794;60367.69816150891;60924;64803.37991550249;67372.66313668597;12837.229766214057;13010.869891300967;13031.674208144494;13236.933815330862;13695.657608559468;11431.027503036206;14223.841125692496;14269.072510286798;14368.281585920453;14725.337359818619;10784.029437350677;11333.489992950503;13163.276019819003;13293.80059299092;13349.466021359036;13292.468301267842;13359.332033398485;13441.462341506622;13475.865241347854;13588.864111359155;11086.833697494383;12649.114561980574;12891.226526408445;12891.677708057374;13355.732885342433;10376.599159113724;10641.627543035956;10691.893081069089;10870.456477176267;11141.16441266892;9241.768955776159;9505.572249248662;9793.706188814347;9831.771028621422;10919.617813376493 10:04:43 INFO - PROCESS | 1637 | __end_tp_report 10:04:43 INFO - PROCESS | 1637 | __start_cc_report 10:04:43 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,435 10:04:43 INFO - PROCESS | 1637 | __end_cc_report 10:04:43 INFO - PROCESS | 1637 | __startTimestamp1487786683924__endTimestamp 10:04:43 INFO - PROCESS | 1637 | 10:04:43 INFO - PROCESS | 1637 | ------- Summary: start ------- 10:04:43 INFO - PROCESS | 1637 | Number of tests: 6 10:04:43 INFO - PROCESS | 1637 | 10:04:43 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5553.23 Median:5777.94 stddev:789.50 (13.7%) stddev-sans-first:761.38 10:04:43 INFO - PROCESS | 1637 | Values: 2781.5 3295.6 3325.6 3357.9 3375.5 4871.5 5149.5 5588.4 5653.6 5706.7 4697.0 4987.2 5394.3 5587.7 5635.5 5023.4 5033.1 5113.7 5169.8 5184.6 5142.8 5154.8 5169.3 5213.2 5213.3 5170.9 5176.2 5208.3 5217.5 5253.4 150.2 4391.8 5107.8 5113.5 5158.6 5091.6 5105.8 5121.6 5129.9 5147.2 5416.1 5587.6 5620.7 5654.5 5689.9 5870.1 5927.2 5992.0 6109.3 6130.9 6215.8 6229.3 6237.3 6259.3 6270.5 5726.5 5728.8 5752.0 5756.4 5769.8 4779.8 6022.8 6112.5 6204.7 6255.2 4956.8 5789.0 5990.4 6063.6 6076.4 6157.1 6183.7 6204.2 6212.3 6219.5 5964.9 5966.3 6043.8 6096.3 6113.1 5084.3 5118.2 6063.1 6107.3 6141.0 4151.5 4804.9 4922.3 4932.5 4949.3 4288.0 4314.0 4332.4 4377.2 4412.1 5818.4 5819.7 5832.2 5838.0 5853.1 6116.7 6149.0 6165.7 6167.4 6171.9 5542.2 5553.6 5561.5 5630.2 5635.7 5379.5 5394.1 5440.2 5469.7 5482.5 6286.8 6287.3 6289.3 6293.5 6311.6 6043.1 6074.8 6100.0 6249.1 6279.8 6148.5 6157.3 6218.4 6241.9 6260.0 6101.0 6108.6 6123.9 6128.7 6132.4 5954.8 6133.4 6137.8 6170.2 6223.7 5829.2 5888.6 5935.1 5945.5 5950.3 4899.6 5089.3 5825.2 5901.1 5946.6 4711.3 5286.3 5368.7 5466.5 5793.5 5931.8 6036.4 6053.6 6070.2 6073.8 5672.6 5736.9 5777.9 5938.3 5953.3 10:04:43 INFO - PROCESS | 1637 | 10:04:43 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:68018.39 Median:35451.41 stddev:147607.47 (416.4%) stddev-sans-first:147934.38 10:04:43 INFO - PROCESS | 1637 | Values: 454.2 460.1 473.5 482.4 491.0 39180.4 41534.6 41806.2 41901.4 43993.1 43250.4 43389.6 43514.9 43681.6 43741.3 6673.8 7605.1 9373.9 9610.8 9624.8 10726.4 11690.6 11699.4 11898.0 11989.5 9905.9 11815.9 11823.7 11883.6 11923.9 11679.6 11691.5 11767.6 11773.9 11799.1 11596.0 11649.4 11691.1 11756.0 11761.0 40934.4 40967.0 41145.4 41172.6 41266.8 3863.6 3896.8 3908.6 3909.7 3974.3 29986.3 30356.5 30742.8 31379.4 31530.5 2907.2 3004.5 3020.2 3020.7 3032.0 465892.0 467541.0 469176.0 471180.0 472051.0 46701.3 47917.0 55276.4 55775.4 56305.9 56155.2 60247.4 60405.8 60432.0 60463.1 14661.7 14696.6 14888.4 14890.6 14920.6 11236.8 11287.9 11310.3 11316.9 11347.1 15053.2 17194.0 17654.4 17785.0 17822.1 7079.1 7394.9 7797.7 7834.0 7879.3 773.8 789.7 822.2 837.0 853.5 25227.2 27705.4 28191.0 29967.0 30375.4 1013.9 1022.0 1051.9 1072.4 1199.9 15366.8 15618.0 15645.2 15715.0 16010.4 617785.0 618390.0 620336.0 620656.0 621356.0 59690.0 60168.0 60284.0 60329.7 60333.4 1374.4 1417.8 1420.2 1420.4 1424.4 25354.0 28301.0 29540.3 30040.1 30304.0 50679.0 51257.5 51679.7 51851.7 55426.4 501228.0 552292.0 576009.0 579957.1 580912.0 30627.2 31393.6 37355.1 37710.6 37814.5 41297.0 42034.6 42463.4 42520.8 43172.8 32098.8 33804.3 34815.0 35414.8 35934.3 27108.7 28873.1 34253.3 35216.1 35964.8 31612.8 32313.8 35488.0 35670.0 35726.8 29606.9 31262.7 31481.0 31593.4 31612.0 18570.7 19622.8 23332.0 23779.8 23934.3 10:04:43 INFO - PROCESS | 1637 | 10:04:43 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:37912.99 Median:2103.55 stddev:115524.75 (5491.9%) stddev-sans-first:115814.40 10:04:43 INFO - PROCESS | 1637 | Values: 353.4 367.1 382.1 396.6 414.1 19648.4 20140.0 21660.9 21852.9 21916.3 11914.3 12006.7 12082.4 12384.0 12413.9 4776.8 5363.7 5597.7 5604.6 5614.1 4499.8 5574.2 5785.9 6056.6 6127.6 6152.8 6165.3 6172.4 6177.0 6185.7 5673.5 5922.4 6143.8 6153.1 6162.9 5041.7 5317.3 5980.6 5986.7 6031.7 12798.5 13520.0 13539.7 13568.9 14855.7 2409.6 2509.9 2539.2 2553.8 2567.2 10243.5 10343.8 11841.3 12197.5 12313.6 1773.1 1775.5 1776.8 1777.7 1797.9 117475.0 123177.0 123231.0 123595.4 124949.0 11518.2 11867.2 11893.3 12002.3 12013.5 12610.9 15444.9 15532.5 15565.3 15588.5 8230.5 8344.8 8375.8 8404.2 8479.9 7815.0 7875.4 7915.8 8042.2 8056.5 4787.4 4840.7 4872.7 4952.6 4964.3 2022.7 2101.1 2106.0 2117.4 2119.2 999.1 1004.9 1017.2 1020.7 1050.2 20643.7 20929.8 21226.8 21277.3 21296.8 796.7 1010.3 1024.5 1029.0 1068.2 9249.6 9563.0 10043.8 10798.9 10809.5 679598.0 688486.0 691235.0 701263.0 709702.0 125681.4 132884.0 141501.0 142935.0 144490.0 1022.7 1034.4 1063.0 1065.1 1065.7 18507.6 19812.2 19831.9 19841.4 19911.5 45601.0 59333.0 60136.7 60352.4 60838.0 73352.6 82427.6 87580.0 88184.1 88233.1 8016.7 8103.5 8120.4 8553.6 8556.3 9346.4 12312.3 13264.4 13265.3 13538.3 11238.0 11472.9 11616.2 11678.1 11826.2 10155.2 11326.0 11347.0 11666.6 11760.5 11214.3 11266.3 11686.1 11727.2 11881.6 6498.8 8114.6 8326.8 8641.9 8718.7 10442.9 10648.3 10965.5 11156.3 11263.6 10:04:43 INFO - PROCESS | 1637 | 10:04:43 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5345.43 Median:5112.57 stddev:2944.45 (57.6%) stddev-sans-first:2937.03 10:04:43 INFO - PROCESS | 1637 | Values: 1303.1 1405.6 1447.5 1456.9 1480.1 8093.3 8254.1 8421.5 8535.9 8545.9 7296.3 8496.0 8554.8 8610.0 8627.7 2297.9 2327.9 2328.9 2330.7 2334.5 2288.9 2344.4 2354.2 2355.1 2356.6 2303.3 2308.1 2329.5 2332.7 2339.4 2233.2 2287.8 2315.4 2318.8 2323.0 1950.4 2032.8 2241.3 2305.1 2336.1 8400.1 8503.4 8540.6 8549.4 8573.2 4773.7 4941.3 5086.9 5261.3 5264.0 3428.9 3440.6 3456.8 3527.4 3544.9 1026.5 1209.1 1227.6 1227.7 1263.2 10720.8 10721.2 10772.1 10855.5 10859.5 3481.6 4144.5 4488.4 4491.4 4497.0 8578.8 8630.4 8660.1 8677.5 8678.4 5013.0 5097.9 5101.7 5111.3 5113.9 4627.6 4699.4 4747.6 4804.1 4816.2 3055.8 3124.9 3623.4 3662.5 3717.2 1151.5 1160.1 1176.3 1176.6 1176.8 848.2 878.1 887.2 917.1 920.7 5498.0 5514.0 5582.6 5702.6 5777.1 574.7 589.3 590.1 905.4 986.0 3321.6 3664.9 3707.2 3843.2 3876.7 7474.6 9668.5 9832.2 9842.2 10012.6 9920.7 9978.7 10024.4 10034.5 10058.7 7704.0 7900.4 7916.9 7932.9 7940.8 4451.4 4460.9 5122.7 5617.9 5641.8 8724.5 8948.9 9162.2 9201.4 9214.7 9220.2 9281.1 9344.7 9350.1 9467.2 5952.5 5986.4 7160.2 7163.1 7207.1 7806.8 7878.9 7879.2 7893.6 7914.9 6536.5 7056.6 7212.8 7213.9 7260.7 7027.0 7060.2 7138.1 7358.9 7362.6 5479.8 6291.8 6347.3 6417.7 6475.0 4906.5 5052.8 5087.5 5091.3 5129.6 4344.9 4867.9 4935.8 4945.4 5231.3 10:04:43 INFO - PROCESS | 1637 | 10:04:43 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4450.46 Median:4992.35 stddev:1381.08 (27.7%) stddev-sans-first:1350.16 10:04:43 INFO - PROCESS | 1637 | Values: 346.3 348.7 367.5 370.2 375.0 4818.0 5135.5 5248.6 5422.8 5509.3 4476.9 4900.6 4943.6 5247.2 5277.5 3394.9 3482.6 3705.6 3750.9 4042.4 3894.7 4043.0 4105.2 4111.0 4125.8 3968.1 3984.7 4019.3 4020.0 4035.8 3723.8 3869.9 3999.6 4007.4 4030.5 3188.2 3421.0 3452.6 3489.8 3490.7 4967.1 5181.5 5255.4 5280.1 5311.6 3511.7 3916.5 4205.5 4295.9 4397.8 5675.3 5681.3 5717.2 5721.9 5760.2 2934.7 3425.7 3550.7 3676.8 3870.8 5294.8 5533.1 5587.2 5756.2 5798.9 3279.5 3479.6 3891.3 3897.0 3933.8 3755.8 3917.3 3940.0 3948.3 3949.8 4023.5 4291.4 4584.2 4606.0 4614.4 5647.7 5684.5 5732.3 5762.7 5769.5 1109.1 1267.4 1280.7 1285.0 1303.6 747.0 812.5 866.7 868.6 882.7 4471.9 4750.7 4925.3 5028.4 5041.9 4936.0 5098.6 5265.8 5326.0 5642.2 3612.8 4256.6 5010.4 5065.1 5092.2 2652.6 2807.7 2856.6 2962.8 2981.9 4773.9 5106.7 5128.8 5777.9 5901.6 5475.5 5683.3 5724.8 5738.2 5750.4 4843.2 5420.9 5698.0 5767.0 5887.9 4778.7 4905.4 5232.9 5694.7 5722.6 4530.5 5362.6 5483.3 5487.0 5497.3 5173.9 5556.9 5836.3 5857.6 5969.4 3843.0 3887.8 3910.3 3915.4 3929.0 4618.0 5439.4 5535.8 5676.6 5840.5 5095.8 5355.1 5555.4 5647.2 5651.4 4819.9 5511.3 5629.6 5638.4 5657.2 4920.3 4974.3 5170.1 5222.8 5628.5 4541.9 5691.3 5694.5 5721.5 5733.9 5174.4 5418.9 5622.5 5634.2 5639.0 10:04:43 INFO - PROCESS | 1637 | 10:04:43 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:18693.97 Median:4947.12 stddev:26126.33 (528.1%) stddev-sans-first:26164.33 10:04:43 INFO - PROCESS | 1637 | Values: 608.6 683.2 759.7 788.0 793.3 10973.9 15010.9 15101.0 15264.6 15292.5 13942.0 14160.9 14229.2 14341.4 14347.0 881.8 889.4 896.6 897.0 899.9 882.5 886.8 887.9 907.9 917.2 874.9 890.0 958.8 960.1 962.7 945.1 951.5 958.5 958.7 960.8 702.1 709.8 711.3 712.3 713.7 12703.9 15154.6 15542.8 15563.7 15583.5 13483.5 13704.1 13782.6 13810.9 13826.9 8447.7 9450.3 11343.4 11680.5 11717.8 3247.3 3542.7 3666.5 3774.2 3781.9 78071.6 95038.6 100464.5 101235.0 102205.5 10454.7 10461.8 10482.4 10586.7 11130.4 21645.8 21772.8 21803.5 21939.1 22027.0 7481.9 7574.2 7647.2 7673.3 7925.2 4019.7 4109.5 4135.3 4179.0 4361.1 3274.3 3344.7 3363.0 3366.1 3383.5 673.1 679.4 680.3 694.3 697.8 630.5 636.7 650.9 670.3 694.4 8349.7 9545.0 9827.6 10153.6 10158.0 589.8 648.6 681.7 693.5 705.3 4899.9 4928.5 4943.3 4951.0 4960.4 77801.0 84341.7 84419.0 103768.4 107753.9 62099.1 76941.2 77339.6 79788.4 85701.0 35899.6 47509.3 72564.0 76623.0 77814.6 8706.0 8959.3 8959.4 8961.8 8985.3 49794.8 49834.5 50216.7 50494.0 51719.7 54727.7 60367.7 60924.0 64803.4 67372.7 12837.2 13010.9 13031.7 13236.9 13695.7 11431.0 14223.8 14269.1 14368.3 14725.3 10784.0 11333.5 13163.3 13293.8 13349.5 13292.5 13359.3 13441.5 13475.9 13588.9 11086.8 12649.1 12891.2 12891.7 13355.7 10376.6 10641.6 10691.9 10870.5 11141.2 9241.8 9505.6 9793.7 9831.8 10919.6 10:04:43 INFO - PROCESS | 1637 | -------- Summary: end -------- 10:04:43 INFO - PROCESS | 1637 | 10:04:44 INFO - TEST-INFO | 1637: exit 0 10:04:44 INFO - TEST-OK | dromaeo_css | took 1116263ms 10:04:44 INFO - TEST-START | kraken 10:04:44 INFO - operating with platform_type : mac_ 10:04:44 INFO - Initialising browser for kraken test... 10:04:44 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/tmpHWvv7i/profile http://localhost:49241/getInfo.html) 10:04:47 INFO - PROCESS | 1648 | 2017-02-22 10:04:47.369 plugin-container[1649:10821] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 10:04:47 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:04:47 INFO - PROCESS | 1648 | 2017-02-22 10:04:47.372 plugin-container[1649:10821] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 10:04:47 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:04:47 INFO - PROCESS | 1648 | 2017-02-22 10:04:47.372 plugin-container[1649:10821] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:04:47 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 10:04:47 INFO - PROCESS | 1648 | colorDepth:24 10:04:47 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 10:04:47 INFO - PROCESS | 1648 | __metrics 10:04:47 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 10:04:48 INFO - TEST-INFO | 1648: exit 0 10:04:48 INFO - Browser initialized. 10:04:48 INFO - Running cycle 1/1 for kraken test... 10:04:48 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/tmpHWvv7i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:04:50 INFO - PROCESS | 1650 | 2017-02-22 10:04:50.775 plugin-container[1651:10948] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4643, name = 'com.apple.tsm.portname' 10:04:50 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:04:50 INFO - PROCESS | 1650 | 2017-02-22 10:04:50.775 plugin-container[1651:10948] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 10:04:50 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:04:50 INFO - PROCESS | 1650 | 2017-02-22 10:04:50.775 plugin-container[1651:10948] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:05:00 INFO - PROCESS | 1650 | RSS: Main: 227266560 10:05:00 INFO - PROCESS | 1650 | 10:05:03 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 10:05:04 INFO - PROCESS | 1650 | RSS: Main: 240750592 10:05:04 INFO - PROCESS | 1650 | 10:05:07 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 10:05:07 INFO - PROCESS | 1650 | RSS: Main: 248770560 10:05:07 INFO - PROCESS | 1650 | 10:05:11 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 10:05:11 INFO - PROCESS | 1650 | RSS: Main: 251408384 10:05:11 INFO - PROCESS | 1650 | 10:05:13 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 10:05:14 INFO - PROCESS | 1650 | RSS: Main: 253722624 10:05:14 INFO - PROCESS | 1650 | 10:05:16 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:05:17 INFO - PROCESS | 1650 | RSS: Main: 254001152 10:05:17 INFO - PROCESS | 1650 | 10:05:20 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 10:05:20 INFO - PROCESS | 1650 | RSS: Main: 260214784 10:05:20 INFO - PROCESS | 1650 | 10:05:24 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 10:05:24 INFO - PROCESS | 1650 | RSS: Main: 259198976 10:05:24 INFO - PROCESS | 1650 | 10:05:27 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 10:05:28 INFO - PROCESS | 1650 | RSS: Main: 259100672 10:05:28 INFO - PROCESS | 1650 | 10:05:30 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:05:30 INFO - PROCESS | 1650 | RSS: Main: 258506752 10:05:30 INFO - PROCESS | 1650 | 10:05:32 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:05:33 INFO - PROCESS | 1650 | RSS: Main: 258555904 10:05:33 INFO - PROCESS | 1650 | 10:05:35 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:05:36 INFO - PROCESS | 1650 | RSS: Main: 258859008 10:05:36 INFO - PROCESS | 1650 | 10:05:39 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:05:40 INFO - PROCESS | 1650 | RSS: Main: 259211264 10:05:40 INFO - PROCESS | 1650 | 10:05:43 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:05:43 INFO - PROCESS | 1650 | RSS: Main: 259018752 10:05:43 INFO - PROCESS | 1650 | 10:05:45 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 10:05:45 INFO - PROCESS | 1650 | RSS: Main: 261529600 10:05:45 INFO - PROCESS | 1650 | 10:05:45 INFO - PROCESS | 1650 | __start_tp_report 10:05:45 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 10:05:45 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 10:05:45 INFO - PROCESS | 1650 | |i|pagename|runs| 10:05:45 INFO - PROCESS | 1650 | |0;ai-astar;131;175;97;167;176;175;118;120;126;174 10:05:45 INFO - PROCESS | 1650 | |1;audio-beat-detection;157;117;115;169;151;123;142;144;132;149 10:05:45 INFO - PROCESS | 1650 | |2;audio-dft;203;216;223;196;196;198;197;193;195;196 10:05:45 INFO - PROCESS | 1650 | |3;audio-fft;84;62;61;89;68;87;52;78;99;91 10:05:45 INFO - PROCESS | 1650 | |4;audio-oscillator;91;70;86;70;73;71;83;75;70;84 10:05:45 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;88;88;90;88;100;127;137;96;89;91 10:05:45 INFO - PROCESS | 1650 | |6;imaging-darkroom;97;120;155;102;154;117;95;101;151;128 10:05:45 INFO - PROCESS | 1650 | |7;imaging-desaturate;99;96;151;145;104;144;89;148;80;151 10:05:45 INFO - PROCESS | 1650 | |8;json-parse-financial;63;61;62;62;64;63;63;62;63;62 10:05:45 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;68;66;77;79;75;69;68;68;70;69 10:05:45 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;95;108;114;89;93;91;90;90;87;88 10:05:45 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;144;150;154;152;144;146;137;159;182;168 10:05:45 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;178;206;240;191;173;177;176;173;173;177 10:05:45 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;70;66;68;68;83;68;64;86;90;91 10:05:45 INFO - PROCESS | 1650 | __end_tp_report 10:05:45 INFO - PROCESS | 1650 | __start_cc_report 10:05:45 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,994 10:05:45 INFO - PROCESS | 1650 | __end_cc_report 10:05:45 INFO - PROCESS | 1650 | __startTimestamp1487786745809__endTimestamp 10:05:45 INFO - PROCESS | 1650 | 10:05:45 INFO - PROCESS | 1650 | ------- Summary: start ------- 10:05:45 INFO - PROCESS | 1650 | Number of tests: 14 10:05:45 INFO - PROCESS | 1650 | 10:05:45 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:145.90 Median:174.50 stddev:30.36 (17.4%) stddev-sans-first:31.71 10:05:45 INFO - PROCESS | 1650 | Values: 131.0 175.0 97.0 167.0 176.0 175.0 118.0 120.0 126.0 174.0 10:05:45 INFO - PROCESS | 1650 | 10:05:45 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:146.50 stddev:17.82 (12.2%) stddev-sans-first:17.80 10:05:45 INFO - PROCESS | 1650 | Values: 157.0 117.0 115.0 169.0 151.0 123.0 142.0 144.0 132.0 149.0 10:05:45 INFO - PROCESS | 1650 | 10:05:45 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:201.30 Median:197.50 stddev:10.07 (5.1%) stddev-sans-first:10.66 10:05:45 INFO - PROCESS | 1650 | Values: 203.0 216.0 223.0 196.0 196.0 198.0 197.0 193.0 195.0 196.0 10:05:45 INFO - PROCESS | 1650 | 10:05:45 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:77.10 Median:85.50 stddev:15.50 (18.1%) stddev-sans-first:16.23 10:05:45 INFO - PROCESS | 1650 | Values: 84.0 62.0 61.0 89.0 68.0 87.0 52.0 78.0 99.0 91.0 10:05:45 INFO - PROCESS | 1650 | 10:05:45 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:79.00 stddev:7.92 (10.0%) stddev-sans-first:6.67 10:05:45 INFO - PROCESS | 1650 | Values: 91.0 70.0 86.0 70.0 73.0 71.0 83.0 75.0 70.0 84.0 10:05:45 INFO - PROCESS | 1650 | 10:05:45 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:99.40 Median:88.50 stddev:17.78 (20.1%) stddev-sans-first:18.37 10:05:45 INFO - PROCESS | 1650 | Values: 88.0 88.0 90.0 88.0 100.0 127.0 137.0 96.0 89.0 91.0 10:05:45 INFO - PROCESS | 1650 | 10:05:45 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:122.00 Median:152.50 stddev:24.07 (15.8%) stddev-sans-first:23.77 10:05:45 INFO - PROCESS | 1650 | Values: 97.0 120.0 155.0 102.0 154.0 117.0 95.0 101.0 151.0 128.0 10:05:45 INFO - PROCESS | 1650 | 10:05:45 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:120.70 Median:115.50 stddev:29.32 (25.4%) stddev-sans-first:30.03 10:05:45 INFO - PROCESS | 1650 | Values: 99.0 96.0 151.0 145.0 104.0 144.0 89.0 148.0 80.0 151.0 10:05:45 INFO - PROCESS | 1650 | 10:05:45 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:63.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 10:05:45 INFO - PROCESS | 1650 | Values: 63.0 61.0 62.0 62.0 64.0 63.0 63.0 62.0 63.0 62.0 10:05:45 INFO - PROCESS | 1650 | 10:05:45 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:69.50 stddev:4.43 (6.4%) stddev-sans-first:4.58 10:05:45 INFO - PROCESS | 1650 | Values: 68.0 66.0 77.0 79.0 75.0 69.0 68.0 68.0 70.0 69.0 10:05:45 INFO - PROCESS | 1650 | 10:05:45 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:94.50 Median:90.00 stddev:9.11 (10.1%) stddev-sans-first:9.66 10:05:45 INFO - PROCESS | 1650 | Values: 95.0 108.0 114.0 89.0 93.0 91.0 90.0 90.0 87.0 88.0 10:05:45 INFO - PROCESS | 1650 | 10:05:45 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:153.60 Median:153.00 stddev:13.23 (8.7%) stddev-sans-first:13.57 10:05:45 INFO - PROCESS | 1650 | Values: 144.0 150.0 154.0 152.0 144.0 146.0 137.0 159.0 182.0 168.0 10:05:45 INFO - PROCESS | 1650 | 10:05:45 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.40 Median:177.50 stddev:21.53 (12.1%) stddev-sans-first:22.62 10:05:45 INFO - PROCESS | 1650 | Values: 178.0 206.0 240.0 191.0 173.0 177.0 176.0 173.0 173.0 177.0 10:05:45 INFO - PROCESS | 1650 | 10:05:45 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.40 Median:76.50 stddev:10.74 (14.0%) stddev-sans-first:11.21 10:05:45 INFO - PROCESS | 1650 | Values: 70.0 66.0 68.0 68.0 83.0 68.0 64.0 86.0 90.0 91.0 10:05:45 INFO - PROCESS | 1650 | -------- Summary: end -------- 10:05:45 INFO - PROCESS | 1650 | 10:05:46 INFO - TEST-INFO | 1650: exit 0 10:05:46 INFO - TEST-OK | kraken | took 62077ms 10:05:46 INFO - SUITE-END | took 1178s 10:05:46 INFO - Completed test suite (00:19:38) 10:05:46 INFO - javascript benchmark 10:05:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7119.935490318462, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2781.4576157649253, 3295.637479877213, 3325.5510506081687, 3357.865685372585, 3375.4768010958296, 4871.488493708154, 5149.459306772791, 5588.357338906022, 5653.604247702662, 5706.7431965561545, 4696.976515117428, 4987.202047672373, 5394.271773310602, 5587.7485513151905, 5635.549156067515, 5023.372078490189, 5033.094043072246, 5113.693178409308, 5169.844904652867, 5184.559312458446, 5142.768575414116, 5154.845354639367, 5169.30214421054, 5213.218017297417, 5213.322268105141, 5170.922436163461, 5176.197689358137, 5208.2968799212185, 5217.530422261995, 5253.422123566424, 150.16059454762475, 4391.758453285068, 5107.846764597068, 5113.51421614946, 5158.561522270612, 5091.592672586185, 5105.846824595231, 5121.641485096045, 5129.871753206163, 5147.22791581262, 5416.1063424534905, 5587.55299576037, 5620.747066381981, 5654.491095801398, 5689.886202275973, 5870.11948207768, 5927.199828023205, 5992.0, 6109.327973922865, 6130.938690613126, 6215.844603884894, 6229.314775374705, 6237.313895471494, 6259.311475737665, 6270.46701030413, 5726.531934511209, 5728.77084916607, 5752.0, 5756.395578464243, 5769.759501707111, 4779.808807647724, 6022.819315420545, 6112.473085128069, 6204.658743769046, 6255.218097737783, 4956.810365512251, 5789.015867302569, 5990.400959904062, 6063.636181829016, 6076.361981991916, 6157.138000679908, 6183.721732522047, 6204.193454850841, 6212.254529456494, 6219.471344935731, 5964.940350596438, 5966.284045914431, 6043.8186854394435, 6096.298925623521, 6113.113598528189, 5084.339035925306, 5118.181091025418, 6063.120847477091, 6107.340534417129, 6140.969295153495, 4151.46031015966, 4804.855854324376, 4922.335484709519, 4932.506749325039, 4949.257611358325, 4288.035192081819, 4314.0, 4332.393464914914, 4377.190219809282, 4412.117576484716, 5818.389069147764, 5819.738111784895, 5832.24180856486, 5837.970810146007, 5853.122031695195, 6116.724747386378, 6148.9692551536955, 6165.691715414211, 6167.383261673796, 6171.907421388682, 5542.224088627595, 5553.611247212656, 5561.499465048165, 5630.18362337467, 5635.6618602883955, 5379.488948549882, 5394.136938089887, 5440.238366628675, 5469.671819690831, 5482.506574408322, 6286.811395658046, 6287.308396076428, 6289.308176100625, 6293.465055470245, 6311.558190926591, 6043.12374705674, 6074.817755467343, 6099.963006288853, 6249.093881387264, 6279.780207692709, 6148.538859585459, 6157.291911430243, 6218.440340369389, 6241.906371404341, 6260.0, 6100.993336099494, 6108.633481991094, 6123.877522449437, 6128.693565321805, 6132.448079672851, 5954.821355359346, 6133.417325354084, 6137.754489820357, 6170.197874276315, 6223.719932603134, 5829.183914252093, 5888.558358123072, 5935.109733540004, 5945.494632956247, 5950.315713692808, 4899.632527560519, 5089.338386009795, 5825.242718446575, 5901.05583106718, 5946.613470124428, 4711.340412342343, 5286.286351342674, 5368.731563421891, 5466.508014278734, 5793.536517078539, 5931.762729490944, 6036.366181550874, 6053.576249662481, 6070.2108725865355, 6073.817785466443, 5672.5745569081655, 5736.913946290725, 5777.94222057774, 5938.287405511366, 5953.315368732651], "value": 5504.110520856491, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [454.2391494247135, 460.084431980359, 473.519377831501, 482.3560546670195, 491.01306374187874, 39180.41229381558, 41534.58465415345, 41806.16387672245, 41901.371479427835, 43993.12013759731, 43250.351244731355, 43389.56610433895, 43514.91212719683, 43681.56318436815, 43741.34387984183, 6673.833154171136, 7605.087389513266, 9373.906260937372, 9610.75973100671, 9624.80750384992, 10726.410047447387, 11690.649280521598, 11699.35653539055, 11898.048156147488, 11989.520419183222, 9905.860826004993, 11815.881841181565, 11823.704407389798, 11883.643490695249, 11923.940380298087, 11679.649610511698, 11691.532338706484, 11767.58813441534, 11773.882261177407, 11799.115066370057, 11595.956363927202, 11649.38868950628, 11691.064714822794, 11756.0, 11761.0, 40934.38598421026, 40967.0, 41145.382819257735, 41172.58827411717, 41266.79366603148, 3863.632954869283, 3896.8051597420017, 3908.55051669056, 3909.7263191576603, 3974.324364857981, 29986.25034374136, 30356.54465183024, 30742.84628576865, 31379.37241255162, 31530.527042094385, 2907.1714561350127, 3004.4892368297224, 3020.1845501714415, 3020.652624948137, 3031.9545206821917, 465892.0, 467541.0, 469175.99999999657, 471180.0, 472051.0, 46701.29948050782, 47917.0, 55276.447235527936, 55775.442245577025, 56305.87388252212, 56155.157672634945, 60247.39752602505, 60405.75130984222, 60432.0, 60463.09305360423, 14661.706765864623, 14696.632584185481, 14888.404463821542, 14890.553283401516, 14920.626984325261, 11236.831447528293, 11287.887121128848, 11310.321380717183, 11316.943415283036, 11347.092232621371, 15053.247337633074, 17194.0, 17654.382096626556, 17785.0, 17822.10889455548, 7079.115110611174, 7394.929419762475, 7797.727079552188, 7833.960830195812, 7879.290863822283, 773.8490994256179, 789.6762327445834, 822.2312138150728, 836.983260334802, 853.5092321914924, 25227.243182704548, 27705.44589108247, 28191.0, 29966.951156709412, 30375.392492150033, 1013.9087482126497, 1021.9642312519026, 1051.8842927277992, 1072.3619446429361, 1199.9100067494974, 15366.791925973253, 15618.0, 15645.217739112999, 15715.0, 16010.359585616678, 617785.0, 618390.0, 620336.0, 620656.0, 621356.0, 59690.0, 60168.0, 60284.0, 60329.698351508836, 60333.39666603366, 1374.3746595299115, 1417.780244062172, 1420.155007770375, 1420.3821337718125, 1424.4444666579834, 25354.0, 28301.0, 29540.261493461974, 30040.098797036124, 30304.0, 50679.0, 51257.48742512527, 51679.74160129175, 51851.74074129605, 55426.445735542125, 501228.0, 552292.0, 576009.0, 579957.1002144963, 580912.0, 30627.2343191422, 31393.587288571613, 37355.14383130176, 37710.62289377071, 37814.48742050287, 41297.0, 42034.57965420429, 42463.36304955366, 42520.78739606282, 43172.78413607912, 32098.83950580232, 33804.32391352209, 34815.0, 35414.822925886234, 35934.281314374086, 27108.72891271062, 28873.133805985854, 34253.31493370169, 35216.11959701028, 35964.82017589895, 31612.841935790173, 32313.838430808635, 35488.0, 35670.0, 35726.821365893, 29606.851965740032, 31262.687373126886, 31481.0, 31593.36813263768, 31612.0, 18570.7000509963, 19622.8037719621, 23332.0, 23779.762202377755, 23934.28197154088], "value": 19720.960604892953, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.3798184186752, 367.0969415238513, 382.0830007980846, 396.62915174312, 414.1241274704, 19648.410547683576, 20140.0, 21660.89169554152, 21852.8907355463, 21916.342509724713, 11914.344711040889, 12006.699832504191, 12082.395880205999, 12384.00927925766, 12413.875861241384, 4776.80892764289, 5363.704996225206, 5597.6641401515835, 5604.579656525756, 5614.101743721006, 4499.820007199708, 5574.219609254687, 5785.884282314351, 6056.576039677225, 6127.601705889125, 6152.815415537541, 6165.290991535986, 6172.351903050182, 6177.0116781315, 6185.690715464231, 5673.517750991171, 5922.4373684500115, 6143.784967526138, 6153.138560601519, 6162.907556386658, 5041.747912604355, 5317.308749862493, 5980.624456375014, 5986.73059712314, 6031.673031932968, 12798.48806047757, 13520.0, 13539.729205415837, 13568.932155339258, 14855.70288594222, 2409.554232466982, 2509.874506274697, 2539.2255362114547, 2553.8084643651614, 2567.2169988153605, 10243.53904074311, 10343.79312413755, 11841.348725820077, 12197.512099516009, 12313.56902508408, 1773.0691387021789, 1775.4762345108225, 1776.786785585725, 1777.6533575952694, 1797.8921264724027, 117475.0, 123177.0, 123231.0, 123595.3820230902, 124949.0, 11518.193726439069, 11867.16929814922, 11893.34586597728, 12002.279863208236, 12013.459394327276, 12610.873891261153, 15444.922775386276, 15532.45636402743, 15565.29956151976, 15588.454404095803, 8230.465019773696, 8344.791380215422, 8375.8324833503, 8404.20160084791, 8479.872801907977, 7815.0, 7875.369970402354, 7915.802104947307, 8042.195780421911, 8056.54982103227, 4787.40157480315, 4840.685355451955, 4872.731999740048, 4952.579030782352, 4964.255361695702, 2022.686483595045, 2101.1385332014106, 2105.968410473844, 2117.4071260047212, 2119.226482333937, 999.1216512955597, 1004.8693669822876, 1017.2167431078028, 1020.7193021918883, 1050.2228351020342, 20643.69034464484, 20929.790702093087, 21226.78773212248, 21277.255296064563, 21296.78703212979, 796.7370767646663, 1010.2625083688948, 1024.5082360467018, 1028.9742756430999, 1068.1721665709138, 9249.583768730423, 9563.0, 10043.849342259871, 10798.920107989139, 10809.513571889283, 679598.0, 688486.0, 691235.0, 701263.0, 709702.0, 125681.37159314145, 132884.0, 141501.0, 142935.0, 144490.0, 1022.7085280694967, 1034.4207243943415, 1062.9574817007388, 1065.0840277361463, 1065.6589891234885, 18507.629847403245, 19812.20751169937, 19831.900840495706, 19841.404757857286, 19911.502212444226, 45601.0, 59333.0, 60136.69931650314, 60352.39647603468, 60838.0, 73352.63323683347, 82427.5878620603, 87580.0, 88184.11815882016, 88233.1176688225, 8016.7194148204535, 8103.473274237156, 8120.350371970347, 8553.572321383781, 8556.27271681914, 9346.392484488486, 12312.26126432417, 13264.403101860247, 13265.33673316311, 13538.323083845571, 11238.044766194966, 11472.88527114718, 11616.186866919235, 11678.124140689652, 11826.231294965799, 10155.187584993331, 11326.0, 11347.0, 11666.591669291534, 11760.529578816751, 11214.327140371604, 11266.267692599955, 11686.123540734648, 11727.237729547553, 11881.5841445549, 6498.772542960974, 8114.553699546582, 8326.791830204293, 8641.876556047673, 8718.694845680371, 10442.895571044497, 10648.307859989076, 10965.50655220501, 11156.274842135235, 11263.592050993626], "value": 9527.075020172202, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1303.1399276477528, 1405.6485878530368, 1447.51508244738, 1456.9490067847628, 1480.1193289992455, 8093.31206847418, 8254.092049874524, 8421.494710317385, 8535.914640853589, 8545.91454085459, 7296.306850849174, 8496.0, 8554.828903421927, 8610.0, 8627.741167764962, 2297.896594653236, 2327.895244713992, 2328.941776455585, 2330.673705681206, 2334.5214231082587, 2288.896999635012, 2344.355302291875, 2354.1642716835536, 2355.0815182079004, 2356.564035653401, 2303.3205204464725, 2308.076769292288, 2329.522447898177, 2332.731735850382, 2339.4034521197154, 2233.171739648734, 2287.816974642033, 2315.351701523576, 2318.7681231876845, 2323.012719594166, 1950.4441234248313, 2032.8272096871783, 2241.3051953894346, 2305.054927479742, 2336.0538981712266, 8400.117987611275, 8503.404761666687, 8540.615672294762, 8549.40154189207, 8573.18554737299, 4773.689710168828, 4941.283513890502, 5086.872828179288, 5261.289725886994, 5263.973680131613, 3428.879989200391, 3440.6215316315183, 3456.844442000116, 3527.4356103023392, 3544.9113772155642, 1026.5072765072807, 1209.08109836524, 1227.643983244858, 1227.7360367520937, 1263.1663102352495, 10720.839187412195, 10721.195910306758, 10772.08437282832, 10855.51150198243, 10859.457027148612, 3481.5822101348, 4144.48193975753, 4488.438945131858, 4491.393661855608, 4497.033137875373, 8578.828423431496, 8630.39587228888, 8660.13398660129, 8677.52273624944, 8678.435901666371, 5012.974935125374, 5097.949020509747, 5101.719405432663, 5111.258867464197, 5113.8721531961255, 4627.5603817637275, 4699.436067671902, 4747.572718455355, 4804.087223427608, 4816.181249187576, 3055.770817188675, 3124.8593813278458, 3623.384024715752, 3662.5421822272215, 3717.20080182762, 1151.510607991617, 1160.1356989043218, 1176.2824676947055, 1176.6117181330312, 1176.817593273044, 848.1518481518482, 878.1306506558589, 887.1616322575234, 917.0600134861687, 920.7053742802373, 5498.010358135574, 5513.972430137904, 5582.609217354746, 5702.600817942787, 5777.133429985536, 574.7327492715824, 589.2899056636743, 590.1207201270076, 905.4386280506128, 985.9901400986042, 3321.568196134487, 3664.926701465956, 3707.1658876753054, 3843.1545060086737, 3876.6511014008875, 7474.5888976106835, 9668.516574171263, 9832.213422926148, 9842.212622990144, 10012.649557265606, 9920.702378928643, 9978.700638980843, 10024.448655324028, 10034.498275086216, 10058.748531286776, 7704.0, 7900.367970562341, 7916.920830791733, 7932.920670793218, 7940.801479962932, 4451.399061126836, 4460.910781784281, 5122.667026643406, 5617.859553511195, 5641.774329026793, 8724.520151391735, 8948.910510894808, 9162.221211197122, 9201.401908875901, 9214.677486287948, 9220.216281616138, 9281.071892810665, 9344.719658410258, 9350.064993500595, 9467.195288400562, 5952.523798096228, 5986.431289027535, 7160.212376638461, 7163.06880105583, 7207.13514378278, 7806.804829879298, 7878.881816772639, 7879.172686867796, 7893.644785984759, 7914.881276780968, 6536.477081833346, 7056.647167641495, 7212.783616491513, 7213.891791623025, 7260.709571617076, 7027.0, 7060.152781666233, 7138.143422789299, 7358.881537885408, 7362.558246505227, 5479.780808767605, 6291.779787707408, 6347.270063942521, 6417.743290268524, 6474.967625161844, 4906.460289368095, 5052.797888084436, 5087.465816089258, 5091.261767043832, 5129.589632829439, 4344.9131017380105, 4867.904721437648, 4935.8025678972435, 4945.406551213733, 5231.346081739783], "value": 4316.677379241342, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.3091133189288, 348.73670378863955, 367.48735513958013, 370.1782043862625, 374.95875453700086, 4818.012307476967, 5135.50785465883, 5248.5538729208065, 5422.783088676458, 5509.283793106895, 4476.910461790762, 4900.632452566063, 4943.615787579483, 5247.212918062283, 5277.498637629419, 3394.8981530554124, 3482.564679415073, 3705.5553333600005, 3750.893486421512, 4042.3734321180264, 3894.687492289094, 4043.0, 4105.240530501852, 4110.958890411088, 4125.814338354781, 3968.127012057357, 3984.6613037891816, 4019.336809426441, 4019.9799001004953, 4035.8497828118993, 3723.7579557328686, 3869.9032524186837, 3999.5600483946887, 4007.3788562772816, 4030.496187976503, 3188.1551388881967, 3420.96579034209, 3452.637473065317, 3489.7731647442833, 3490.685838274542, 4967.137323503686, 5181.455947125535, 5255.421903590602, 5280.128778751501, 5311.575073994071, 3511.6663916928105, 3916.5104361954754, 4205.537390887031, 4295.91408171838, 4397.846075387346, 5675.34733505648, 5681.261436013292, 5717.199592057115, 5721.942780572224, 5760.222369980041, 2934.6918573549683, 3425.74306926979, 3550.6981906537717, 3676.761010534307, 3870.845166193349, 5294.788208471657, 5533.114701647717, 5587.245721827542, 5756.194132821408, 5798.913016304801, 3279.5244689519886, 3479.582450105953, 3891.3384724596885, 3896.9610303897166, 3933.8033098344968, 3755.75587586806, 3917.2753040686994, 3939.9606003940166, 3948.3287841067086, 3949.822257998397, 4023.4970628671417, 4291.420658211164, 4584.15193189261, 4606.0097079128145, 4614.377059097046, 5647.7176141193595, 5684.516816070598, 5732.3121225453215, 5762.683052432073, 5769.451902069297, 1109.0960866893456, 1267.4106540458731, 1280.7182419867613, 1284.9678758031123, 1303.5763376902544, 746.958917259545, 812.524673066251, 866.7269810009826, 868.5700578213698, 882.6910581296495, 4471.932921006188, 4750.738709371018, 4925.310456536088, 5028.416048944644, 5041.924371134436, 4935.950640493621, 5098.59211263098, 5265.842024739264, 5325.961437519724, 5642.210090587321, 3612.753600007993, 4256.5953235432235, 5010.398752149766, 5065.138926382524, 5092.159793634083, 2652.6153707712274, 2807.7332653397893, 2856.600075989363, 2962.8074175178544, 2981.925451863677, 4773.904521909542, 5106.693598384109, 5128.769205385766, 5777.851071166225, 5901.616394934315, 5475.534579560703, 5683.318001839723, 5724.8282551523525, 5738.188287739062, 5750.441053731133, 4843.1524483216, 5420.888717812839, 5697.971510142423, 5767.0, 5887.940170769217, 4778.737169455713, 4905.3623029006, 5232.921506177487, 5694.715264236855, 5722.628029178257, 4530.478994915627, 5362.624616276823, 5483.314585676791, 5486.954740119112, 5497.312835895513, 5173.861750414902, 5556.861078473071, 5836.328822185503, 5857.552476197177, 5969.432903874125, 3843.0, 3887.7667339959694, 3910.2570511602703, 3915.4126880968083, 3929.0, 4617.984043510422, 5439.422567455394, 5535.750891209986, 5676.574256930664, 5840.532757379485, 5095.821646242363, 5355.116405793001, 5555.3611334697025, 5647.181158732043, 5651.43485651448, 4819.903601927872, 5511.311086114236, 5629.634073785191, 5638.407967163389, 5657.236273103243, 4920.31115643803, 4974.303597496281, 5170.146925757358, 5222.817201397933, 5628.521575666115, 4541.886452838706, 5691.26013618227, 5694.487496125369, 5721.485066344049, 5733.913991290051, 5174.379074511083, 5418.85955047746, 5622.453825198103, 5634.225219055984, 5638.971805140948], "value": 4023.929783568459, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.6348191085347, 683.2416018219778, 759.6885277036416, 788.0056823525338, 793.2781169136085, 10973.902609739032, 15010.924945375285, 15101.018433801795, 15264.618384540392, 15292.464763733271, 13942.0, 14160.858391416108, 14229.217393043378, 14341.354639041243, 14347.0, 881.8412685716569, 889.4085433186955, 896.5651658945407, 896.977575560613, 899.8875140607424, 882.4793371910572, 886.8093359927615, 887.8934527856666, 907.850204716221, 917.2203626917134, 874.8583099055729, 889.968851090212, 958.8417911044669, 960.1023043454358, 962.6678795815468, 945.1021529546958, 951.4814426137772, 958.4632605740808, 958.7363475044349, 960.8270511307961, 702.1398786486565, 709.8260926073093, 711.2816055783644, 712.3197346534099, 713.678844519968, 12703.872961270361, 15154.621134471616, 15542.844571554253, 15563.688726225526, 15583.532494025198, 13483.460661573525, 13704.10923289993, 13782.586522404345, 13810.861891381059, 13826.861731382658, 8447.662093516252, 9450.33847630666, 11343.432828358631, 11680.532778688843, 11717.824232636518, 3247.285597168619, 3542.6988705960025, 3666.5233519642543, 3774.226283611853, 3781.9054523636855, 78071.60964195199, 95038.57442138373, 100464.49767751187, 101234.99999999926, 102205.48897255541, 10454.738631534272, 10461.84307235392, 10482.423466709251, 10586.735331616617, 11130.443477826077, 21645.783542164692, 21772.782272177392, 21803.454913627287, 21939.122435102738, 22027.0, 7481.925180748123, 7574.204708505527, 7647.235276472419, 7673.3477654398885, 7925.167857375008, 4019.678425725935, 4109.486314210723, 4135.31767258405, 4178.979105104516, 4361.127774445124, 3274.279658475132, 3344.7156991655984, 3362.9663703362653, 3366.124807550055, 3383.4924761286006, 673.1249375811426, 679.4360680635061, 680.3332733920786, 694.3195668245047, 697.8255436140964, 630.4515071887396, 636.7166610858217, 650.8730797494443, 670.3497607320891, 694.3924066441863, 8349.680298288464, 9545.0, 9827.606895724233, 10153.593856245667, 10157.984201579931, 589.799468180812, 648.5946283572767, 681.7102731339161, 693.486819753389, 705.2527980138178, 4899.912147037046, 4928.457869634337, 4943.2585112233455, 4950.975245123824, 4960.429550601655, 77801.0, 84341.73487397694, 84419.0, 103768.44347334796, 107753.92246077595, 62099.13702588929, 76941.23058769453, 77339.61330193313, 79788.4042319162, 85701.0, 35899.56401743953, 47509.33717319877, 72564.0, 76623.0, 77814.61092694727, 8705.952916479182, 8959.283257339528, 8959.372843901125, 8961.7759556009, 8985.326100542356, 49794.751026246086, 49834.50165498299, 50216.74891625519, 50494.0, 51719.72484402628, 54727.72636136794, 60367.69816150891, 60924.0, 64803.37991550249, 67372.66313668597, 12837.229766214057, 13010.869891300967, 13031.674208144494, 13236.933815330862, 13695.657608559468, 11431.027503036206, 14223.841125692496, 14269.072510286798, 14368.281585920453, 14725.337359818619, 10784.029437350677, 11333.489992950503, 13163.276019819003, 13293.80059299092, 13349.466021359036, 13292.468301267842, 13359.332033398485, 13441.462341506622, 13475.865241347854, 13588.864111359155, 11086.833697494383, 12649.114561980574, 12891.226526408445, 12891.677708057374, 13355.732885342433, 10376.599159113724, 10641.627543035956, 10691.893081069089, 10870.456477176267, 11141.16441266892, 9241.768955776159, 9505.572249248662, 9793.706188814347, 9831.771028621422, 10919.617813376493], "value": 7251.57977921074, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1626.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 175.0, 97.0, 167.0, 176.0, 175.0, 118.0, 120.0, 126.0, 174.0], "value": 145.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 117.0, 115.0, 169.0, 151.0, 123.0, 142.0, 144.0, 132.0, 149.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 216.0, 223.0, 196.0, 196.0, 198.0, 197.0, 193.0, 195.0, 196.0], "value": 201.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 62.0, 61.0, 89.0, 68.0, 87.0, 52.0, 78.0, 99.0, 91.0], "value": 77.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 86.0, 70.0, 73.0, 71.0, 83.0, 75.0, 70.0, 84.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 90.0, 88.0, 100.0, 127.0, 137.0, 96.0, 89.0, 91.0], "value": 99.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 120.0, 155.0, 102.0, 154.0, 117.0, 95.0, 101.0, 151.0, 128.0], "value": 122.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 96.0, 151.0, 145.0, 104.0, 144.0, 89.0, 148.0, 80.0, 151.0], "value": 120.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 62.0, 62.0, 64.0, 63.0, 63.0, 62.0, 63.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 77.0, 79.0, 75.0, 69.0, 68.0, 68.0, 70.0, 69.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 108.0, 114.0, 89.0, 93.0, 91.0, 90.0, 90.0, 87.0, 88.0], "value": 94.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 150.0, 154.0, 152.0, 144.0, 146.0, 137.0, 159.0, 182.0, 168.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 206.0, 240.0, 191.0, 173.0, 177.0, 176.0, 173.0, 173.0, 177.0], "value": 186.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 68.0, 68.0, 83.0, 68.0, 64.0, 86.0, 90.0, 91.0], "value": 75.4, "unit": "score"}]}]} 10:05:47 INFO - Return code: 0 10:05:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:05:47 ERROR - # TBPL SUCCESS # 10:05:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:05:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:05:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:05:47 INFO - 2017-02-22 10:05:47.102 screenresolution[1655:11337] starting screenresolution argv=screenresolution get 10:05:47 INFO - 2017-02-22 10:05:47.105 screenresolution[1655:11337] Display 0: 1600x1200x32@60 10:05:47 INFO - 2017-02-22 10:05:47.111 screenresolution[1656:11340] starting screenresolution argv=screenresolution list 10:05:47 INFO - Available Modes on Display 0 10:05:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:05:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:05:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:05:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:05:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:05:47 INFO - Intel Iris: 10:05:47 INFO - Chipset Model: Intel Iris 10:05:47 INFO - Type: GPU 10:05:47 INFO - Bus: Built-In 10:05:47 INFO - VRAM (Dynamic, Max): 1536 MB 10:05:47 INFO - Vendor: Intel (0x8086) 10:05:47 INFO - Device ID: 0x0a2e 10:05:47 INFO - Revision ID: 0x0009 10:05:47 INFO - Displays: 10:05:47 INFO - Display: 10:05:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:05:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:05:47 INFO - Display Serial Number: 1600x1200 60 10:05:47 INFO - Main Display: Yes 10:05:47 INFO - Mirror: Off 10:05:47 INFO - Online: Yes 10:05:47 INFO - Rotation: Supported 10:05:47 INFO - Return code: 0 10:05:47 INFO - Running post-action listener: _resource_record_post_action 10:05:47 INFO - [mozharness: 2017-02-22 18:05:47.356271Z] Finished run-tests step (success) 10:05:47 INFO - Running post-run listener: _resource_record_post_run 10:05:47 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 38873600; Write bytes: 515403776; Read time: 243; Write time: 1618 10:05:47 INFO - TinderboxPrint: CPU usage
54.4% 10:05:47 INFO - TinderboxPrint: I/O read bytes / time
38,873,600 / 243 10:05:47 INFO - TinderboxPrint: I/O write bytes / time
515,403,776 / 1,618 10:05:47 INFO - TinderboxPrint: CPU idle
2,188.1 (45.6%) 10:05:47 INFO - TinderboxPrint: CPU system
962.5 (20.1%) 10:05:47 INFO - TinderboxPrint: CPU user
1,647.2 (34.3%) 10:05:47 INFO - TinderboxPrint: Swap in / out
249,319,424 / 0 10:05:47 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208275968; Write bytes: 202733056; Read time: 15740; Write time: 441 10:05:47 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 36772352; Write bytes: 301758976; Read time: 221; Write time: 1146 10:05:47 INFO - Running post-run listener: _upload_blobber_files 10:05:47 INFO - Blob upload gear active. 10:05:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:05:47 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 10:05:47 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'] 10:05:47 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 10:05:48 INFO - (blobuploader) - INFO - Open directory for files ... 10:05:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:05:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:05:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:49 INFO - (blobuploader) - INFO - Done attempting. 10:05:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:05:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:05:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:50 INFO - (blobuploader) - INFO - Done attempting. 10:05:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:05:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:05:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:51 INFO - (blobuploader) - INFO - Done attempting. 10:05:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:05:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:05:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:53 INFO - (blobuploader) - INFO - Done attempting. 10:05:53 INFO - (blobuploader) - INFO - Iteration through files over. 10:05:53 INFO - Return code: 0 10:05:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:05:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:05:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38d84f8a613d1331924631ec4a86a907c0ab603d04eb08184eb26662cebd078448ce47f70ba0519792e0308d9814c6ae51ca30137fddd34c5a602ca709c32e62", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6de060f5e8fca0616de604520a2f0e4f6c64a37b39be65b346aca136a5721f3c8a3879ebeca05269fc6e9746bf8b78af697bae5a647f5b112859b6b63e0c2418", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9041b4ede43bd4717ed20e7c9d9cac542b09d1670c5f3161dc650c93d92ca5b3eb03c7ef4355b107b9361482cfa2a781b2b0b486972ca39a1d15e83d52078750", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77464121d3cf4e666c1e97810d0cc5a28ae568517a68e545d2ba10c6cd614bf9ea9ce337bd5feb20f1ec9824f921abb1abafe58211d77938c7e6b730e09d1af1"} 10:05:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:05:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:05:53 INFO - Contents: 10:05:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38d84f8a613d1331924631ec4a86a907c0ab603d04eb08184eb26662cebd078448ce47f70ba0519792e0308d9814c6ae51ca30137fddd34c5a602ca709c32e62", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6de060f5e8fca0616de604520a2f0e4f6c64a37b39be65b346aca136a5721f3c8a3879ebeca05269fc6e9746bf8b78af697bae5a647f5b112859b6b63e0c2418", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9041b4ede43bd4717ed20e7c9d9cac542b09d1670c5f3161dc650c93d92ca5b3eb03c7ef4355b107b9361482cfa2a781b2b0b486972ca39a1d15e83d52078750", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77464121d3cf4e666c1e97810d0cc5a28ae568517a68e545d2ba10c6cd614bf9ea9ce337bd5feb20f1ec9824f921abb1abafe58211d77938c7e6b730e09d1af1"} 10:05:53 INFO - Running post-run listener: copy_logs_to_upload_dir 10:05:53 INFO - Copying logs to upload dir... 10:05:53 INFO - mkdir: /builds/slave/test/build/upload/logs 10:05:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.721898 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-02-22 10:05:53.998071) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 10:05:54.003007) ========= 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.pnhsSqP8KQ/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.qf8OVzSLGe/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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/38d84f8a613d1331924631ec4a86a907c0ab603d04eb08184eb26662cebd078448ce47f70ba0519792e0308d9814c6ae51ca30137fddd34c5a602ca709c32e62", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6de060f5e8fca0616de604520a2f0e4f6c64a37b39be65b346aca136a5721f3c8a3879ebeca05269fc6e9746bf8b78af697bae5a647f5b112859b6b63e0c2418", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9041b4ede43bd4717ed20e7c9d9cac542b09d1670c5f3161dc650c93d92ca5b3eb03c7ef4355b107b9361482cfa2a781b2b0b486972ca39a1d15e83d52078750", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77464121d3cf4e666c1e97810d0cc5a28ae568517a68e545d2ba10c6cd614bf9ea9ce337bd5feb20f1ec9824f921abb1abafe58211d77938c7e6b730e09d1af1"} build_url:https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011506 build_url: 'https://queue.taskcluster.net/v1/task/Zd-bSR4DRv6qdyWT2GfC_Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38d84f8a613d1331924631ec4a86a907c0ab603d04eb08184eb26662cebd078448ce47f70ba0519792e0308d9814c6ae51ca30137fddd34c5a602ca709c32e62", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6de060f5e8fca0616de604520a2f0e4f6c64a37b39be65b346aca136a5721f3c8a3879ebeca05269fc6e9746bf8b78af697bae5a647f5b112859b6b63e0c2418", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9041b4ede43bd4717ed20e7c9d9cac542b09d1670c5f3161dc650c93d92ca5b3eb03c7ef4355b107b9361482cfa2a781b2b0b486972ca39a1d15e83d52078750", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77464121d3cf4e666c1e97810d0cc5a28ae568517a68e545d2ba10c6cd614bf9ea9ce337bd5feb20f1ec9824f921abb1abafe58211d77938c7e6b730e09d1af1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 10:05:54.035054) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 10:05:54.035379) ========= 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.pnhsSqP8KQ/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.qf8OVzSLGe/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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.005252 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 10:05:54.083450) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 10:05:54.083772) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 10:05:54.084125) ========= ========= Total master_lag: 0.34 =========