builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0297 starttime: 1484495642.73 results: success (0) buildid: 20170115065023 builduid: cd78f48beab7458298da4bf78b2dbb85 revision: 825c9cc5f51f60d3776556621a18118c5b3aa088 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-15 07:54:02.726786) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-15 07:54:02.727355) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-15 07:54:02.727639) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-15 07:54:02.783216) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 07:54:02.783596) ========= 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.qy9N1qDWVR/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.Bf2Hkizsa2/Listeners TMPDIR=/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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-01-15 07:54:02-- 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% 17.7M=0.001s 2017-01-15 07:54:02 (17.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.151389 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 07:54:02.960973) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 07:54:02.961293) ========= 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.qy9N1qDWVR/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.Bf2Hkizsa2/Listeners TMPDIR=/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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.024558 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 07:54:03.009773) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-15 07:54:03.010142) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 825c9cc5f51f60d3776556621a18118c5b3aa088 --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 825c9cc5f51f60d3776556621a18118c5b3aa088 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qy9N1qDWVR/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.Bf2Hkizsa2/Listeners TMPDIR=/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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-01-15 07:54:03,107 truncating revision to first 12 chars 2017-01-15 07:54:03,107 Setting DEBUG logging. 2017-01-15 07:54:03,107 attempt 1/10 2017-01-15 07:54:03,108 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/825c9cc5f51f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-15 07:54:04,457 unpacking tar archive at: mozilla-central-825c9cc5f51f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.626494 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-15 07:54:04.659993) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-15 07:54:04.660316) ========= script_repo_revision: 825c9cc5f51f60d3776556621a18118c5b3aa088 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-15 07:54:04.660752) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-15 07:54:04.661028) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-15 07:54:04.681101) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-15 07:54:04.681496) ========= /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.qy9N1qDWVR/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.Bf2Hkizsa2/Listeners TMPDIR=/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 07:54:04 INFO - MultiFileLogger online at 20170115 07:54:04 in /builds/slave/test 07:54:04 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 07:54:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:54:04 INFO - {'append_to_log': False, 07:54:04 INFO - 'base_work_dir': '/builds/slave/test', 07:54:04 INFO - 'blob_upload_branch': 'Firefox', 07:54:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:54:04 INFO - 'branch': 'Firefox', 07:54:04 INFO - 'buildbot_json_path': 'buildprops.json', 07:54:04 INFO - 'config_files': ('talos/mac_config.py',), 07:54:04 INFO - 'default_actions': ('clobber', 07:54:04 INFO - 'read-buildbot-config', 07:54:04 INFO - 'download-and-extract', 07:54:04 INFO - 'populate-webroot', 07:54:04 INFO - 'create-virtualenv', 07:54:04 INFO - 'install', 07:54:04 INFO - 'run-tests'), 07:54:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:54:04 INFO - 'download_minidump_stackwalk': True, 07:54:04 INFO - 'download_symbols': 'ondemand', 07:54:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:54:04 INFO - 'tooltool.py': '/tools/tooltool.py', 07:54:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:54:04 INFO - '/tools/misc-python/virtualenv.py')}, 07:54:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:54:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:54:04 INFO - 'installer_path': 'installer.exe', 07:54:04 INFO - 'log_level': 'info', 07:54:04 INFO - 'log_name': 'talos', 07:54:04 INFO - 'log_to_console': True, 07:54:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:54:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:54:04 INFO - 'opt_config_files': (), 07:54:04 INFO - 'pip_index': False, 07:54:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:54:04 INFO - 'cmd': ('bash', 07:54:04 INFO - '-c', 07:54:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:54:04 INFO - 'enabled': True, 07:54:04 INFO - 'halt_on_failure': False, 07:54:04 INFO - 'name': 'check_screen_resolution'},), 07:54:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:54:04 INFO - 'cmd': ('bash', 07:54:04 INFO - '-c', 07:54:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:54:04 INFO - 'enabled': True, 07:54:04 INFO - 'halt_on_failure': False, 07:54:04 INFO - 'name': 'check_screen_resolution'},), 07:54:04 INFO - 'run_cmd_checks_enabled': True, 07:54:04 INFO - 'sps_profile': False, 07:54:04 INFO - 'sps_profile_interval': 0, 07:54:04 INFO - 'suite': 'dromaeojs-e10s', 07:54:04 INFO - 'system_bits': '32', 07:54:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:54:04 INFO - 'title': 't-yosemite-r7-0297', 07:54:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:54:04 INFO - 'use_talos_json': True, 07:54:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:54:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:54:04 INFO - 'work_dir': 'build'} 07:54:04 INFO - [mozharness: 2017-01-15 15:54:04.885403Z] Running clobber step. 07:54:04 INFO - Running pre-action listener: _resource_record_pre_action 07:54:04 INFO - Running main action method: clobber 07:54:04 INFO - rmtree: /builds/slave/test/build 07:54:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:54:07 INFO - Running post-action listener: _resource_record_post_action 07:54:07 INFO - [mozharness: 2017-01-15 15:54:07.203766Z] Finished clobber step (success) 07:54:07 INFO - [mozharness: 2017-01-15 15:54:07.203890Z] Running read-buildbot-config step. 07:54:07 INFO - Running pre-action listener: _resource_record_pre_action 07:54:07 INFO - Running main action method: read_buildbot_config 07:54:07 INFO - Using buildbot properties: 07:54:07 INFO - { 07:54:07 INFO - "project": "", 07:54:07 INFO - "product": "firefox", 07:54:07 INFO - "script_repo_revision": "production", 07:54:07 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 07:54:07 INFO - "repository": "", 07:54:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 07:54:07 INFO - "buildid": "20170115065023", 07:54:07 INFO - "pgo_build": "False", 07:54:07 INFO - "basedir": "/builds/slave/test", 07:54:07 INFO - "buildnumber": 51, 07:54:07 INFO - "slavename": "t-yosemite-r7-0297", 07:54:07 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 07:54:07 INFO - "platform": "yosemite_r7", 07:54:07 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:54:07 INFO - "branch": "mozilla-central", 07:54:07 INFO - "repo_path": "mozilla-central", 07:54:07 INFO - "revision": "825c9cc5f51f60d3776556621a18118c5b3aa088", 07:54:07 INFO - "stage_platform": "macosx64", 07:54:07 INFO - "builduid": "cd78f48beab7458298da4bf78b2dbb85", 07:54:07 INFO - "slavebuilddir": "test" 07:54:07 INFO - } 07:54:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/O3FAS58vQNqtxnGoYw2c3w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 07:54:07 INFO - Running post-action listener: _resource_record_post_action 07:54:07 INFO - [mozharness: 2017-01-15 15:54:07.207284Z] Finished read-buildbot-config step (success) 07:54:07 INFO - [mozharness: 2017-01-15 15:54:07.207419Z] Running download-and-extract step. 07:54:07 INFO - Running pre-action listener: _resource_record_pre_action 07:54:07 INFO - Running main action method: download_and_extract 07:54:07 INFO - mkdir: /builds/slave/test/build/tests 07:54:07 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')]} 07:54:07 INFO - trying https://queue.taskcluster.net/v1/task/O3FAS58vQNqtxnGoYw2c3w/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 07:54:07 INFO - Downloading https://queue.taskcluster.net/v1/task/O3FAS58vQNqtxnGoYw2c3w/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:54:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O3FAS58vQNqtxnGoYw2c3w/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 07:54:08 INFO - Downloaded 1199 bytes. 07:54:08 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:54:08 INFO - Using the following test package requirements: 07:54:08 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:54:08 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:54:08 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 07:54:08 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:54:08 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 07:54:08 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:54:08 INFO - u'jsshell-mac.zip'], 07:54:08 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:54:08 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 07:54:08 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:54:08 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:54:08 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 07:54:08 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:54:08 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 07:54:08 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:54:08 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 07:54:08 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:54:08 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 07:54:08 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:54:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O3FAS58vQNqtxnGoYw2c3w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:54:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O3FAS58vQNqtxnGoYw2c3w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:54:08 INFO - Fetch https://queue.taskcluster.net/v1/task/O3FAS58vQNqtxnGoYw2c3w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:54:09 INFO - Expected file size: 16318969 07:54:09 INFO - Obtained file size: 16318969 07:54:15 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:54:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O3FAS58vQNqtxnGoYw2c3w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:54:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O3FAS58vQNqtxnGoYw2c3w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:54:15 INFO - Fetch https://queue.taskcluster.net/v1/task/O3FAS58vQNqtxnGoYw2c3w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:54:16 INFO - Expected file size: 16318969 07:54:16 INFO - Obtained file size: 16318969 07:54:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O3FAS58vQNqtxnGoYw2c3w/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 07:54:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O3FAS58vQNqtxnGoYw2c3w/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:54:23 INFO - Fetch https://queue.taskcluster.net/v1/task/O3FAS58vQNqtxnGoYw2c3w/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 07:54:24 INFO - Expected file size: 14403463 07:54:24 INFO - Obtained file size: 14403463 07:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:24 INFO - trying https://queue.taskcluster.net/v1/task/O3FAS58vQNqtxnGoYw2c3w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:54:24 INFO - Downloading https://queue.taskcluster.net/v1/task/O3FAS58vQNqtxnGoYw2c3w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 07:54:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O3FAS58vQNqtxnGoYw2c3w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 07:54:26 INFO - Downloaded 70118711 bytes. 07:54:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O3FAS58vQNqtxnGoYw2c3w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:54:26 INFO - mkdir: /builds/slave/test/properties 07:54:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:54:26 INFO - Writing to file /builds/slave/test/properties/build_url 07:54:26 INFO - Contents: 07:54:26 INFO - build_url:https://queue.taskcluster.net/v1/task/O3FAS58vQNqtxnGoYw2c3w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:54:27 INFO - Running post-action listener: _resource_record_post_action 07:54:27 INFO - Running post-action listener: set_extra_try_arguments 07:54:27 INFO - [mozharness: 2017-01-15 15:54:27.505022Z] Finished download-and-extract step (success) 07:54:27 INFO - [mozharness: 2017-01-15 15:54:27.505184Z] Running populate-webroot step. 07:54:27 INFO - Running pre-action listener: _resource_record_pre_action 07:54:27 INFO - Running main action method: populate_webroot 07:54:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:54:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:54:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:54:27 INFO - '--tppagecycles', 07:54:27 INFO - '7'], 07:54:27 INFO - 'tests': ['tsvgm']}}, 07:54:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:54:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:54:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:54:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:54:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:54:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:54:27 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:54:27 INFO - 'talos_options': ['--disable-e10s'], 07:54:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:54:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:54:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:54:27 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:54:27 INFO - 'talos_options': ['--disable-e10s'], 07:54:27 INFO - 'tests': ['damp', 'tps']}, 07:54:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:54:27 INFO - 'tests': ['damp', 'tps']}, 07:54:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:54:27 INFO - 'tests': ['dromaeo_dom']}, 07:54:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:54:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:54:27 INFO - 'tests': ['basic_compositor_video']}, 07:54:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:54:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:54:27 INFO - 'tests': ['a11yr', 07:54:27 INFO - 'ts_paint', 07:54:27 INFO - 'tpaint', 07:54:27 INFO - 'sessionrestore', 07:54:27 INFO - 'sessionrestore_no_auto_restore', 07:54:27 INFO - 'tabpaint']}, 07:54:27 INFO - 'other-e10s': {'tests': ['a11yr', 07:54:27 INFO - 'ts_paint', 07:54:27 INFO - 'tpaint', 07:54:27 INFO - 'sessionrestore', 07:54:27 INFO - 'sessionrestore_no_auto_restore', 07:54:27 INFO - 'tabpaint']}, 07:54:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:54:27 INFO - 'ts_paint', 07:54:27 INFO - 'tpaint', 07:54:27 INFO - 'sessionrestore', 07:54:27 INFO - 'sessionrestore_no_auto_restore', 07:54:27 INFO - 'tabpaint']}, 07:54:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:54:27 INFO - 'ts_paint', 07:54:27 INFO - 'tpaint', 07:54:27 INFO - 'sessionrestore', 07:54:27 INFO - 'sessionrestore_no_auto_restore', 07:54:27 INFO - 'tabpaint']}, 07:54:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:54:27 INFO - 'tests': ['a11yr', 07:54:27 INFO - 'ts_paint', 07:54:27 INFO - 'tpaint', 07:54:27 INFO - 'sessionrestore', 07:54:27 INFO - 'sessionrestore_no_auto_restore', 07:54:27 INFO - 'tabpaint']}, 07:54:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:54:27 INFO - 'tests': ['a11yr', 07:54:27 INFO - 'ts_paint', 07:54:27 INFO - 'tpaint', 07:54:27 INFO - 'sessionrestore', 07:54:27 INFO - 'sessionrestore_no_auto_restore', 07:54:27 INFO - 'tabpaint']}, 07:54:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:54:27 INFO - 'tests': ['tsvgx', 07:54:27 INFO - 'tsvgr_opacity', 07:54:27 INFO - 'tart', 07:54:27 INFO - 'tscrollx', 07:54:27 INFO - 'cart', 07:54:27 INFO - 'tsvg_static']}, 07:54:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:54:27 INFO - 'tsvgr_opacity', 07:54:27 INFO - 'tart', 07:54:27 INFO - 'tscrollx', 07:54:27 INFO - 'cart', 07:54:27 INFO - 'tsvg_static']}, 07:54:27 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:54:27 INFO - 'talos_options': ['--disable-e10s'], 07:54:27 INFO - 'tests': ['tp5o']}, 07:54:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:54:27 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:54:27 INFO - 'talos_options': ['--disable-e10s', 07:54:27 INFO - '--xperf_path', 07:54:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:54:27 INFO - 'tests': ['tp5n']}, 07:54:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:54:27 INFO - 'talos_options': ['--xperf_path', 07:54:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:54:27 INFO - 'tests': ['tp5n']}}, 07:54:27 INFO - 'talos.zip': {'path': '', 07:54:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:54:27 INFO - Running post-action listener: _resource_record_post_action 07:54:27 INFO - [mozharness: 2017-01-15 15:54:27.523581Z] Finished populate-webroot step (success) 07:54:27 INFO - [mozharness: 2017-01-15 15:54:27.523677Z] Running create-virtualenv step. 07:54:27 INFO - Running pre-action listener: _resource_record_pre_action 07:54:27 INFO - Running main action method: create_virtualenv 07:54:27 INFO - Creating virtualenv /builds/slave/test/build/venv 07:54:27 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 07:54:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:54:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:54:27 INFO - Using real prefix '/tools/python27' 07:54:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:54:28 INFO - Installing distribute.............................................................................................................................................................................................done. 07:54:31 INFO - Installing pip.................done. 07:54:31 INFO - Return code: 0 07:54:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:54:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:54:31 INFO - Reading from file tmpfile_stdout 07:54:31 INFO - Output received: 07:54:31 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) 07:54:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:54: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')]} 07:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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')]} 07:54:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10745eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107461768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc79d7fd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10723cd30>, '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 0x107163db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107231be8>, '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.qy9N1qDWVR/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.Bf2Hkizsa2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 07:54: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', 'pip>=1.5'] in /builds/slave/test/build 07:54: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 pip>=1.5 07:54:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qy9N1qDWVR/Render', 07:54:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:31 INFO - 'HOME': '/Users/cltbld', 07:54:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:31 INFO - 'LOGNAME': 'cltbld', 07:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:31 INFO - 'MOZ_NO_REMOTE': '1', 07:54:31 INFO - 'NO_EM_RESTART': '1', 07:54:31 INFO - 'PAGER': '/bin/cat', 07:54:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:31 INFO - 'PWD': '/builds/slave/test', 07:54:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:31 INFO - 'SHELL': '/bin/bash', 07:54:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Bf2Hkizsa2/Listeners', 07:54:31 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 07:54:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:31 INFO - 'USER': 'cltbld', 07:54:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:31 INFO - 'XPC_FLAGS': '0x0', 07:54:31 INFO - 'XPC_SERVICE_NAME': '0', 07:54:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:31 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 07:54:31 INFO - Cleaning up... 07:54:31 INFO - Return code: 0 07:54:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:54: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')]} 07:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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')]} 07:54:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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', '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 0x10745eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107461768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc79d7fd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10723cd30>, '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 0x107163db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107231be8>, '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.qy9N1qDWVR/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.Bf2Hkizsa2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 07:54: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:54: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 psutil>=3.1.1 07:54:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qy9N1qDWVR/Render', 07:54:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:31 INFO - 'HOME': '/Users/cltbld', 07:54:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:31 INFO - 'LOGNAME': 'cltbld', 07:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:31 INFO - 'MOZ_NO_REMOTE': '1', 07:54:31 INFO - 'NO_EM_RESTART': '1', 07:54:31 INFO - 'PAGER': '/bin/cat', 07:54:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:31 INFO - 'PWD': '/builds/slave/test', 07:54:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:31 INFO - 'SHELL': '/bin/bash', 07:54:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Bf2Hkizsa2/Listeners', 07:54:31 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 07:54:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:31 INFO - 'USER': 'cltbld', 07:54:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:31 INFO - 'XPC_FLAGS': '0x0', 07:54:31 INFO - 'XPC_SERVICE_NAME': '0', 07:54:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:32 INFO - Downloading/unpacking psutil>=3.1.1 07:54: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 07:54: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 07:54: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 07:54: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 07:54: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 07:54: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 07:54:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:54:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:54:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:54:35 INFO - Installing collected packages: psutil 07:54:35 INFO - Running setup.py install for psutil 07:54:35 INFO - building 'psutil._psutil_osx' extension 07:54:35 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 07:54:36 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 07:54:36 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 07:54:36 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 07:54:36 INFO - building 'psutil._psutil_posix' extension 07:54:36 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 07:54:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:54:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:54:36 INFO - ^ 07:54:36 INFO - 1 warning generated. 07:54:36 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 07:54:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:54:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:54:36 INFO - Successfully installed psutil 07:54:36 INFO - Cleaning up... 07:54:37 INFO - Return code: 0 07:54:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10745eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107461768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc79d7fd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10723cd30>, '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 0x107163db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107231be8>, '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.qy9N1qDWVR/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.Bf2Hkizsa2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 07:54:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:54:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:54:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qy9N1qDWVR/Render', 07:54:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:37 INFO - 'HOME': '/Users/cltbld', 07:54:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:37 INFO - 'LOGNAME': 'cltbld', 07:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:37 INFO - 'MOZ_NO_REMOTE': '1', 07:54:37 INFO - 'NO_EM_RESTART': '1', 07:54:37 INFO - 'PAGER': '/bin/cat', 07:54:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:37 INFO - 'PWD': '/builds/slave/test', 07:54:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:37 INFO - 'SHELL': '/bin/bash', 07:54:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Bf2Hkizsa2/Listeners', 07:54:37 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 07:54:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:37 INFO - 'USER': 'cltbld', 07:54:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:37 INFO - 'XPC_FLAGS': '0x0', 07:54:37 INFO - 'XPC_SERVICE_NAME': '0', 07:54:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:54:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:54:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:54:40 INFO - Installing collected packages: mozsystemmonitor 07:54:40 INFO - Running setup.py install for mozsystemmonitor 07:54:40 INFO - Successfully installed mozsystemmonitor 07:54:40 INFO - Cleaning up... 07:54:40 INFO - Return code: 0 07:54:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:54:40 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')]} 07:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:40 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')]} 07:54:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:40 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 0x10745eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107461768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc79d7fd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10723cd30>, '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 0x107163db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107231be8>, '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.qy9N1qDWVR/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.Bf2Hkizsa2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 07:54:40 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 07:54:40 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 07:54:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qy9N1qDWVR/Render', 07:54:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:40 INFO - 'HOME': '/Users/cltbld', 07:54:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:40 INFO - 'LOGNAME': 'cltbld', 07:54:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:40 INFO - 'MOZ_NO_REMOTE': '1', 07:54:40 INFO - 'NO_EM_RESTART': '1', 07:54:40 INFO - 'PAGER': '/bin/cat', 07:54:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:40 INFO - 'PWD': '/builds/slave/test', 07:54:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:40 INFO - 'SHELL': '/bin/bash', 07:54:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Bf2Hkizsa2/Listeners', 07:54:40 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 07:54:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:40 INFO - 'USER': 'cltbld', 07:54:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:40 INFO - 'XPC_FLAGS': '0x0', 07:54:40 INFO - 'XPC_SERVICE_NAME': '0', 07:54:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:40 INFO - Downloading/unpacking jsonschema==2.5.1 07:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:54:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:54: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 07:54: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 07:54: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 07:54: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 07:54: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 07:54: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 07:54:43 INFO - Downloading functools32-3.2.3-2.tar.gz 07:54:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:54:43 INFO - warning: no files found matching '*.txt' 07:54:43 INFO - no previously-included directories found matching 'build' 07:54:43 INFO - no previously-included directories found matching 'dist' 07:54:43 INFO - no previously-included directories found matching '.git*' 07:54:43 INFO - Installing collected packages: jsonschema, functools32 07:54:43 INFO - Running setup.py install for functools32 07:54:43 INFO - warning: no files found matching '*.txt' 07:54:43 INFO - no previously-included directories found matching 'build' 07:54:43 INFO - no previously-included directories found matching 'dist' 07:54:43 INFO - no previously-included directories found matching '.git*' 07:54:43 INFO - Successfully installed jsonschema functools32 07:54:43 INFO - Cleaning up... 07:54:43 INFO - Return code: 0 07:54:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:43 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 0x10745eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107461768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc79d7fd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10723cd30>, '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 0x107163db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107231be8>, '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.qy9N1qDWVR/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.Bf2Hkizsa2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 07:54:43 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 07:54:43 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 07:54:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qy9N1qDWVR/Render', 07:54:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:43 INFO - 'HOME': '/Users/cltbld', 07:54:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:43 INFO - 'LOGNAME': 'cltbld', 07:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:43 INFO - 'MOZ_NO_REMOTE': '1', 07:54:43 INFO - 'NO_EM_RESTART': '1', 07:54:43 INFO - 'PAGER': '/bin/cat', 07:54:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:43 INFO - 'PWD': '/builds/slave/test', 07:54:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:43 INFO - 'SHELL': '/bin/bash', 07:54:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Bf2Hkizsa2/Listeners', 07:54:43 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 07:54:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:43 INFO - 'USER': 'cltbld', 07:54:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:43 INFO - 'XPC_FLAGS': '0x0', 07:54:43 INFO - 'XPC_SERVICE_NAME': '0', 07:54:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:54:44 INFO - Cleaning up... 07:54:44 INFO - Return code: 0 07:54:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:44 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 0x10745eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107461768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc79d7fd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10723cd30>, '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 0x107163db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107231be8>, '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.qy9N1qDWVR/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.Bf2Hkizsa2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 07:54:44 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 07:54:44 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 07:54:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qy9N1qDWVR/Render', 07:54:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:44 INFO - 'HOME': '/Users/cltbld', 07:54:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:44 INFO - 'LOGNAME': 'cltbld', 07:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:44 INFO - 'MOZ_NO_REMOTE': '1', 07:54:44 INFO - 'NO_EM_RESTART': '1', 07:54:44 INFO - 'PAGER': '/bin/cat', 07:54:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:44 INFO - 'PWD': '/builds/slave/test', 07:54:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:44 INFO - 'SHELL': '/bin/bash', 07:54:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Bf2Hkizsa2/Listeners', 07:54:44 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 07:54:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:44 INFO - 'USER': 'cltbld', 07:54:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:44 INFO - 'XPC_FLAGS': '0x0', 07:54:44 INFO - 'XPC_SERVICE_NAME': '0', 07:54:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:44 INFO - Downloading/unpacking blobuploader==1.2.4 07:54:44 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 07:54:44 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 07:54:44 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 07:54:44 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 07:54:44 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 07:54:44 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 07:54:47 INFO - Downloading blobuploader-1.2.4.tar.gz 07:54:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:54:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:54:47 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 07:54:47 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 07:54:47 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 07:54:47 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 07:54:47 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 07:54:47 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 07:54:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:54:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:54:47 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 07:54:47 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 07:54:47 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 07:54:47 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 07:54:47 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 07:54:47 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 07:54:48 INFO - Downloading docopt-0.6.1.tar.gz 07:54:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:54:48 INFO - Installing collected packages: blobuploader, requests, docopt 07:54:48 INFO - Running setup.py install for blobuploader 07:54:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:54:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:54:48 INFO - Running setup.py install for requests 07:54:49 INFO - Running setup.py install for docopt 07:54:49 INFO - Successfully installed blobuploader requests docopt 07:54:49 INFO - Cleaning up... 07:54:49 INFO - Return code: 0 07:54:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:54:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:49 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 0x10745eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107461768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc79d7fd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10723cd30>, '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 0x107163db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107231be8>, '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.qy9N1qDWVR/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.Bf2Hkizsa2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 07:54:49 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 07:54:49 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 07:54:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qy9N1qDWVR/Render', 07:54:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:49 INFO - 'HOME': '/Users/cltbld', 07:54:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:49 INFO - 'LOGNAME': 'cltbld', 07:54:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:49 INFO - 'MOZ_NO_REMOTE': '1', 07:54:49 INFO - 'NO_EM_RESTART': '1', 07:54:49 INFO - 'PAGER': '/bin/cat', 07:54:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:49 INFO - 'PWD': '/builds/slave/test', 07:54:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:49 INFO - 'SHELL': '/bin/bash', 07:54:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Bf2Hkizsa2/Listeners', 07:54:49 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 07:54:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:49 INFO - 'USER': 'cltbld', 07:54:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:49 INFO - 'XPC_FLAGS': '0x0', 07:54:49 INFO - 'XPC_SERVICE_NAME': '0', 07:54:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:54:49 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-mdD6Gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:54:49 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-A0pa8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:54:49 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-nSlWMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:54:49 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-ueWFWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:54:50 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-rNbhfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:54:50 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-bHZAG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:54:50 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-k41rwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:54:50 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-wF5sjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:54:50 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-RRKyoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:54:50 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-FNXgVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:54:50 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-7MP_5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:54:50 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-GYE8xu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:54:50 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-u3UpmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:54:50 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-r9UPYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:51 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-J5bljB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:54:51 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-RT7Meg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:54:51 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-jhvpje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:54:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:54:51 INFO - Running setup.py install for manifestparser 07:54:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:54:51 INFO - Running setup.py install for mozcrash 07:54:51 INFO - Running setup.py install for mozdebug 07:54:51 INFO - Running setup.py install for mozdevice 07:54:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:54:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:54:51 INFO - Running setup.py install for mozfile 07:54:52 INFO - Running setup.py install for mozhttpd 07:54:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:54:52 INFO - Running setup.py install for mozinfo 07:54:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:54:52 INFO - Running setup.py install for mozInstall 07:54:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:54:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:54:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:54:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:54:52 INFO - Running setup.py install for mozleak 07:54:52 INFO - Running setup.py install for mozlog 07:54:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:54:52 INFO - Running setup.py install for moznetwork 07:54:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:54:53 INFO - Running setup.py install for mozprocess 07:54:53 INFO - Running setup.py install for mozprofile 07:54:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:54:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:54:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:54:53 INFO - Running setup.py install for mozrunner 07:54:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:54:53 INFO - Running setup.py install for mozscreenshot 07:54:53 INFO - Running setup.py install for moztest 07:54:53 INFO - Running setup.py install for mozversion 07:54:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:54:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:54:53 INFO - Cleaning up... 07:54:53 INFO - Return code: 0 07:54:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:53 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 0x10745eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107461768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc79d7fd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10723cd30>, '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 0x107163db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107231be8>, '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.qy9N1qDWVR/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.Bf2Hkizsa2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 07:54:53 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 07:54:53 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 07:54:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qy9N1qDWVR/Render', 07:54:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:53 INFO - 'HOME': '/Users/cltbld', 07:54:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:53 INFO - 'LOGNAME': 'cltbld', 07:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:53 INFO - 'MOZ_NO_REMOTE': '1', 07:54:53 INFO - 'NO_EM_RESTART': '1', 07:54:53 INFO - 'PAGER': '/bin/cat', 07:54:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:53 INFO - 'PWD': '/builds/slave/test', 07:54:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:53 INFO - 'SHELL': '/bin/bash', 07:54:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Bf2Hkizsa2/Listeners', 07:54:53 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 07:54:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:53 INFO - 'USER': 'cltbld', 07:54:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:53 INFO - 'XPC_FLAGS': '0x0', 07:54:53 INFO - 'XPC_SERVICE_NAME': '0', 07:54:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:54:54 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-TQOt3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:54:54 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)) 07:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:54:54 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-9cCGfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:54:54 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)) 07:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:54:54 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-ub5lDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:54:54 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)) 07:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:54:54 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-hZ9YOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:54:54 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)) 07:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:54:54 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-t6hMrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:54:54 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)) 07:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:54:54 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-c_wEJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:54:54 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)) 07:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:54:54 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-yUZH4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:54:54 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)) 07:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:54:54 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-cRFT4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:54:55 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)) 07:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:54:55 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-i6F5WS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:54:55 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)) 07:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:54:55 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-is2xGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:54:55 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)) 07:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:54:55 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-L4i2y9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:54:55 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)) 07:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:54:55 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-bxUzkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 07:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:54:55 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-UB57zz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:54:55 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)) 07:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:54:55 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-vfFGPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:54:55 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)) 07:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:55 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-WdQmx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:55 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)) 07:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:54:55 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-eLNqpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:54:55 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)) 07:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:54:55 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-cCaKO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:54:56 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)) 07:54:56 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)) 07:54:56 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)) 07:54:56 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)) 07:54:56 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)) 07:54:56 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)) 07:54:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:54:56 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 07:54:56 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 07:54:56 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 07:54:56 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 07:54:56 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 07:54:56 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 07:54:58 INFO - Downloading blessings-1.6.tar.gz 07:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:54:58 INFO - Installing collected packages: blessings 07:54:58 INFO - Running setup.py install for blessings 07:54:58 INFO - Successfully installed blessings 07:54:58 INFO - Cleaning up... 07:54:58 INFO - Return code: 0 07:54:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:54:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:54:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:54:59 INFO - Reading from file tmpfile_stdout 07:54:59 INFO - Current package versions: 07:54:59 INFO - blessings == 1.6 07:54:59 INFO - blobuploader == 1.2.4 07:54:59 INFO - docopt == 0.6.1 07:54:59 INFO - functools32 == 3.2.3-2 07:54:59 INFO - jsonschema == 2.5.1 07:54:59 INFO - manifestparser == 1.1 07:54:59 INFO - mozInstall == 1.12 07:54:59 INFO - mozcrash == 1.0 07:54:59 INFO - mozdebug == 0.1 07:54:59 INFO - mozdevice == 0.49 07:54:59 INFO - mozfile == 1.2 07:54:59 INFO - mozhttpd == 0.7 07:54:59 INFO - mozinfo == 0.9 07:54:59 INFO - mozleak == 0.1 07:54:59 INFO - mozlog == 3.4 07:54:59 INFO - moznetwork == 0.27 07:54:59 INFO - mozprocess == 0.24 07:54:59 INFO - mozprofile == 0.28 07:54:59 INFO - mozrunner == 6.13 07:54:59 INFO - mozscreenshot == 0.1 07:54:59 INFO - mozsystemmonitor == 0.3 07:54:59 INFO - moztest == 0.8 07:54:59 INFO - mozversion == 1.4 07:54:59 INFO - psutil == 3.1.1 07:54:59 INFO - requests == 1.2.3 07:54:59 INFO - wsgiref == 0.1.2 07:54:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:59 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 0x10745eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107461768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc79d7fd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10723cd30>, '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 0x107163db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107231be8>, '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.qy9N1qDWVR/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.Bf2Hkizsa2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 07:54:59 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 07:54:59 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 07:54:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qy9N1qDWVR/Render', 07:54:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:59 INFO - 'HOME': '/Users/cltbld', 07:54:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:59 INFO - 'LOGNAME': 'cltbld', 07:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:59 INFO - 'MOZ_NO_REMOTE': '1', 07:54:59 INFO - 'NO_EM_RESTART': '1', 07:54:59 INFO - 'PAGER': '/bin/cat', 07:54:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:59 INFO - 'PWD': '/builds/slave/test', 07:54:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:59 INFO - 'SHELL': '/bin/bash', 07:54:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Bf2Hkizsa2/Listeners', 07:54:59 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 07:54:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:59 INFO - 'USER': 'cltbld', 07:54:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:59 INFO - 'XPC_FLAGS': '0x0', 07:54:59 INFO - 'XPC_SERVICE_NAME': '0', 07:54:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:59 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)) 07:54:59 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)) 07:54:59 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)) 07:54:59 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)) 07:54:59 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)) 07:54:59 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)) 07:54:59 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)) 07:54:59 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)) 07:54:59 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)) 07:54:59 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)) 07:54:59 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)) 07:54:59 INFO - Cleaning up... 07:54:59 INFO - Return code: 0 07:54:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:59 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 0x10745eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107461768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc79d7fd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10723cd30>, '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 0x107163db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107231be8>, '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.qy9N1qDWVR/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.Bf2Hkizsa2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 07:54:59 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 07:54:59 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 07:54:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qy9N1qDWVR/Render', 07:54:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:59 INFO - 'HOME': '/Users/cltbld', 07:54:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:59 INFO - 'LOGNAME': 'cltbld', 07:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:59 INFO - 'MOZ_NO_REMOTE': '1', 07:54:59 INFO - 'NO_EM_RESTART': '1', 07:54:59 INFO - 'PAGER': '/bin/cat', 07:54:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:59 INFO - 'PWD': '/builds/slave/test', 07:54:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:59 INFO - 'SHELL': '/bin/bash', 07:54:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Bf2Hkizsa2/Listeners', 07:54:59 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 07:54:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:59 INFO - 'USER': 'cltbld', 07:54:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:59 INFO - 'XPC_FLAGS': '0x0', 07:54:59 INFO - 'XPC_SERVICE_NAME': '0', 07:54:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:54:59 INFO - Cleaning up... 07:54:59 INFO - Return code: 0 07:54:59 INFO - Running post-action listener: _resource_record_post_action 07:54:59 INFO - Running post-action listener: _start_resource_monitoring 07:54:59 INFO - Starting resource monitoring. 07:54:59 INFO - [mozharness: 2017-01-15 15:54:59.818411Z] Finished create-virtualenv step (success) 07:54:59 INFO - [mozharness: 2017-01-15 15:54:59.819440Z] Running install step. 07:54:59 INFO - Running pre-action listener: _resource_record_pre_action 07:54:59 INFO - Running main action method: install 07:54:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:54:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:55:00 INFO - Reading from file tmpfile_stdout 07:55:00 INFO - Detecting whether we're running mozinstall >=1.0... 07:55:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:55:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:55:00 INFO - Reading from file tmpfile_stdout 07:55:00 INFO - Output received: 07:55:00 INFO - Usage: mozinstall [options] installer 07:55:00 INFO - Options: 07:55:00 INFO - -h, --help show this help message and exit 07:55:00 INFO - -d DEST, --destination=DEST 07:55:00 INFO - Directory to install application into. [default: 07:55:00 INFO - "/builds/slave/test"] 07:55:00 INFO - --app=APP Application being installed. [default: firefox] 07:55:00 INFO - mkdir: /builds/slave/test/build/application 07:55:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:55:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:55:22 INFO - Reading from file tmpfile_stdout 07:55:22 INFO - Output received: 07:55:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:55:22 INFO - Running post-action listener: _resource_record_post_action 07:55:22 INFO - [mozharness: 2017-01-15 15:55:22.339223Z] Finished install step (success) 07:55:22 INFO - [mozharness: 2017-01-15 15:55:22.339338Z] Running run-tests step. 07:55:22 INFO - Running pre-action listener: _resource_record_pre_action 07:55:22 INFO - Running main action method: run_tests 07:55:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:55:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:55:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:55:22 INFO - 2017-01-15 07:55:22.353 screenresolution[1636:7825] starting screenresolution argv=screenresolution get 07:55:22 INFO - 2017-01-15 07:55:22.356 screenresolution[1636:7825] Display 0: 1600x1200x32@60 07:55:22 INFO - 2017-01-15 07:55:22.362 screenresolution[1637:7827] starting screenresolution argv=screenresolution list 07:55:22 INFO - Available Modes on Display 0 07:55:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:55:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:55:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:55:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:55:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:55:22 INFO - Intel Iris: 07:55:22 INFO - Chipset Model: Intel Iris 07:55:22 INFO - Type: GPU 07:55:22 INFO - Bus: Built-In 07:55:22 INFO - VRAM (Dynamic, Max): 1536 MB 07:55:22 INFO - Vendor: Intel (0x8086) 07:55:22 INFO - Device ID: 0x0a2e 07:55:22 INFO - Revision ID: 0x0009 07:55:22 INFO - Displays: 07:55:22 INFO - Display: 07:55:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:55:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:55:22 INFO - Display Serial Number: 1600x1200 60 07:55:22 INFO - Main Display: Yes 07:55:22 INFO - Mirror: Off 07:55:22 INFO - Online: Yes 07:55:22 INFO - Rotation: Supported 07:55:22 INFO - Return code: 0 07:55:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:55:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:55:22 INFO - Python 2.7.3 07:55:22 INFO - Return code: 0 07:55:22 INFO - grabbing minidump binary from tooltool 07:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:55:22 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 0x10723cd30>, '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 0x107163db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107231be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:55:22 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 07:55:22 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 07:55:22 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 07:55:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:55:22 INFO - Return code: 0 07:55:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:55:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:55:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:55:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:55:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:55:22 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/O3FAS58vQNqtxnGoYw2c3w/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0297', '--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 07:55:22 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/O3FAS58vQNqtxnGoYw2c3w/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0297 --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 07:55:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qy9N1qDWVR/Render', 07:55:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:55:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:55:22 INFO - 'HOME': '/Users/cltbld', 07:55:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:55:22 INFO - 'LOGNAME': 'cltbld', 07:55:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:55:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:22 INFO - 'MOZ_NO_REMOTE': '1', 07:55:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:55:22 INFO - 'NO_EM_RESTART': '1', 07:55:22 INFO - 'PAGER': '/bin/cat', 07:55:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:22 INFO - 'PWD': '/builds/slave/test', 07:55:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:55:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:55:22 INFO - 'SHELL': '/bin/bash', 07:55:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Bf2Hkizsa2/Listeners', 07:55:22 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 07:55:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:55:22 INFO - 'USER': 'cltbld', 07:55:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:55:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:22 INFO - 'XPC_FLAGS': '0x0', 07:55:22 INFO - 'XPC_SERVICE_NAME': '0', 07:55:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:55:22 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/O3FAS58vQNqtxnGoYw2c3w/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0297', '--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 07:55:22 INFO - mozversion application_buildid: 20170115065023 07:55:22 INFO - mozversion application_changeset: 825c9cc5f51f60d3776556621a18118c5b3aa088 07:55:22 INFO - mozversion application_display_name: Nightly 07:55:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:55:22 INFO - mozversion application_name: Firefox 07:55:22 INFO - mozversion application_remotingname: firefox 07:55:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:55:22 INFO - mozversion application_vendor: Mozilla 07:55:22 INFO - mozversion application_version: 53.0a1 07:55:22 INFO - mozversion platform_buildid: 20170115065023 07:55:22 INFO - mozversion platform_changeset: 825c9cc5f51f60d3776556621a18118c5b3aa088 07:55:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:55:22 INFO - mozversion platform_version: 53.0a1 07:55:22 INFO - using testdate: 1484495722 07:55:22 INFO - actual date: 1484495722 07:55:22 INFO - starting webserver on 'localhost:49241' 07:55:22 INFO - SUITE-START | Running 2 tests 07:55:22 INFO - TEST-START | dromaeo_css 07:55:22 INFO - operating with platform_type : mac_ 07:55:22 INFO - Initialising browser for dromaeo_css test... 07:55:22 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/tmp0O3TNY/profile http://localhost:49241/getInfo.html) 07:55:25 INFO - PROCESS | 1647 | 2017-01-15 07:55:25.701 plugin-container[1649:7994] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d43, name = 'com.apple.tsm.portname' 07:55:25 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:55:25 INFO - PROCESS | 1647 | 2017-01-15 07:55:25.703 plugin-container[1649:7994] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 07:55:25 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:55:25 INFO - PROCESS | 1647 | 2017-01-15 07:55:25.703 plugin-container[1649:7994] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:55:25 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 07:55:25 INFO - PROCESS | 1647 | colorDepth:24 07:55:25 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 07:55:25 INFO - PROCESS | 1647 | __metrics 07:55:25 ERROR - PROCESS | 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3249: TypeError: this.tabs is undefined 07:55:26 INFO - TEST-INFO | 1647: exit 0 07:55:26 INFO - Browser initialized. 07:55:26 INFO - Running cycle 1/1 for dromaeo_css test... 07:55:26 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/tmp0O3TNY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:55:29 INFO - PROCESS | 1650 | 2017-01-15 07:55:29.137 plugin-container[1651:8118] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 07:55:29 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:55:29 INFO - PROCESS | 1650 | 2017-01-15 07:55:29.137 plugin-container[1651:8118] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b23, name = 'com.apple.CFPasteboardClient' 07:55:29 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:55:29 INFO - PROCESS | 1650 | 2017-01-15 07:55:29.137 plugin-container[1651:8118] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:55:38 INFO - PROCESS | 1650 | RSS: Main: 233836544 07:55:38 INFO - PROCESS | 1650 | 07:58:41 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 07:58:43 INFO - PROCESS | 1650 | RSS: Main: 250806272 07:58:43 INFO - PROCESS | 1650 | 08:00:27 INFO - PROCESS | 1650 | ************************* 08:00:27 INFO - PROCESS | 1650 | A coding exception was thrown and uncaught in a Task. 08:00:27 INFO - PROCESS | 1650 | 08:00:27 ERROR - PROCESS | 1650 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:00:27 INFO - PROCESS | 1650 | Full stack: 08:00:27 INFO - PROCESS | 1650 | ************************* 08:01:45 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 08:01:46 INFO - PROCESS | 1650 | RSS: Main: 261406720 08:01:46 INFO - PROCESS | 1650 | 08:04:47 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 08:04:48 INFO - PROCESS | 1650 | RSS: Main: 268972032 08:04:48 INFO - PROCESS | 1650 | 08:07:50 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 08:07:51 INFO - PROCESS | 1650 | RSS: Main: 265170944 08:07:51 INFO - PROCESS | 1650 | 08:10:53 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 08:10:54 INFO - PROCESS | 1650 | RSS: Main: 271912960 08:10:54 INFO - PROCESS | 1650 | 08:13:57 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 08:13:57 INFO - PROCESS | 1650 | RSS: Main: 275116032 08:13:57 INFO - PROCESS | 1650 | 08:13:57 INFO - PROCESS | 1650 | __start_tp_report 08:13:57 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 08:13:57 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 08:13:57 INFO - PROCESS | 1650 | |i|pagename|runs| 08:13:57 INFO - PROCESS | 1650 | |0;dojo.html;2955.3793703322303;3357.345317663055;3363.192833719908;3397.2016576104625;3425.2806910548784;5698.0883058710615;5747.51146152577;5764.827055188346;5782.277215348082;5787.768489260425;5713.828585142442;5790.652560846353;5814.622049566775;5917;5978.312494063173;5221.295125158112;5223.660462069973;5240.633155679104;5306.283651707028;5396.568274538047;5370.946290537084;5376.1398176291605;5396.43337449566;5414.83755487334;5452.972735136319;4292.9141417171795;4432.844850430236;4650.814042419195;5198.9480105198845;5354.625176237665;4294.935575966363;5287.603429742746;5290.55030322423;5290.55030322423;5294.97352513235;4584.426946631671;5192.376914770214;5221.817236396708;5249.68501889884;5293.6294459387855;4652.74409907455;5390.946090539083;5797.971010144965;5867.911981320283;5909.2908850938165;5393.271908292409;6246;6266.655333956631;6287.528435367366;6299.244090709099;6176.84557886052;6180.598261113013;6212.751489940397;6225.501959843202;6229.0967809667345;4793.808247670089;6026.578139530191;6029.427204415573;6062.333143354272;6070.2412198475195;6238.407351301619;6302.464290535264;6329.588576742497;6336.271328797156;6356.3325850785;6092;6151.507879369639;6245.219347581552;6262;6282.308946015934;6177.104319873593;6181.536384771161;6185.567010309325;6186.422462272092;6214.25428948529;6166;6206.937930620727;6260.342664020303;6262.436380725757;6272.027835685385;6152.876942461216;6201.596896201732;6228.5951413158;6229.657368844757;6236.126942228092;4939.061578300111;5044.470330615306;5049.495050494995;5061.291419201315;5069.771860266297;4437.5784300491405;4449.532799056053;4450.221211288012;4504.459464864237;4594.839180628729;5855.238818953509;5860.677662728591;5866.442687944638;5867.941320586825;5868.970655146697;6265.373462653698;6272.18461599989;6273.592216505913;6277.278113016971;6304.432601065926;4691.390119284471;5693.829185124453;5826.621269617462;5826.970865145647;5859.707014649251;5505.614606977473;5543.417941116125;5567.192757050205;5568;5585.329760428694;6351.491880649629;6353.841153971188;6388.712507937061;6395.616263024233;6417.935820641827;5632.183333416549;6112.685862051747;6136.886723215932;6170.444659980623;6246.344133865879;5873.911891321548;5875.41245875409;6248;6333.240011198685;6364.968175159094;5237.580993520433;6242.687865606611;6269.467095296951;6273.435390814849;6274.6548939808745;6031.185789918481;6102.307478454422;6145.231846019247;6217.098520714561;6249.250089989048;5565.970295495346;6107.037103281039;6113.081058499921;6138.7869253627705;6252.562320637512;5915.940840591539;6221.720022599085;6240.5319601031015;6246.344133865879;6254.061890716429;4733.502982186821;5341.519263266169;5709.172170035238;5935.673537955454;6136.938630613815;5538.529225015919;5741.91387129185;6192.876142477216;6252.781152659635;6260.906086408799;6044.24446944132;6093.695315234132;6102.877942441215;6103.84740381494;6140.17107690456 08:13:57 INFO - PROCESS | 1650 | |1;ext.html;453.12999041839646;508.7202038878617;514.2671692837705;521.1089037745458;524.889773147639;40133.98660133985;41995;42045;42098.99999999996;42115.78942105289;42449.36325955113;42999.92500187489;43000.35499467503;43005.92485187872;43127.56872431275;8512.616932238034;9383.953080234607;9539.80920381592;9550.761230969247;9558.90441095587;8458.3656225783;11268.943655281711;11602.651920442358;11603.419829008559;11822.527098916033;11574.016208622277;11630.95321421072;11633.36016519091;11637.18539702217;11661.300321980665;11641.243319184226;11642.126840486997;11649.301041937468;11652.941735291353;11667.416629168592;11359.261647992937;11404.600838970679;11425.08599312053;11425.428728563622;11427.885721142766;40243.798781005906;40372;40419.98950026243;40535;40611.1877762446;4063.5936406359424;4102.979485102555;4124.6906482013665;4135.0902801383645;4223.239816832969;30919.536206956913;30941;31025.8448707755;31050.37899242025;31153;3046.908592742221;3204.038788363505;3242.3515296940705;3295.703386695185;3368.949465758016;453727.4627253718;455100;456467;456860;459420.92026778904;65278;66173;66176.33823661701;66217;66324.33675663278;68386.63226735438;68734.65632671905;68972.3102768976;69533.65233173802;69626;14293.428262869576;15270.38918443272;15420.92289538545;15432.38270469191;15535.611609709847;9657.792775903012;9753.951230243945;10120.848187277197;10387.792244155075;11503.539858405737;15893.920530397274;17700.130566586755;19690;19931.501712457015;19975.300864469675;7183.568985860865;8462.280706140047;8612.354073444516;8621.827563448696;8626.317868015676;883.8276536075532;888.9733308000771;907.2152588011322;921.8801555797837;930.5114814722325;25319.860606272763;29739.066960647488;30116.397672046438;30227.395452090834;30512.237194069883;1072.9302595331278;1099.3125552277215;1106.7233191702076;1108.6009036746764;1181.2517474138324;14806.851931480547;15082.54752357431;15548.222588870738;15984.920075399548;16303.429379971643;529310;634742;635182;635296;641202;59452.10821837676;59752.701236493536;60127.39872601218;60205;60271;1394.4770710983382;1432.5630682641895;1439.6113049476583;1446.0745123121;1453.6656568989192;24208.43637883585;27298.498582578148;27757.583636245876;28010.879564817995;29621.25946851346;49575;49912.75043624759;51916.48083519268;52049.21926171035;54987.72506137444;512854.92152853956;606953;609294;609957.9502102461;613123;28537;30897.691023089483;33447.665523344454;37578.436323454625;39040.41439378355;40988.081430228565;42448.15103697847;42743.93140171521;43234.56765432305;43360.349594756735;30176.396472069995;31493.370132597676;35364.64635353613;35470;36573.63426365809;35593.64406355903;35597.644023559435;36327.455088174225;36653.63346366502;36702.44946325754;34767.65232347644;34862.82568587141;35105.48945105469;35219.47170792492;35480.64519354773;28941.276468088465;31388.843055785488;31422.842885785423;31480.212994675316;31550.58022389044;23255;23839.52320953606;23916.162934297216;24275.878620606785;24310.635340469555 08:13:57 INFO - PROCESS | 1650 | |2;jquery.html;396.54001358424216;397.3423983307623;408.4608317021532;409.50858969236924;426.96248117075515;20425.080871360788;20815.0633221505;21197.046132924017;21558.245461408853;21850;21767.129314827387;21844.45388865279;22209;22471.87640617971;22680.54638907221;5592.944070559293;5793.971030144843;5875.206847075654;5877.500412464924;5889.587728858982;5650.943490565103;5808.883822323551;5816.360200377955;5883.47048765611;5924.496417804492;5817.621854579439;5821.7380217890295;5825.271841019872;5829.329627092896;5851.912221316684;5599.776008959637;5730.2837145356625;5799.159121927339;5799.3620701722775;5806.59353845231;4449.955500444987;5127.589792816566;5136;5139.7687104080405;5145.974270128625;26055.609165862526;26472.338191545172;26500.73499265002;26752.86623566889;26891;2734.2207470870903;2765.9170224893287;2768.529350010503;2769.252301878502;2792.6928037915814;15611.297491612904;15894.443694470638;16037.599060023476;16258.268377923021;16615.335386584644;1826.9908650456796;1828.6159906419668;1836.3572749537689;1841.8894866308065;1848.159087615132;106902.46548767285;131599;131910.3404482981;134734;136235;11384.14618903569;11663.475143618558;11671.474783634756;11739.23694959842;11916.702082447835;14937.103773773608;14958.252087395587;14966.476173334098;14973.326200321011;15016.324265408082;6670.666466676646;8456.534890581077;8495.872561911576;8500;8613.095624959415;8159.632816523271;8180.9590952044855;8187.83624327522;8329;8370.53962032094;6035.577509574376;7193.856122877513;7298.343149116498;7311.744088956861;7341.302576255247;1926.25839051966;1956.2664000999625;1960.5588742532816;1960.9901950490157;1962.1758861278297;897.8473659477904;900.428228075177;904.8823652925078;930.2604429478581;954.9045095490534;21498.677519837216;22581.209657661904;22718.864056797094;22826.771732282796;22833.771662283496;704.6864145455223;923.8151175176462;933.2207606648388;952.0669743651122;953.3612479638658;9280.341786493262;11684.70788230301;11745.706357340963;11750.29498230109;11793.469293881795;523059.1541126886;671638;708448.4577577079;721912;727445;63411;90649;109784;123573.14640280404;127941;1037.3827572594294;1038.8597539332245;1066.4294602387686;1066.5520481397987;1067.6103222323795;19293.903530482257;19417.320393786715;19574.825510469418;19628.60742785165;19644.90177549103;52290.47709522856;52317.69205769886;52635.73682131718;53003.0247731414;53067;74023.62988185024;74754;74754.50490990041;75410.86883696858;75675.62162189154;6305.337939516285;7548.698052077855;7596.962015189889;7614.124375696644;7759.534427934342;11600.825987610024;11934.761304773681;12059.879401205875;12119;12183.573574924834;8382.16178382157;9854.901450985399;10030.548625311732;10170.8474372883;10203.234757393373;9824.950875245579;9915.008499150315;10117.392956422638;10150.644727434505;10404.323718958243;10164.33931794431;10440.791184176425;10607.045365917105;10641.308314959502;10704.197185210984;7502.474826762074;7636.12184598756;7657.358211417052;7898.052233731989;7991.041075071029;9964.551595178089;10004.099631033241;10148.13740832008;10245.48772561354;10392 08:13:57 INFO - PROCESS | 1650 | |3;mootools.html;1366.8223130992972;1438.2592964623227;1464.8315443723975;1489.2181604657553;1505.7816616590592;7487.9251207487905;7674.961625191881;8177.959110204448;8669.349798765094;8669.479831210125;8171.673133074684;8459.661613535467;8468.322534197265;8543.231109200171;8605.956970215157;1808.7286906963996;1952.9902350488298;2186.857854239477;2335.6730057791924;2374.442006128558;2055.496403381174;2340.3681006128336;2347.3427440316736;2377.0135393811547;2385.33210701004;1961.852861035428;2338.959163172389;2343.121329501437;2348.4598542335275;2375.809935205188;1943.0964601460248;2339.157903154863;2347.823913206499;2357.54027964547;2364.0189321431585;1991.8506112041655;2295.9782896611014;2303.090279339668;2374.2877136858874;2382.6545150953016;7579.242075792432;8543.572821358906;8566.571671416405;8624.956875215585;8632.223099921037;5153.458886816868;5307.548858347045;5330.893382132335;5337.172738225581;5342.866428339323;3325.4679251319913;3407.386670399327;3542.752007359486;3602.8919132426067;3612.295602357541;1201;1202.182515889195;1221.8087364819319;1232.7657745028505;1240.6340129661771;10958.506867190916;11000.22998390105;11091.55633774648;11107.99999999992;11113.777724445466;4470.5976462117915;4690.390249267573;4750.382450281441;4763.333133361332;4781.211100168433;9575.952120239353;9611.951940240255;9649.9035009649;9656.95171524138;9660.178884794872;5223;5314.202869569595;5324.361076670824;5329.493698098674;5341.786328546892;4195.223883581547;4829.6860704054125;4843.782029808667;4871.391076115486;4892.633052521075;3490.616032236452;3844.1350696093714;3844.6539811417106;3918.8824335269987;3986.5814089520763;1303.680598253415;1307.130758045908;1310.9934450327878;1318.2749487781682;1329.322045756671;804.1717031457491;805.3275514945086;861.5950503263456;926.6247169896203;927.9211267042242;5014.498550144956;5396.78412863481;5576.581756368289;5691.800786972436;5909.379515150933;1002.659095907395;1012.4785735346303;1050;1061.3737894642045;1071.2287153249647;3726.2547490501465;3783.7162212834146;3802.5817160112365;3877.747946383476;3904.6095390461296;9887.110160085484;10195.643152489627;10197.18422526196;10202.795944081077;10227.130693891102;10052.69841904744;10103.7474063149;10172.186225101974;10207.081362677247;10216.387016779017;7618.961905190438;7908.01149856268;7978.760637180894;8011.597970355165;8024.759257222293;4630.374899388674;5809.24479817621;5840.678762668094;5844.970775146267;6015.488683461955;9111.134442227978;9177.587008584496;9278.907210928075;9437.292203084933;9443.244540436886;9248.16766491019;9376.57805398745;9466.100720431548;9501.28740344463;9515.238780897651;6668.066470694203;6837.453003759588;6991.021257023919;7082.716691332289;7223.422126229994;7908.644111015134;8031.237032481905;8047.919520804717;8076.676932922617;8114.715984940499;6489.221293444817;6935.89596156048;7149.82125446868;7254.782356529313;7406.962965185139;6707;7072.752453664097;7075.964620176866;7082.150141982995;7117.537360071578;6379.011253255753;6416.871662566816;6432;6486.286508483969;6492.805215843532;4297.806598703003;5049.394072711299;5068.417132029864;5077.669951453144;5102.744862756922;4960.181570040902;4992.80028798844;5089.949100508948;5139.743012849268;5159.664621799571 08:13:57 INFO - PROCESS | 1650 | |4;prototype.html;310.810405652552;320.3209196503412;363.30971154805883;374.71896077941545;377.5676850006741;4122.7526348419115;5112.778949261964;5129.333186685735;5206.713630750307;5455.509004189622;4227.71054828278;5313.20301954707;5315.36215654121;5317.308749862522;5341.4925582069645;3703.3889408247605;4156.8129434175535;4190.763724701213;4222.894427639303;4226.640735537483;3766.1902690921447;3837.4052021936504;4203;4209.452771139763;4223.809928553223;3985.8604948826796;4008.478897743304;4009.218202450523;4018.57804930481;4022.2558826617023;3635.9818200908826;3721.9441708374397;3987.2623564640635;4010.779407132621;4031.959680403217;3487.2563718140927;3500.967214671678;3501.404761190578;3514.5606799150105;3515.2090779574646;4373.190959672471;4499.505054444008;5158.071547121516;5183.455737147583;5208.166693329049;4049.514058312992;4596.632269418472;4599.425071866017;4631.444226692818;4659.976700116512;5568.582356323292;5683.886322273532;5686.601937864351;5697.003024470701;5712.457316554921;3314.320564284316;3735.9813200933822;3824.330742120118;3858.614138586147;3911.1617539756553;5129.487051294878;5709.685967271798;5786.739596718157;5891.263592050994;5903;3875.6511913927884;3885.203533275672;3890.3386424307937;3902.6292502212245;3905.824237909301;3703.8518459261327;3937.5078115235597;3956.090099277125;3970.8808735737975;3985.1631157456677;4392.934105988413;4462.6876118672035;4586.564276393738;4638.884027899329;4680;5459.781608735606;5600.85997850057;5760.971195143998;5800.941990580124;5823.39856539455;1214.2350319298785;1230.2864338683721;1248.9375531223402;1258.2261908926127;1352.1819299323963;795.5067857928121;938.9014852622448;1001.8028455995161;1004.6885465505717;1005.7586179317058;4226.535081141072;4523.932141017887;5048.343715316985;5055.418626857959;5056.266841308064;4723.811047558128;4905.8226025754275;5290.709011004355;5479.698616576126;5604.747786349624;4684.484706682262;5030.270610761419;5033.521815427529;5038.874028149252;5051.191809310566;2449.4366295752075;2765.1013420638374;2830.1038304336143;2935.750461210778;2975.3900450407614;4929.112759703288;4952.5542701157065;5508.944910550843;5624.862552230208;5826.329972053183;5370.355557333145;5701.572382071361;5756.453136951983;5810.690712281478;5812.564057695689;4767.69010014348;4945.986072855056;5080.415752188545;5411.458854114636;5751.447109280471;4521.005378816655;5242.606804489755;5466.508014278734;5589.273394458694;5601.271834661468;4619.284010978169;5485.424030476902;5539.279893613804;5542.224088627515;5588.329400471969;5265.052290587731;5411.6211865170635;5545.556355491632;5733.569982251432;5804.736152900457;3816.2939856126704;4013.050407950096;4013.7190396673122;4048.5344185419053;4089.159878054828;4862.756862156807;5446.591505637014;5659.688717120598;5670.489655930821;5688.402717714746;5265.710385928657;5274.578033757367;5432.207371567294;5459.590530710292;5611.523020543136;5526.80656177048;5684.971575142098;5713.342965559014;5717.227144834668;5726.570507211893;4723.905521889612;5299.49654782795;5366.785328586813;5565.833025009256;5615.2700148980375;5398.974194902956;5717.885642287214;5731.398203188605;5733.512651424676;5741.97129014369;4480.252701446504;5331.253624492651;5408.72956352173;5620.290608198569;5654.067078932095 08:13:57 INFO - PROCESS | 1650 | |5;yui.html;730.8246020954972;778.1362687416967;832.0680837462036;842.2167384332571;845.0957475501216;15468.767968480468;16105.597360066004;16126.113063781488;16149.354025838968;16151.273192706327;14778.556643300692;14963.251837408114;14986.400543978229;15002.924985375057;15012;690.3752104345575;713.6182142553735;855.0167307596283;862.7282406042077;897.6364572348209;894.1058941058941;899.7075950316141;901.6528636474972;902.6840605787987;909.586138307072;934.8550974598948;951.3103000324778;952.3095755577186;953.1278879824987;953.8855337359527;935.1583574782682;938.755923459902;942.6559305853383;945.121037435185;946.5503885654327;703.1070540413697;704.5737328916034;706.7808979216408;709.0321710864632;709.7728726807424;14931.552053438414;15326.233688315651;15419.845801541953;15949.282282297325;16120.355185792554;14360.56918292453;14570.198639074846;14575.708485830224;14625;14659.633509162357;11692.356920369377;11696.005839503652;11717.824232636518;11720;11735.239714042962;3573.6426357364317;3666.816659167058;3778.131029863147;3796.9430458543143;3854.8843534693724;104250;107912.38131428036;108205.45897270463;108561;108916.45541772319;10561.102306303897;10782.78434431307;10820.837687434694;10822.729431764112;11094.00153986145;21099;21170.94145292729;21257.78742212558;21259.68110478344;21271.57456850885;7466.664000120008;7472.364848987897;7623.199564045806;7641.465097443237;7767.067951845815;4149.854755083557;4207.705460617727;4239.300515414983;4317.438732964694;4350.477942646902;3619.0952261934517;3634.854605815791;3697.5932647408763;3707.9988403131542;3720.2745464634136;679.3444326225216;680.9012693159464;684.8082536889679;685.3352248319122;699.8915168148945;664.6909187227963;677.701811203069;686.2074304178682;689.8240948558085;697.2121502702016;7992.321612461332;8349.33205343571;8363;10364.326318789406;10518.947405263078;669.9062131301622;684.1619016704498;703.0930100170825;709.1206903439801;720.9459290553125;3679.6504332088944;4584.7936842842155;4758.191107511731;4871.464138944713;4894.420916226916;101171;101604;102265.48867255617;103380.48309758553;108036.45981770041;88355.55822220976;90317;93948.0605193953;94339;94428;58510.12234816481;71621;71885.12459501562;71989.6400517994;72564;10430.26988110825;10804.621838235624;10934.945325273322;11011.559537618405;11171.832422513506;48646.75676621594;49664;50322.74193145201;51109.744451277504;51546.484535154166;71585.64207179139;72371.63814180896;72687.63656181685;73025.26974730397;74086;13137.211767293993;13230.603081907559;13287.40206690682;13406.396712148171;13636.454203112251;14473.421063157355;14574;14671.486497972519;14737.631559211106;14783.186924719244;13639.318034098455;13708.520201793288;13904.72099145334;13911.652208694864;14305.21321327337;13405.865941340462;13721.519746808814;13752.381142848395;14221.64445888861;14407.495737649131;13347.532836350681;13413.932930335677;13472.865271347553;13667.863321367056;13847.79228311556;10987.560497580007;11420.31478111316;11458;11644.88355116438;11690.357030363411;8931.910680893108;9572.856407153758;9657.517124143906;11092.944535277595;11379.772404552028 08:13:57 INFO - PROCESS | 1650 | __end_tp_report 08:13:57 INFO - PROCESS | 1650 | __start_cc_report 08:13:57 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,374 08:13:57 INFO - PROCESS | 1650 | __end_cc_report 08:13:57 INFO - PROCESS | 1650 | __startTimestamp1484496837397__endTimestamp 08:13:57 INFO - PROCESS | 1650 | 08:13:57 INFO - PROCESS | 1650 | ------- Summary: start ------- 08:13:57 INFO - PROCESS | 1650 | Number of tests: 6 08:13:57 INFO - PROCESS | 1650 | 08:13:57 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5721.27 Median:5935.67 stddev:686.19 (11.6%) stddev-sans-first:653.09 08:13:57 INFO - PROCESS | 1650 | Values: 2955.4 3357.3 3363.2 3397.2 3425.3 5698.1 5747.5 5764.8 5782.3 5787.8 5713.8 5790.7 5814.6 5917.0 5978.3 5221.3 5223.7 5240.6 5306.3 5396.6 5370.9 5376.1 5396.4 5414.8 5453.0 4292.9 4432.8 4650.8 5198.9 5354.6 4294.9 5287.6 5290.6 5290.6 5295.0 4584.4 5192.4 5221.8 5249.7 5293.6 4652.7 5390.9 5798.0 5867.9 5909.3 5393.3 6246.0 6266.7 6287.5 6299.2 6176.8 6180.6 6212.8 6225.5 6229.1 4793.8 6026.6 6029.4 6062.3 6070.2 6238.4 6302.5 6329.6 6336.3 6356.3 6092.0 6151.5 6245.2 6262.0 6282.3 6177.1 6181.5 6185.6 6186.4 6214.3 6166.0 6206.9 6260.3 6262.4 6272.0 6152.9 6201.6 6228.6 6229.7 6236.1 4939.1 5044.5 5049.5 5061.3 5069.8 4437.6 4449.5 4450.2 4504.5 4594.8 5855.2 5860.7 5866.4 5867.9 5869.0 6265.4 6272.2 6273.6 6277.3 6304.4 4691.4 5693.8 5826.6 5827.0 5859.7 5505.6 5543.4 5567.2 5568.0 5585.3 6351.5 6353.8 6388.7 6395.6 6417.9 5632.2 6112.7 6136.9 6170.4 6246.3 5873.9 5875.4 6248.0 6333.2 6365.0 5237.6 6242.7 6269.5 6273.4 6274.7 6031.2 6102.3 6145.2 6217.1 6249.3 5566.0 6107.0 6113.1 6138.8 6252.6 5915.9 6221.7 6240.5 6246.3 6254.1 4733.5 5341.5 5709.2 5935.7 6136.9 5538.5 5741.9 6192.9 6252.8 6260.9 6044.2 6093.7 6102.9 6103.8 6140.2 08:13:57 INFO - PROCESS | 1650 | 08:13:57 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:69218.86 Median:35962.55 stddev:149406.74 (415.5%) stddev-sans-first:149736.66 08:13:57 INFO - PROCESS | 1650 | Values: 453.1 508.7 514.3 521.1 524.9 40134.0 41995.0 42045.0 42099.0 42115.8 42449.4 42999.9 43000.4 43005.9 43127.6 8512.6 9384.0 9539.8 9550.8 9558.9 8458.4 11268.9 11602.7 11603.4 11822.5 11574.0 11631.0 11633.4 11637.2 11661.3 11641.2 11642.1 11649.3 11652.9 11667.4 11359.3 11404.6 11425.1 11425.4 11427.9 40243.8 40372.0 40420.0 40535.0 40611.2 4063.6 4103.0 4124.7 4135.1 4223.2 30919.5 30941.0 31025.8 31050.4 31153.0 3046.9 3204.0 3242.4 3295.7 3368.9 453727.5 455100.0 456467.0 456860.0 459420.9 65278.0 66173.0 66176.3 66217.0 66324.3 68386.6 68734.7 68972.3 69533.7 69626.0 14293.4 15270.4 15420.9 15432.4 15535.6 9657.8 9754.0 10120.8 10387.8 11503.5 15893.9 17700.1 19690.0 19931.5 19975.3 7183.6 8462.3 8612.4 8621.8 8626.3 883.8 889.0 907.2 921.9 930.5 25319.9 29739.1 30116.4 30227.4 30512.2 1072.9 1099.3 1106.7 1108.6 1181.3 14806.9 15082.5 15548.2 15984.9 16303.4 529310.0 634742.0 635182.0 635296.0 641202.0 59452.1 59752.7 60127.4 60205.0 60271.0 1394.5 1432.6 1439.6 1446.1 1453.7 24208.4 27298.5 27757.6 28010.9 29621.3 49575.0 49912.8 51916.5 52049.2 54987.7 512854.9 606953.0 609294.0 609958.0 613123.0 28537.0 30897.7 33447.7 37578.4 39040.4 40988.1 42448.2 42743.9 43234.6 43360.3 30176.4 31493.4 35364.6 35470.0 36573.6 35593.6 35597.6 36327.5 36653.6 36702.4 34767.7 34862.8 35105.5 35219.5 35480.6 28941.3 31388.8 31422.8 31480.2 31550.6 23255.0 23839.5 23916.2 24275.9 24310.6 08:13:57 INFO - PROCESS | 1650 | 08:13:57 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:36786.91 Median:2780.97 stddev:111756.04 (4018.6%) stddev-sans-first:112036.14 08:13:57 INFO - PROCESS | 1650 | Values: 396.5 397.3 408.5 409.5 427.0 20425.1 20815.1 21197.0 21558.2 21850.0 21767.1 21844.5 22209.0 22471.9 22680.5 5592.9 5794.0 5875.2 5877.5 5889.6 5650.9 5808.9 5816.4 5883.5 5924.5 5817.6 5821.7 5825.3 5829.3 5851.9 5599.8 5730.3 5799.2 5799.4 5806.6 4450.0 5127.6 5136.0 5139.8 5146.0 26055.6 26472.3 26500.7 26752.9 26891.0 2734.2 2765.9 2768.5 2769.3 2792.7 15611.3 15894.4 16037.6 16258.3 16615.3 1827.0 1828.6 1836.4 1841.9 1848.2 106902.5 131599.0 131910.3 134734.0 136235.0 11384.1 11663.5 11671.5 11739.2 11916.7 14937.1 14958.3 14966.5 14973.3 15016.3 6670.7 8456.5 8495.9 8500.0 8613.1 8159.6 8181.0 8187.8 8329.0 8370.5 6035.6 7193.9 7298.3 7311.7 7341.3 1926.3 1956.3 1960.6 1961.0 1962.2 897.8 900.4 904.9 930.3 954.9 21498.7 22581.2 22718.9 22826.8 22833.8 704.7 923.8 933.2 952.1 953.4 9280.3 11684.7 11745.7 11750.3 11793.5 523059.2 671638.0 708448.5 721912.0 727445.0 63411.0 90649.0 109784.0 123573.1 127941.0 1037.4 1038.9 1066.4 1066.6 1067.6 19293.9 19417.3 19574.8 19628.6 19644.9 52290.5 52317.7 52635.7 53003.0 53067.0 74023.6 74754.0 74754.5 75410.9 75675.6 6305.3 7548.7 7597.0 7614.1 7759.5 11600.8 11934.8 12059.9 12119.0 12183.6 8382.2 9854.9 10030.5 10170.8 10203.2 9825.0 9915.0 10117.4 10150.6 10404.3 10164.3 10440.8 10607.0 10641.3 10704.2 7502.5 7636.1 7657.4 7898.1 7991.0 9964.6 10004.1 10148.1 10245.5 10392.0 08:13:57 INFO - PROCESS | 1650 | 08:13:57 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5485.90 Median:5073.04 stddev:3009.02 (59.3%) stddev-sans-first:3001.54 08:13:57 INFO - PROCESS | 1650 | Values: 1366.8 1438.3 1464.8 1489.2 1505.8 7487.9 7675.0 8178.0 8669.3 8669.5 8171.7 8459.7 8468.3 8543.2 8606.0 1808.7 1953.0 2186.9 2335.7 2374.4 2055.5 2340.4 2347.3 2377.0 2385.3 1961.9 2339.0 2343.1 2348.5 2375.8 1943.1 2339.2 2347.8 2357.5 2364.0 1991.9 2296.0 2303.1 2374.3 2382.7 7579.2 8543.6 8566.6 8625.0 8632.2 5153.5 5307.5 5330.9 5337.2 5342.9 3325.5 3407.4 3542.8 3602.9 3612.3 1201.0 1202.2 1221.8 1232.8 1240.6 10958.5 11000.2 11091.6 11108.0 11113.8 4470.6 4690.4 4750.4 4763.3 4781.2 9576.0 9612.0 9649.9 9657.0 9660.2 5223.0 5314.2 5324.4 5329.5 5341.8 4195.2 4829.7 4843.8 4871.4 4892.6 3490.6 3844.1 3844.7 3918.9 3986.6 1303.7 1307.1 1311.0 1318.3 1329.3 804.2 805.3 861.6 926.6 927.9 5014.5 5396.8 5576.6 5691.8 5909.4 1002.7 1012.5 1050.0 1061.4 1071.2 3726.3 3783.7 3802.6 3877.7 3904.6 9887.1 10195.6 10197.2 10202.8 10227.1 10052.7 10103.7 10172.2 10207.1 10216.4 7619.0 7908.0 7978.8 8011.6 8024.8 4630.4 5809.2 5840.7 5845.0 6015.5 9111.1 9177.6 9278.9 9437.3 9443.2 9248.2 9376.6 9466.1 9501.3 9515.2 6668.1 6837.5 6991.0 7082.7 7223.4 7908.6 8031.2 8047.9 8076.7 8114.7 6489.2 6935.9 7149.8 7254.8 7407.0 6707.0 7072.8 7076.0 7082.2 7117.5 6379.0 6416.9 6432.0 6486.3 6492.8 4297.8 5049.4 5068.4 5077.7 5102.7 4960.2 4992.8 5089.9 5139.7 5159.7 08:13:57 INFO - PROCESS | 1650 | 08:13:57 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4492.50 Median:4991.41 stddev:1354.23 (27.1%) stddev-sans-first:1321.16 08:13:57 INFO - PROCESS | 1650 | Values: 310.8 320.3 363.3 374.7 377.6 4122.8 5112.8 5129.3 5206.7 5455.5 4227.7 5313.2 5315.4 5317.3 5341.5 3703.4 4156.8 4190.8 4222.9 4226.6 3766.2 3837.4 4203.0 4209.5 4223.8 3985.9 4008.5 4009.2 4018.6 4022.3 3636.0 3721.9 3987.3 4010.8 4032.0 3487.3 3501.0 3501.4 3514.6 3515.2 4373.2 4499.5 5158.1 5183.5 5208.2 4049.5 4596.6 4599.4 4631.4 4660.0 5568.6 5683.9 5686.6 5697.0 5712.5 3314.3 3736.0 3824.3 3858.6 3911.2 5129.5 5709.7 5786.7 5891.3 5903.0 3875.7 3885.2 3890.3 3902.6 3905.8 3703.9 3937.5 3956.1 3970.9 3985.2 4392.9 4462.7 4586.6 4638.9 4680.0 5459.8 5600.9 5761.0 5800.9 5823.4 1214.2 1230.3 1248.9 1258.2 1352.2 795.5 938.9 1001.8 1004.7 1005.8 4226.5 4523.9 5048.3 5055.4 5056.3 4723.8 4905.8 5290.7 5479.7 5604.7 4684.5 5030.3 5033.5 5038.9 5051.2 2449.4 2765.1 2830.1 2935.8 2975.4 4929.1 4952.6 5508.9 5624.9 5826.3 5370.4 5701.6 5756.5 5810.7 5812.6 4767.7 4946.0 5080.4 5411.5 5751.4 4521.0 5242.6 5466.5 5589.3 5601.3 4619.3 5485.4 5539.3 5542.2 5588.3 5265.1 5411.6 5545.6 5733.6 5804.7 3816.3 4013.1 4013.7 4048.5 4089.2 4862.8 5446.6 5659.7 5670.5 5688.4 5265.7 5274.6 5432.2 5459.6 5611.5 5526.8 5685.0 5713.3 5717.2 5726.6 4723.9 5299.5 5366.8 5565.8 5615.3 5399.0 5717.9 5731.4 5733.5 5742.0 4480.3 5331.3 5408.7 5620.3 5654.1 08:13:57 INFO - PROCESS | 1650 | 08:13:57 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:20614.91 Median:3714.14 stddev:29565.21 (796.0%) stddev-sans-first:29610.45 08:13:57 INFO - PROCESS | 1650 | Values: 730.8 778.1 832.1 842.2 845.1 15468.8 16105.6 16126.1 16149.4 16151.3 14778.6 14963.3 14986.4 15002.9 15012.0 690.4 713.6 855.0 862.7 897.6 894.1 899.7 901.7 902.7 909.6 934.9 951.3 952.3 953.1 953.9 935.2 938.8 942.7 945.1 946.6 703.1 704.6 706.8 709.0 709.8 14931.6 15326.2 15419.8 15949.3 16120.4 14360.6 14570.2 14575.7 14625.0 14659.6 11692.4 11696.0 11717.8 11720.0 11735.2 3573.6 3666.8 3778.1 3796.9 3854.9 104250.0 107912.4 108205.5 108561.0 108916.5 10561.1 10782.8 10820.8 10822.7 11094.0 21099.0 21170.9 21257.8 21259.7 21271.6 7466.7 7472.4 7623.2 7641.5 7767.1 4149.9 4207.7 4239.3 4317.4 4350.5 3619.1 3634.9 3697.6 3708.0 3720.3 679.3 680.9 684.8 685.3 699.9 664.7 677.7 686.2 689.8 697.2 7992.3 8349.3 8363.0 10364.3 10518.9 669.9 684.2 703.1 709.1 720.9 3679.7 4584.8 4758.2 4871.5 4894.4 101171.0 101604.0 102265.5 103380.5 108036.5 88355.6 90317.0 93948.1 94339.0 94428.0 58510.1 71621.0 71885.1 71989.6 72564.0 10430.3 10804.6 10934.9 11011.6 11171.8 48646.8 49664.0 50322.7 51109.7 51546.5 71585.6 72371.6 72687.6 73025.3 74086.0 13137.2 13230.6 13287.4 13406.4 13636.5 14473.4 14574.0 14671.5 14737.6 14783.2 13639.3 13708.5 13904.7 13911.7 14305.2 13405.9 13721.5 13752.4 14221.6 14407.5 13347.5 13413.9 13472.9 13667.9 13847.8 10987.6 11420.3 11458.0 11644.9 11690.4 8931.9 9572.9 9657.5 11092.9 11379.8 08:13:57 INFO - PROCESS | 1650 | -------- Summary: end -------- 08:13:57 INFO - PROCESS | 1650 | 08:13:58 INFO - TEST-INFO | 1650: exit 0 08:13:58 INFO - TEST-OK | dromaeo_css | took 1115119ms 08:13:58 INFO - TEST-START | kraken 08:13:58 INFO - operating with platform_type : mac_ 08:13:58 INFO - Initialising browser for kraken test... 08:13:58 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/tmpnEC2FB/profile http://localhost:49241/getInfo.html) 08:14:00 INFO - PROCESS | 1659 | 2017-01-15 08:14:00.872 plugin-container[1660:10633] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b3f, name = 'com.apple.tsm.portname' 08:14:00 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:14:00 INFO - PROCESS | 1659 | 2017-01-15 08:14:00.875 plugin-container[1660:10633] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4417, name = 'com.apple.CFPasteboardClient' 08:14:00 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:14:00 INFO - PROCESS | 1659 | 2017-01-15 08:14:00.875 plugin-container[1660:10633] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:14:00 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 08:14:00 INFO - PROCESS | 1659 | colorDepth:24 08:14:00 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 08:14:00 INFO - PROCESS | 1659 | __metrics 08:14:01 ERROR - PROCESS | 1659 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3249: TypeError: this.tabs is undefined 08:14:01 INFO - TEST-INFO | 1659: exit 0 08:14:01 INFO - Browser initialized. 08:14:01 INFO - Running cycle 1/1 for kraken test... 08:14:01 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/tmpnEC2FB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:14:04 INFO - PROCESS | 1661 | 2017-01-15 08:14:04.234 plugin-container[1662:10751] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 08:14:04 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:14:04 INFO - PROCESS | 1661 | 2017-01-15 08:14:04.237 plugin-container[1662:10751] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 08:14:04 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:14:04 INFO - PROCESS | 1661 | 2017-01-15 08:14:04.237 plugin-container[1662:10751] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:14:13 INFO - PROCESS | 1661 | RSS: Main: 233279488 08:14:13 INFO - PROCESS | 1661 | 08:14:16 INFO - PROCESS | 1661 | 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) 08:14:17 INFO - PROCESS | 1661 | RSS: Main: 245817344 08:14:17 INFO - PROCESS | 1661 | 08:14:20 INFO - PROCESS | 1661 | 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) 08:14:20 INFO - PROCESS | 1661 | RSS: Main: 253870080 08:14:20 INFO - PROCESS | 1661 | 08:14:24 INFO - PROCESS | 1661 | 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) 08:14:25 INFO - PROCESS | 1661 | RSS: Main: 256446464 08:14:25 INFO - PROCESS | 1661 | 08:14:26 INFO - PROCESS | 1661 | 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) 08:14:27 INFO - PROCESS | 1661 | RSS: Main: 258719744 08:14:27 INFO - PROCESS | 1661 | 08:14:29 INFO - PROCESS | 1661 | 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) 08:14:30 INFO - PROCESS | 1661 | RSS: Main: 259354624 08:14:30 INFO - PROCESS | 1661 | 08:14:32 INFO - PROCESS | 1661 | 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) 08:14:33 INFO - PROCESS | 1661 | RSS: Main: 265203712 08:14:33 INFO - PROCESS | 1661 | 08:14:36 INFO - PROCESS | 1661 | 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) 08:14:37 INFO - PROCESS | 1661 | RSS: Main: 264642560 08:14:37 INFO - PROCESS | 1661 | 08:14:40 INFO - PROCESS | 1661 | 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) 08:14:40 INFO - PROCESS | 1661 | RSS: Main: 263794688 08:14:40 INFO - PROCESS | 1661 | 08:14:42 INFO - PROCESS | 1661 | 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) 08:14:43 INFO - PROCESS | 1661 | RSS: Main: 263225344 08:14:43 INFO - PROCESS | 1661 | 08:14:45 INFO - PROCESS | 1661 | 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) 08:14:45 INFO - PROCESS | 1661 | RSS: Main: 263315456 08:14:45 INFO - PROCESS | 1661 | 08:14:47 INFO - PROCESS | 1661 | 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) 08:14:48 INFO - PROCESS | 1661 | RSS: Main: 263315456 08:14:48 INFO - PROCESS | 1661 | 08:14:51 INFO - PROCESS | 1661 | 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) 08:14:52 INFO - PROCESS | 1661 | RSS: Main: 263659520 08:14:52 INFO - PROCESS | 1661 | 08:14:55 INFO - PROCESS | 1661 | 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) 08:14:55 INFO - PROCESS | 1661 | RSS: Main: 263733248 08:14:55 INFO - PROCESS | 1661 | 08:14:57 INFO - PROCESS | 1661 | 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) 08:14:57 INFO - PROCESS | 1661 | RSS: Main: 265650176 08:14:57 INFO - PROCESS | 1661 | 08:14:57 INFO - PROCESS | 1661 | __start_tp_report 08:14:57 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 08:14:57 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 08:14:57 INFO - PROCESS | 1661 | |i|pagename|runs| 08:14:57 INFO - PROCESS | 1661 | |0;ai-astar;106;118;117;118;116;118;118;129;177;156 08:14:57 INFO - PROCESS | 1661 | |1;audio-beat-detection;138;113;112;148;113;114;114;112;137;114 08:14:57 INFO - PROCESS | 1661 | |2;audio-dft;197;207;204;215;240;242;196;197;198;267 08:14:57 INFO - PROCESS | 1661 | |3;audio-fft;80;58;58;85;63;61;58;62;64;70 08:14:57 INFO - PROCESS | 1661 | |4;audio-oscillator;90;72;84;72;71;72;80;70;72;83 08:14:57 INFO - PROCESS | 1661 | |5;imaging-gaussian-blur;89;87;91;130;90;88;99;86;89;85 08:14:57 INFO - PROCESS | 1661 | |6;imaging-darkroom;95;96;97;96;97;95;105;96;96;101 08:14:57 INFO - PROCESS | 1661 | |7;imaging-desaturate;145;146;91;95;100;130;93;119;146;96 08:14:57 INFO - PROCESS | 1661 | |8;json-parse-financial;63;62;61;61;63;62;62;63;63;61 08:14:57 INFO - PROCESS | 1661 | |9;json-stringify-tinderbox;69;82;74;76;75;69;70;69;103;106 08:14:57 INFO - PROCESS | 1661 | |10;stanford-crypto-aes;101;107;108;109;90;86;87;90;87;91 08:14:57 INFO - PROCESS | 1661 | |11;stanford-crypto-ccm;145;135;152;147;150;154;142;159;207;167 08:14:57 INFO - PROCESS | 1661 | |12;stanford-crypto-pbkdf2;175;176;176;177;178;173;236;190;175;177 08:14:57 INFO - PROCESS | 1661 | |13;stanford-crypto-sha256-iterative;67;68;67;68;67;68;75;79;86;88 08:14:57 INFO - PROCESS | 1661 | __end_tp_report 08:14:57 INFO - PROCESS | 1661 | __start_cc_report 08:14:57 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,910 08:14:57 INFO - PROCESS | 1661 | __end_cc_report 08:14:57 INFO - PROCESS | 1661 | __startTimestamp1484496897948__endTimestamp 08:14:57 INFO - PROCESS | 1661 | 08:14:57 INFO - PROCESS | 1661 | ------- Summary: start ------- 08:14:57 INFO - PROCESS | 1661 | Number of tests: 14 08:14:57 INFO - PROCESS | 1661 | 08:14:57 INFO - PROCESS | 1661 | [#0] ai-astar Cycles:10 Average:127.30 Median:118.00 stddev:21.93 (18.6%) stddev-sans-first:21.87 08:14:57 INFO - PROCESS | 1661 | Values: 106.0 118.0 117.0 118.0 116.0 118.0 118.0 129.0 177.0 156.0 08:14:57 INFO - PROCESS | 1661 | 08:14:57 INFO - PROCESS | 1661 | [#1] audio-beat-detection Cycles:10 Average:121.50 Median:114.00 stddev:13.78 (12.1%) stddev-sans-first:13.26 08:14:57 INFO - PROCESS | 1661 | Values: 138.0 113.0 112.0 148.0 113.0 114.0 114.0 112.0 137.0 114.0 08:14:57 INFO - PROCESS | 1661 | 08:14:57 INFO - PROCESS | 1661 | [#2] audio-dft Cycles:10 Average:216.30 Median:211.00 stddev:24.77 (11.7%) stddev-sans-first:25.27 08:14:57 INFO - PROCESS | 1661 | Values: 197.0 207.0 204.0 215.0 240.0 242.0 196.0 197.0 198.0 267.0 08:14:57 INFO - PROCESS | 1661 | 08:14:57 INFO - PROCESS | 1661 | [#3] audio-fft Cycles:10 Average:65.90 Median:63.50 stddev:9.54 (15.0%) stddev-sans-first:8.65 08:14:57 INFO - PROCESS | 1661 | Values: 80.0 58.0 58.0 85.0 63.0 61.0 58.0 62.0 64.0 70.0 08:14:57 INFO - PROCESS | 1661 | 08:14:57 INFO - PROCESS | 1661 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:76.00 stddev:7.04 (9.3%) stddev-sans-first:5.56 08:14:57 INFO - PROCESS | 1661 | Values: 90.0 72.0 84.0 72.0 71.0 72.0 80.0 70.0 72.0 83.0 08:14:57 INFO - PROCESS | 1661 | 08:14:57 INFO - PROCESS | 1661 | [#5] imaging-gaussian-blur Cycles:10 Average:93.40 Median:89.00 stddev:13.43 (15.1%) stddev-sans-first:14.15 08:14:57 INFO - PROCESS | 1661 | Values: 89.0 87.0 91.0 130.0 90.0 88.0 99.0 86.0 89.0 85.0 08:14:57 INFO - PROCESS | 1661 | 08:14:57 INFO - PROCESS | 1661 | [#6] imaging-darkroom Cycles:10 Average:97.40 Median:96.00 stddev:3.17 (3.3%) stddev-sans-first:3.24 08:14:57 INFO - PROCESS | 1661 | Values: 95.0 96.0 97.0 96.0 97.0 95.0 105.0 96.0 96.0 101.0 08:14:57 INFO - PROCESS | 1661 | 08:14:57 INFO - PROCESS | 1661 | [#7] imaging-desaturate Cycles:10 Average:116.10 Median:118.50 stddev:23.80 (20.1%) stddev-sans-first:22.83 08:14:57 INFO - PROCESS | 1661 | Values: 145.0 146.0 91.0 95.0 100.0 130.0 93.0 119.0 146.0 96.0 08:14:57 INFO - PROCESS | 1661 | 08:14:57 INFO - PROCESS | 1661 | [#8] json-parse-financial Cycles:10 Average:62.10 Median:62.50 stddev:0.88 (1.4%) stddev-sans-first:0.87 08:14:57 INFO - PROCESS | 1661 | Values: 63.0 62.0 61.0 61.0 63.0 62.0 62.0 63.0 63.0 61.0 08:14:57 INFO - PROCESS | 1661 | 08:14:57 INFO - PROCESS | 1661 | [#9] json-stringify-tinderbox Cycles:10 Average:79.30 Median:72.00 stddev:13.92 (19.3%) stddev-sans-first:14.26 08:14:57 INFO - PROCESS | 1661 | Values: 69.0 82.0 74.0 76.0 75.0 69.0 70.0 69.0 103.0 106.0 08:14:57 INFO - PROCESS | 1661 | 08:14:57 INFO - PROCESS | 1661 | [#10] stanford-crypto-aes Cycles:10 Average:95.60 Median:87.00 stddev:9.52 (10.9%) stddev-sans-first:9.90 08:14:57 INFO - PROCESS | 1661 | Values: 101.0 107.0 108.0 109.0 90.0 86.0 87.0 90.0 87.0 91.0 08:14:57 INFO - PROCESS | 1661 | 08:14:57 INFO - PROCESS | 1661 | [#11] stanford-crypto-ccm Cycles:10 Average:155.80 Median:153.00 stddev:20.07 (13.1%) stddev-sans-first:20.90 08:14:57 INFO - PROCESS | 1661 | Values: 145.0 135.0 152.0 147.0 150.0 154.0 142.0 159.0 207.0 167.0 08:14:57 INFO - PROCESS | 1661 | 08:14:57 INFO - PROCESS | 1661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.30 Median:177.00 stddev:19.09 (10.8%) stddev-sans-first:20.01 08:14:57 INFO - PROCESS | 1661 | Values: 175.0 176.0 176.0 177.0 178.0 173.0 236.0 190.0 175.0 177.0 08:14:57 INFO - PROCESS | 1661 | 08:14:57 INFO - PROCESS | 1661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:71.50 stddev:8.27 (11.6%) stddev-sans-first:8.46 08:14:57 INFO - PROCESS | 1661 | Values: 67.0 68.0 67.0 68.0 67.0 68.0 75.0 79.0 86.0 88.0 08:14:57 INFO - PROCESS | 1661 | -------- Summary: end -------- 08:14:57 INFO - PROCESS | 1661 | 08:14:58 INFO - TEST-INFO | 1661: exit 0 08:14:58 INFO - TEST-OK | kraken | took 60729ms 08:14:58 INFO - SUITE-END | took 1175s 08:14:59 INFO - Completed test suite (00:19:36) 08:14:59 INFO - javascript benchmark 08:14:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7331.319997028222, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2955.3793703322303, 3357.345317663055, 3363.192833719908, 3397.2016576104625, 3425.2806910548784, 5698.0883058710615, 5747.51146152577, 5764.827055188346, 5782.277215348082, 5787.768489260425, 5713.828585142442, 5790.652560846353, 5814.622049566775, 5917.0, 5978.312494063173, 5221.295125158112, 5223.660462069973, 5240.633155679104, 5306.283651707028, 5396.568274538047, 5370.946290537084, 5376.1398176291605, 5396.43337449566, 5414.83755487334, 5452.972735136319, 4292.9141417171795, 4432.844850430236, 4650.814042419195, 5198.9480105198845, 5354.625176237665, 4294.935575966363, 5287.603429742746, 5290.55030322423, 5290.55030322423, 5294.97352513235, 4584.426946631671, 5192.376914770214, 5221.817236396708, 5249.68501889884, 5293.6294459387855, 4652.74409907455, 5390.946090539083, 5797.971010144965, 5867.911981320283, 5909.2908850938165, 5393.271908292409, 6246.0, 6266.655333956631, 6287.528435367366, 6299.244090709099, 6176.84557886052, 6180.598261113013, 6212.751489940397, 6225.501959843202, 6229.0967809667345, 4793.808247670089, 6026.578139530191, 6029.427204415573, 6062.333143354272, 6070.2412198475195, 6238.407351301619, 6302.464290535264, 6329.588576742497, 6336.271328797156, 6356.3325850785, 6092.0, 6151.507879369639, 6245.219347581552, 6262.0, 6282.308946015934, 6177.104319873593, 6181.536384771161, 6185.567010309325, 6186.422462272092, 6214.25428948529, 6166.0, 6206.937930620727, 6260.342664020303, 6262.436380725757, 6272.027835685385, 6152.876942461216, 6201.596896201732, 6228.5951413158, 6229.657368844757, 6236.126942228092, 4939.061578300111, 5044.470330615306, 5049.495050494995, 5061.291419201315, 5069.771860266297, 4437.5784300491405, 4449.532799056053, 4450.221211288012, 4504.459464864237, 4594.839180628729, 5855.238818953509, 5860.677662728591, 5866.442687944638, 5867.941320586825, 5868.970655146697, 6265.373462653698, 6272.18461599989, 6273.592216505913, 6277.278113016971, 6304.432601065926, 4691.390119284471, 5693.829185124453, 5826.621269617462, 5826.970865145647, 5859.707014649251, 5505.614606977473, 5543.417941116125, 5567.192757050205, 5568.0, 5585.329760428694, 6351.491880649629, 6353.841153971188, 6388.712507937061, 6395.616263024233, 6417.935820641827, 5632.183333416549, 6112.685862051747, 6136.886723215932, 6170.444659980623, 6246.344133865879, 5873.911891321548, 5875.41245875409, 6248.0, 6333.240011198685, 6364.968175159094, 5237.580993520433, 6242.687865606611, 6269.467095296951, 6273.435390814849, 6274.6548939808745, 6031.185789918481, 6102.307478454422, 6145.231846019247, 6217.098520714561, 6249.250089989048, 5565.970295495346, 6107.037103281039, 6113.081058499921, 6138.7869253627705, 6252.562320637512, 5915.940840591539, 6221.720022599085, 6240.5319601031015, 6246.344133865879, 6254.061890716429, 4733.502982186821, 5341.519263266169, 5709.172170035238, 5935.673537955454, 6136.938630613815, 5538.529225015919, 5741.91387129185, 6192.876142477216, 6252.781152659635, 6260.906086408799, 6044.24446944132, 6093.695315234132, 6102.877942441215, 6103.84740381494, 6140.17107690456], "value": 5678.405475020857, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [453.12999041839646, 508.7202038878617, 514.2671692837705, 521.1089037745458, 524.889773147639, 40133.98660133985, 41995.0, 42045.0, 42098.99999999996, 42115.78942105289, 42449.36325955113, 42999.92500187489, 43000.35499467503, 43005.92485187872, 43127.56872431275, 8512.616932238034, 9383.953080234607, 9539.80920381592, 9550.761230969247, 9558.90441095587, 8458.3656225783, 11268.943655281711, 11602.651920442358, 11603.419829008559, 11822.527098916033, 11574.016208622277, 11630.95321421072, 11633.36016519091, 11637.18539702217, 11661.300321980665, 11641.243319184226, 11642.126840486997, 11649.301041937468, 11652.941735291353, 11667.416629168592, 11359.261647992937, 11404.600838970679, 11425.08599312053, 11425.428728563622, 11427.885721142766, 40243.798781005906, 40372.0, 40419.98950026243, 40535.0, 40611.1877762446, 4063.5936406359424, 4102.979485102555, 4124.6906482013665, 4135.0902801383645, 4223.239816832969, 30919.536206956913, 30941.0, 31025.8448707755, 31050.37899242025, 31153.0, 3046.908592742221, 3204.038788363505, 3242.3515296940705, 3295.703386695185, 3368.949465758016, 453727.4627253718, 455100.0, 456467.0, 456860.0, 459420.92026778904, 65278.0, 66173.0, 66176.33823661701, 66217.0, 66324.33675663278, 68386.63226735438, 68734.65632671905, 68972.3102768976, 69533.65233173802, 69626.0, 14293.428262869576, 15270.38918443272, 15420.92289538545, 15432.38270469191, 15535.611609709847, 9657.792775903012, 9753.951230243945, 10120.848187277197, 10387.792244155075, 11503.539858405737, 15893.920530397274, 17700.130566586755, 19690.0, 19931.501712457015, 19975.300864469675, 7183.568985860865, 8462.280706140047, 8612.354073444516, 8621.827563448696, 8626.317868015676, 883.8276536075532, 888.9733308000771, 907.2152588011322, 921.8801555797837, 930.5114814722325, 25319.860606272763, 29739.066960647488, 30116.397672046438, 30227.395452090834, 30512.237194069883, 1072.9302595331278, 1099.3125552277215, 1106.7233191702076, 1108.6009036746764, 1181.2517474138324, 14806.851931480547, 15082.54752357431, 15548.222588870738, 15984.920075399548, 16303.429379971643, 529310.0, 634742.0, 635182.0, 635296.0, 641202.0, 59452.10821837676, 59752.701236493536, 60127.39872601218, 60205.0, 60271.0, 1394.4770710983382, 1432.5630682641895, 1439.6113049476583, 1446.0745123121, 1453.6656568989192, 24208.43637883585, 27298.498582578148, 27757.583636245876, 28010.879564817995, 29621.25946851346, 49575.0, 49912.75043624759, 51916.48083519268, 52049.21926171035, 54987.72506137444, 512854.92152853956, 606953.0, 609294.0, 609957.9502102461, 613123.0, 28537.0, 30897.691023089483, 33447.665523344454, 37578.436323454625, 39040.41439378355, 40988.081430228565, 42448.15103697847, 42743.93140171521, 43234.56765432305, 43360.349594756735, 30176.396472069995, 31493.370132597676, 35364.64635353613, 35470.0, 36573.63426365809, 35593.64406355903, 35597.644023559435, 36327.455088174225, 36653.63346366502, 36702.44946325754, 34767.65232347644, 34862.82568587141, 35105.48945105469, 35219.47170792492, 35480.64519354773, 28941.276468088465, 31388.843055785488, 31422.842885785423, 31480.212994675316, 31550.58022389044, 23255.0, 23839.52320953606, 23916.162934297216, 24275.878620606785, 24310.635340469555], "value": 20270.951197950442, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.54001358424216, 397.3423983307623, 408.4608317021532, 409.50858969236924, 426.96248117075515, 20425.080871360788, 20815.0633221505, 21197.046132924017, 21558.245461408853, 21850.0, 21767.129314827387, 21844.45388865279, 22209.0, 22471.87640617971, 22680.54638907221, 5592.944070559293, 5793.971030144843, 5875.206847075654, 5877.500412464924, 5889.587728858982, 5650.943490565103, 5808.883822323551, 5816.360200377955, 5883.47048765611, 5924.496417804492, 5817.621854579439, 5821.7380217890295, 5825.271841019872, 5829.329627092896, 5851.912221316684, 5599.776008959637, 5730.2837145356625, 5799.159121927339, 5799.3620701722775, 5806.59353845231, 4449.955500444987, 5127.589792816566, 5136.0, 5139.7687104080405, 5145.974270128625, 26055.609165862526, 26472.338191545172, 26500.73499265002, 26752.86623566889, 26891.0, 2734.2207470870903, 2765.9170224893287, 2768.529350010503, 2769.252301878502, 2792.6928037915814, 15611.297491612904, 15894.443694470638, 16037.599060023476, 16258.268377923021, 16615.335386584644, 1826.9908650456796, 1828.6159906419668, 1836.3572749537689, 1841.8894866308065, 1848.159087615132, 106902.46548767285, 131599.0, 131910.3404482981, 134734.0, 136235.0, 11384.14618903569, 11663.475143618558, 11671.474783634756, 11739.23694959842, 11916.702082447835, 14937.103773773608, 14958.252087395587, 14966.476173334098, 14973.326200321011, 15016.324265408082, 6670.666466676646, 8456.534890581077, 8495.872561911576, 8500.0, 8613.095624959415, 8159.632816523271, 8180.9590952044855, 8187.83624327522, 8329.0, 8370.53962032094, 6035.577509574376, 7193.856122877513, 7298.343149116498, 7311.744088956861, 7341.302576255247, 1926.25839051966, 1956.2664000999625, 1960.5588742532816, 1960.9901950490157, 1962.1758861278297, 897.8473659477904, 900.428228075177, 904.8823652925078, 930.2604429478581, 954.9045095490534, 21498.677519837216, 22581.209657661904, 22718.864056797094, 22826.771732282796, 22833.771662283496, 704.6864145455223, 923.8151175176462, 933.2207606648388, 952.0669743651122, 953.3612479638658, 9280.341786493262, 11684.70788230301, 11745.706357340963, 11750.29498230109, 11793.469293881795, 523059.1541126886, 671638.0, 708448.4577577079, 721912.0, 727445.0, 63411.0, 90649.0, 109784.0, 123573.14640280404, 127941.0, 1037.3827572594294, 1038.8597539332245, 1066.4294602387686, 1066.5520481397987, 1067.6103222323795, 19293.903530482257, 19417.320393786715, 19574.825510469418, 19628.60742785165, 19644.90177549103, 52290.47709522856, 52317.69205769886, 52635.73682131718, 53003.0247731414, 53067.0, 74023.62988185024, 74754.0, 74754.50490990041, 75410.86883696858, 75675.62162189154, 6305.337939516285, 7548.698052077855, 7596.962015189889, 7614.124375696644, 7759.534427934342, 11600.825987610024, 11934.761304773681, 12059.879401205875, 12119.0, 12183.573574924834, 8382.16178382157, 9854.901450985399, 10030.548625311732, 10170.8474372883, 10203.234757393373, 9824.950875245579, 9915.008499150315, 10117.392956422638, 10150.644727434505, 10404.323718958243, 10164.33931794431, 10440.791184176425, 10607.045365917105, 10641.308314959502, 10704.197185210984, 7502.474826762074, 7636.12184598756, 7657.358211417052, 7898.052233731989, 7991.041075071029, 9964.551595178089, 10004.099631033241, 10148.13740832008, 10245.48772561354, 10392.0], "value": 9753.489922546627, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1366.8223130992972, 1438.2592964623227, 1464.8315443723975, 1489.2181604657553, 1505.7816616590592, 7487.9251207487905, 7674.961625191881, 8177.959110204448, 8669.349798765094, 8669.479831210125, 8171.673133074684, 8459.661613535467, 8468.322534197265, 8543.231109200171, 8605.956970215157, 1808.7286906963996, 1952.9902350488298, 2186.857854239477, 2335.6730057791924, 2374.442006128558, 2055.496403381174, 2340.3681006128336, 2347.3427440316736, 2377.0135393811547, 2385.33210701004, 1961.852861035428, 2338.959163172389, 2343.121329501437, 2348.4598542335275, 2375.809935205188, 1943.0964601460248, 2339.157903154863, 2347.823913206499, 2357.54027964547, 2364.0189321431585, 1991.8506112041655, 2295.9782896611014, 2303.090279339668, 2374.2877136858874, 2382.6545150953016, 7579.242075792432, 8543.572821358906, 8566.571671416405, 8624.956875215585, 8632.223099921037, 5153.458886816868, 5307.548858347045, 5330.893382132335, 5337.172738225581, 5342.866428339323, 3325.4679251319913, 3407.386670399327, 3542.752007359486, 3602.8919132426067, 3612.295602357541, 1201.0, 1202.182515889195, 1221.8087364819319, 1232.7657745028505, 1240.6340129661771, 10958.506867190916, 11000.22998390105, 11091.55633774648, 11107.99999999992, 11113.777724445466, 4470.5976462117915, 4690.390249267573, 4750.382450281441, 4763.333133361332, 4781.211100168433, 9575.952120239353, 9611.951940240255, 9649.9035009649, 9656.95171524138, 9660.178884794872, 5223.0, 5314.202869569595, 5324.361076670824, 5329.493698098674, 5341.786328546892, 4195.223883581547, 4829.6860704054125, 4843.782029808667, 4871.391076115486, 4892.633052521075, 3490.616032236452, 3844.1350696093714, 3844.6539811417106, 3918.8824335269987, 3986.5814089520763, 1303.680598253415, 1307.130758045908, 1310.9934450327878, 1318.2749487781682, 1329.322045756671, 804.1717031457491, 805.3275514945086, 861.5950503263456, 926.6247169896203, 927.9211267042242, 5014.498550144956, 5396.78412863481, 5576.581756368289, 5691.800786972436, 5909.379515150933, 1002.659095907395, 1012.4785735346303, 1050.0, 1061.3737894642045, 1071.2287153249647, 3726.2547490501465, 3783.7162212834146, 3802.5817160112365, 3877.747946383476, 3904.6095390461296, 9887.110160085484, 10195.643152489627, 10197.18422526196, 10202.795944081077, 10227.130693891102, 10052.69841904744, 10103.7474063149, 10172.186225101974, 10207.081362677247, 10216.387016779017, 7618.961905190438, 7908.01149856268, 7978.760637180894, 8011.597970355165, 8024.759257222293, 4630.374899388674, 5809.24479817621, 5840.678762668094, 5844.970775146267, 6015.488683461955, 9111.134442227978, 9177.587008584496, 9278.907210928075, 9437.292203084933, 9443.244540436886, 9248.16766491019, 9376.57805398745, 9466.100720431548, 9501.28740344463, 9515.238780897651, 6668.066470694203, 6837.453003759588, 6991.021257023919, 7082.716691332289, 7223.422126229994, 7908.644111015134, 8031.237032481905, 8047.919520804717, 8076.676932922617, 8114.715984940499, 6489.221293444817, 6935.89596156048, 7149.82125446868, 7254.782356529313, 7406.962965185139, 6707.0, 7072.752453664097, 7075.964620176866, 7082.150141982995, 7117.537360071578, 6379.011253255753, 6416.871662566816, 6432.0, 6486.286508483969, 6492.805215843532, 4297.806598703003, 5049.394072711299, 5068.417132029864, 5077.669951453144, 5102.744862756922, 4960.181570040902, 4992.80028798844, 5089.949100508948, 5139.743012849268, 5159.664621799571], "value": 4456.5381859529125, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.810405652552, 320.3209196503412, 363.30971154805883, 374.71896077941545, 377.5676850006741, 4122.7526348419115, 5112.778949261964, 5129.333186685735, 5206.713630750307, 5455.509004189622, 4227.71054828278, 5313.20301954707, 5315.36215654121, 5317.308749862522, 5341.4925582069645, 3703.3889408247605, 4156.8129434175535, 4190.763724701213, 4222.894427639303, 4226.640735537483, 3766.1902690921447, 3837.4052021936504, 4203.0, 4209.452771139763, 4223.809928553223, 3985.8604948826796, 4008.478897743304, 4009.218202450523, 4018.57804930481, 4022.2558826617023, 3635.9818200908826, 3721.9441708374397, 3987.2623564640635, 4010.779407132621, 4031.959680403217, 3487.2563718140927, 3500.967214671678, 3501.404761190578, 3514.5606799150105, 3515.2090779574646, 4373.190959672471, 4499.505054444008, 5158.071547121516, 5183.455737147583, 5208.166693329049, 4049.514058312992, 4596.632269418472, 4599.425071866017, 4631.444226692818, 4659.976700116512, 5568.582356323292, 5683.886322273532, 5686.601937864351, 5697.003024470701, 5712.457316554921, 3314.320564284316, 3735.9813200933822, 3824.330742120118, 3858.614138586147, 3911.1617539756553, 5129.487051294878, 5709.685967271798, 5786.739596718157, 5891.263592050994, 5903.0, 3875.6511913927884, 3885.203533275672, 3890.3386424307937, 3902.6292502212245, 3905.824237909301, 3703.8518459261327, 3937.5078115235597, 3956.090099277125, 3970.8808735737975, 3985.1631157456677, 4392.934105988413, 4462.6876118672035, 4586.564276393738, 4638.884027899329, 4680.0, 5459.781608735606, 5600.85997850057, 5760.971195143998, 5800.941990580124, 5823.39856539455, 1214.2350319298785, 1230.2864338683721, 1248.9375531223402, 1258.2261908926127, 1352.1819299323963, 795.5067857928121, 938.9014852622448, 1001.8028455995161, 1004.6885465505717, 1005.7586179317058, 4226.535081141072, 4523.932141017887, 5048.343715316985, 5055.418626857959, 5056.266841308064, 4723.811047558128, 4905.8226025754275, 5290.709011004355, 5479.698616576126, 5604.747786349624, 4684.484706682262, 5030.270610761419, 5033.521815427529, 5038.874028149252, 5051.191809310566, 2449.4366295752075, 2765.1013420638374, 2830.1038304336143, 2935.750461210778, 2975.3900450407614, 4929.112759703288, 4952.5542701157065, 5508.944910550843, 5624.862552230208, 5826.329972053183, 5370.355557333145, 5701.572382071361, 5756.453136951983, 5810.690712281478, 5812.564057695689, 4767.69010014348, 4945.986072855056, 5080.415752188545, 5411.458854114636, 5751.447109280471, 4521.005378816655, 5242.606804489755, 5466.508014278734, 5589.273394458694, 5601.271834661468, 4619.284010978169, 5485.424030476902, 5539.279893613804, 5542.224088627515, 5588.329400471969, 5265.052290587731, 5411.6211865170635, 5545.556355491632, 5733.569982251432, 5804.736152900457, 3816.2939856126704, 4013.050407950096, 4013.7190396673122, 4048.5344185419053, 4089.159878054828, 4862.756862156807, 5446.591505637014, 5659.688717120598, 5670.489655930821, 5688.402717714746, 5265.710385928657, 5274.578033757367, 5432.207371567294, 5459.590530710292, 5611.523020543136, 5526.80656177048, 5684.971575142098, 5713.342965559014, 5717.227144834668, 5726.570507211893, 4723.905521889612, 5299.49654782795, 5366.785328586813, 5565.833025009256, 5615.2700148980375, 5398.974194902956, 5717.885642287214, 5731.398203188605, 5733.512651424676, 5741.97129014369, 4480.252701446504, 5331.253624492651, 5408.72956352173, 5620.290608198569, 5654.067078932095], "value": 4075.7283308642827, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.8246020954972, 778.1362687416967, 832.0680837462036, 842.2167384332571, 845.0957475501216, 15468.767968480468, 16105.597360066004, 16126.113063781488, 16149.354025838968, 16151.273192706327, 14778.556643300692, 14963.251837408114, 14986.400543978229, 15002.924985375057, 15012.0, 690.3752104345575, 713.6182142553735, 855.0167307596283, 862.7282406042077, 897.6364572348209, 894.1058941058941, 899.7075950316141, 901.6528636474972, 902.6840605787987, 909.586138307072, 934.8550974598948, 951.3103000324778, 952.3095755577186, 953.1278879824987, 953.8855337359527, 935.1583574782682, 938.755923459902, 942.6559305853383, 945.121037435185, 946.5503885654327, 703.1070540413697, 704.5737328916034, 706.7808979216408, 709.0321710864632, 709.7728726807424, 14931.552053438414, 15326.233688315651, 15419.845801541953, 15949.282282297325, 16120.355185792554, 14360.56918292453, 14570.198639074846, 14575.708485830224, 14625.0, 14659.633509162357, 11692.356920369377, 11696.005839503652, 11717.824232636518, 11720.0, 11735.239714042962, 3573.6426357364317, 3666.816659167058, 3778.131029863147, 3796.9430458543143, 3854.8843534693724, 104250.0, 107912.38131428036, 108205.45897270463, 108561.0, 108916.45541772319, 10561.102306303897, 10782.78434431307, 10820.837687434694, 10822.729431764112, 11094.00153986145, 21099.0, 21170.94145292729, 21257.78742212558, 21259.68110478344, 21271.57456850885, 7466.664000120008, 7472.364848987897, 7623.199564045806, 7641.465097443237, 7767.067951845815, 4149.854755083557, 4207.705460617727, 4239.300515414983, 4317.438732964694, 4350.477942646902, 3619.0952261934517, 3634.854605815791, 3697.5932647408763, 3707.9988403131542, 3720.2745464634136, 679.3444326225216, 680.9012693159464, 684.8082536889679, 685.3352248319122, 699.8915168148945, 664.6909187227963, 677.701811203069, 686.2074304178682, 689.8240948558085, 697.2121502702016, 7992.321612461332, 8349.33205343571, 8363.0, 10364.326318789406, 10518.947405263078, 669.9062131301622, 684.1619016704498, 703.0930100170825, 709.1206903439801, 720.9459290553125, 3679.6504332088944, 4584.7936842842155, 4758.191107511731, 4871.464138944713, 4894.420916226916, 101171.0, 101604.0, 102265.48867255617, 103380.48309758553, 108036.45981770041, 88355.55822220976, 90317.0, 93948.0605193953, 94339.0, 94428.0, 58510.12234816481, 71621.0, 71885.12459501562, 71989.6400517994, 72564.0, 10430.26988110825, 10804.621838235624, 10934.945325273322, 11011.559537618405, 11171.832422513506, 48646.75676621594, 49664.0, 50322.74193145201, 51109.744451277504, 51546.484535154166, 71585.64207179139, 72371.63814180896, 72687.63656181685, 73025.26974730397, 74086.0, 13137.211767293993, 13230.603081907559, 13287.40206690682, 13406.396712148171, 13636.454203112251, 14473.421063157355, 14574.0, 14671.486497972519, 14737.631559211106, 14783.186924719244, 13639.318034098455, 13708.520201793288, 13904.72099145334, 13911.652208694864, 14305.21321327337, 13405.865941340462, 13721.519746808814, 13752.381142848395, 14221.64445888861, 14407.495737649131, 13347.532836350681, 13413.932930335677, 13472.865271347553, 13667.863321367056, 13847.79228311556, 10987.560497580007, 11420.31478111316, 11458.0, 11644.88355116438, 11690.357030363411, 8931.910680893108, 9572.856407153758, 9657.517124143906, 11092.944535277595, 11379.772404552028], "value": 7613.451505665294, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1563.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 117.0, 118.0, 116.0, 118.0, 118.0, 129.0, 177.0, 156.0], "value": 127.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 113.0, 112.0, 148.0, 113.0, 114.0, 114.0, 112.0, 137.0, 114.0], "value": 121.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 207.0, 204.0, 215.0, 240.0, 242.0, 196.0, 197.0, 198.0, 267.0], "value": 216.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 58.0, 85.0, 63.0, 61.0, 58.0, 62.0, 64.0, 70.0], "value": 65.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 72.0, 84.0, 72.0, 71.0, 72.0, 80.0, 70.0, 72.0, 83.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 91.0, 130.0, 90.0, 88.0, 99.0, 86.0, 89.0, 85.0], "value": 93.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 96.0, 97.0, 95.0, 105.0, 96.0, 96.0, 101.0], "value": 97.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 91.0, 95.0, 100.0, 130.0, 93.0, 119.0, 146.0, 96.0], "value": 116.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 61.0, 63.0, 62.0, 62.0, 63.0, 63.0, 61.0], "value": 62.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 82.0, 74.0, 76.0, 75.0, 69.0, 70.0, 69.0, 103.0, 106.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 107.0, 108.0, 109.0, 90.0, 86.0, 87.0, 90.0, 87.0, 91.0], "value": 95.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 135.0, 152.0, 147.0, 150.0, 154.0, 142.0, 159.0, 207.0, 167.0], "value": 155.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 176.0, 176.0, 177.0, 178.0, 173.0, 236.0, 190.0, 175.0, 177.0], "value": 183.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 68.0, 67.0, 68.0, 75.0, 79.0, 86.0, 88.0], "value": 73.3, "unit": "score"}]}]} 08:14:59 INFO - Return code: 0 08:14:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:14:59 ERROR - # TBPL SUCCESS # 08:14:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:14:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:14:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:14:59 INFO - 2017-01-15 08:14:59.238 screenresolution[1666:11133] starting screenresolution argv=screenresolution get 08:14:59 INFO - 2017-01-15 08:14:59.242 screenresolution[1666:11133] Display 0: 1600x1200x32@60 08:14:59 INFO - 2017-01-15 08:14:59.248 screenresolution[1667:11136] starting screenresolution argv=screenresolution list 08:14:59 INFO - Available Modes on Display 0 08:14:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:14:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:14:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:14:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:14:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:14:59 INFO - Intel Iris: 08:14:59 INFO - Chipset Model: Intel Iris 08:14:59 INFO - Type: GPU 08:14:59 INFO - Bus: Built-In 08:14:59 INFO - VRAM (Dynamic, Max): 1536 MB 08:14:59 INFO - Vendor: Intel (0x8086) 08:14:59 INFO - Device ID: 0x0a2e 08:14:59 INFO - Revision ID: 0x0009 08:14:59 INFO - Displays: 08:14:59 INFO - Display: 08:14:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:14:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:14:59 INFO - Display Serial Number: 1600x1200 60 08:14:59 INFO - Main Display: Yes 08:14:59 INFO - Mirror: Off 08:14:59 INFO - Online: Yes 08:14:59 INFO - Rotation: Supported 08:14:59 INFO - Return code: 0 08:14:59 INFO - Running post-action listener: _resource_record_post_action 08:14:59 INFO - [mozharness: 2017-01-15 16:14:59.483255Z] Finished run-tests step (success) 08:14:59 INFO - Running post-run listener: _resource_record_post_run 08:14:59 INFO - Total resource usage - Wall time: 1199s; CPU: 55.0%; Read bytes: 33309184; Write bytes: 555369472; Read time: 200; Write time: 1718 08:14:59 INFO - TinderboxPrint: CPU usage
54.6% 08:14:59 INFO - TinderboxPrint: I/O read bytes / time
33,309,184 / 200 08:14:59 INFO - TinderboxPrint: I/O write bytes / time
555,369,472 / 1,718 08:14:59 INFO - TinderboxPrint: CPU idle
2,176.8 (45.4%) 08:14:59 INFO - TinderboxPrint: CPU system
970.5 (20.2%) 08:14:59 INFO - TinderboxPrint: CPU user
1,650.4 (34.4%) 08:14:59 INFO - TinderboxPrint: Swap in / out
280,997,888 / 0 08:14:59 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 243487232; Write bytes: 234530304; Read time: 18033; Write time: 521 08:14:59 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 31339008; Write bytes: 301239808; Read time: 183; Write time: 1154 08:14:59 INFO - Running post-run listener: _upload_blobber_files 08:14:59 INFO - Blob upload gear active. 08:14:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:14:59 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 08:14:59 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'] 08:14:59 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 08:15:00 INFO - (blobuploader) - INFO - Open directory for files ... 08:15:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:15:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:15:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:15:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:15:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:15:01 INFO - (blobuploader) - INFO - Done attempting. 08:15:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:15:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:15:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:15:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:15:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:15:03 INFO - (blobuploader) - INFO - Done attempting. 08:15:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:15:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:15:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:15:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:15:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:15:04 INFO - (blobuploader) - INFO - Done attempting. 08:15:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:15:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:15:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:15:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:15:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:15:07 INFO - (blobuploader) - INFO - Done attempting. 08:15:07 INFO - (blobuploader) - INFO - Iteration through files over. 08:15:07 INFO - Return code: 0 08:15:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:15:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:15:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41ea905fd470f0a02835098e516972cf71be350623024fd6e06f9d19a39ae0452f767b6b0d47a2f6f290de37bfa081590af9b5fa09840606e93072beaa8a7fdb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/194fc102a03c2d84ffeac4b5f56156ee36c8ad6236a11222934d21a973d27eefd74ce3a81b8d353f26a5cb36170e691b624ea43a22c91ced3e849631eec9086a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d06667ba362edc1e027296508a89e07b39b565c7dde9f68760bcdd3b4bc28e1b97c4875c70ebb4933a0998fe0f379243a783136fb92156d0d94d44fd494c682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9da1ba6ab3387313635d60ba81bc4b55ce215923af733df501089da45d8b71ee370dd21243cd45df35d95965d9e0725201eb69f4f424934e417a06ba819f006"} 08:15:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:15:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:15:07 INFO - Contents: 08:15:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41ea905fd470f0a02835098e516972cf71be350623024fd6e06f9d19a39ae0452f767b6b0d47a2f6f290de37bfa081590af9b5fa09840606e93072beaa8a7fdb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/194fc102a03c2d84ffeac4b5f56156ee36c8ad6236a11222934d21a973d27eefd74ce3a81b8d353f26a5cb36170e691b624ea43a22c91ced3e849631eec9086a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d06667ba362edc1e027296508a89e07b39b565c7dde9f68760bcdd3b4bc28e1b97c4875c70ebb4933a0998fe0f379243a783136fb92156d0d94d44fd494c682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9da1ba6ab3387313635d60ba81bc4b55ce215923af733df501089da45d8b71ee370dd21243cd45df35d95965d9e0725201eb69f4f424934e417a06ba819f006"} 08:15:07 INFO - Running post-run listener: copy_logs_to_upload_dir 08:15:07 INFO - Copying logs to upload dir... 08:15:07 INFO - mkdir: /builds/slave/test/build/upload/logs 08:15:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.949714 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-15 08:15:07.671800) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-15 08:15:07.675357) ========= 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.qy9N1qDWVR/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.Bf2Hkizsa2/Listeners TMPDIR=/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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/41ea905fd470f0a02835098e516972cf71be350623024fd6e06f9d19a39ae0452f767b6b0d47a2f6f290de37bfa081590af9b5fa09840606e93072beaa8a7fdb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/194fc102a03c2d84ffeac4b5f56156ee36c8ad6236a11222934d21a973d27eefd74ce3a81b8d353f26a5cb36170e691b624ea43a22c91ced3e849631eec9086a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d06667ba362edc1e027296508a89e07b39b565c7dde9f68760bcdd3b4bc28e1b97c4875c70ebb4933a0998fe0f379243a783136fb92156d0d94d44fd494c682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9da1ba6ab3387313635d60ba81bc4b55ce215923af733df501089da45d8b71ee370dd21243cd45df35d95965d9e0725201eb69f4f424934e417a06ba819f006"} build_url:https://queue.taskcluster.net/v1/task/O3FAS58vQNqtxnGoYw2c3w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011032 build_url: 'https://queue.taskcluster.net/v1/task/O3FAS58vQNqtxnGoYw2c3w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41ea905fd470f0a02835098e516972cf71be350623024fd6e06f9d19a39ae0452f767b6b0d47a2f6f290de37bfa081590af9b5fa09840606e93072beaa8a7fdb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/194fc102a03c2d84ffeac4b5f56156ee36c8ad6236a11222934d21a973d27eefd74ce3a81b8d353f26a5cb36170e691b624ea43a22c91ced3e849631eec9086a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d06667ba362edc1e027296508a89e07b39b565c7dde9f68760bcdd3b4bc28e1b97c4875c70ebb4933a0998fe0f379243a783136fb92156d0d94d44fd494c682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9da1ba6ab3387313635d60ba81bc4b55ce215923af733df501089da45d8b71ee370dd21243cd45df35d95965d9e0725201eb69f4f424934e417a06ba819f006"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-15 08:15:07.710429) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 08:15:07.710756) ========= 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.qy9N1qDWVR/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.Bf2Hkizsa2/Listeners TMPDIR=/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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.004995 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 08:15:07.759151) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-15 08:15:07.759576) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-15 08:15:07.759913) ========= ========= Total master_lag: 0.18 =========