builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0278 starttime: 1493142576.94 results: success (0) buildid: 20170425094824 builduid: 0d626cc0ebf84365ba6f0d5b55a55119 revision: 419d01b08a9ef9d9f8698c73b573eb2ffeeef0c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 10:49:36.942924) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 10:49:36.943344) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 18 secs) (at 2017-04-25 10:49:36.947636) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 18 secs) (at 2017-04-25 10:49:55.720344) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 10:49:55.720658) ========= 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.0ms9ScJ8LL/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.iQH9Lirok7/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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-04-25 10:49:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 17.2M=0.001s 2017-04-25 10:49:55 (17.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.147039 ========= master_lag: 0.27 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 10:49:56.140884) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2017-04-25 10:49:56.141837) ========= 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.0ms9ScJ8LL/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.iQH9Lirok7/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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.027416 ========= master_lag: 1.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2017-04-25 10:49:57.191395) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-25 10:49:57.191848) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 419d01b08a9ef9d9f8698c73b573eb2ffeeef0c1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 419d01b08a9ef9d9f8698c73b573eb2ffeeef0c1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0ms9ScJ8LL/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.iQH9Lirok7/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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-04-25 10:49:57,298 truncating revision to first 12 chars 2017-04-25 10:49:57,299 Setting DEBUG logging. 2017-04-25 10:49:57,299 attempt 1/10 2017-04-25 10:49:57,299 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/419d01b08a9e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-25 10:49:58,962 unpacking tar archive at: mozilla-beta-419d01b08a9e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.941623 ========= master_lag: 0.69 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-25 10:49:59.827472) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 10:49:59.827814) ========= script_repo_revision: 419d01b08a9ef9d9f8698c73b573eb2ffeeef0c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 10:49:59.828200) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 10:49:59.828466) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 10:50:00.167848) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2017-04-25 10:50:00.168147) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0ms9ScJ8LL/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.iQH9Lirok7/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 10:50:00 INFO - MultiFileLogger online at 20170425 10:50:00 in /builds/slave/test 10:50:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:50:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:50:00 INFO - {'append_to_log': False, 10:50:00 INFO - 'base_work_dir': '/builds/slave/test', 10:50:00 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:50:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:50:00 INFO - 'branch': 'Mozilla-Beta', 10:50:00 INFO - 'buildbot_json_path': 'buildprops.json', 10:50:00 INFO - 'config_files': ('talos/mac_config.py',), 10:50:00 INFO - 'default_actions': ('clobber', 10:50:00 INFO - 'read-buildbot-config', 10:50:00 INFO - 'download-and-extract', 10:50:00 INFO - 'populate-webroot', 10:50:00 INFO - 'create-virtualenv', 10:50:00 INFO - 'install', 10:50:00 INFO - 'run-tests'), 10:50:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:50:00 INFO - 'download_minidump_stackwalk': True, 10:50:00 INFO - 'download_symbols': 'ondemand', 10:50:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:50:00 INFO - 'tooltool.py': '/tools/tooltool.py', 10:50:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:50:00 INFO - '/tools/misc-python/virtualenv.py')}, 10:50:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:50:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:50:00 INFO - 'gecko_profile': False, 10:50:00 INFO - 'gecko_profile_interval': 0, 10:50:00 INFO - 'installer_path': 'installer.exe', 10:50:00 INFO - 'log_level': 'info', 10:50:00 INFO - 'log_name': 'talos', 10:50:00 INFO - 'log_to_console': True, 10:50:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:50:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:50:00 INFO - 'opt_config_files': (), 10:50:00 INFO - 'pip_index': False, 10:50:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:50:00 INFO - 'cmd': ('bash', 10:50:00 INFO - '-c', 10:50:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:50:00 INFO - 'enabled': True, 10:50:00 INFO - 'halt_on_failure': False, 10:50:00 INFO - 'name': 'check_screen_resolution'},), 10:50:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:50:00 INFO - 'cmd': ('bash', 10:50:00 INFO - '-c', 10:50:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:50:00 INFO - 'enabled': True, 10:50:00 INFO - 'halt_on_failure': False, 10:50:00 INFO - 'name': 'check_screen_resolution'},), 10:50:00 INFO - 'run_cmd_checks_enabled': True, 10:50:00 INFO - 'suite': 'dromaeojs-e10s', 10:50:00 INFO - 'system_bits': '32', 10:50:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:50:00 INFO - 'title': 't-yosemite-r7-0278', 10:50:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:50:00 INFO - 'use_talos_json': True, 10:50:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:50:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:50:00 INFO - 'work_dir': 'build'} 10:50:00 INFO - [mozharness: 2017-04-25 17:50:00.463356Z] Running clobber step. 10:50:00 INFO - Running pre-action listener: _resource_record_pre_action 10:50:00 INFO - Running main action method: clobber 10:50:00 INFO - rmtree: /builds/slave/test/build 10:50:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:50:02 INFO - Running post-action listener: _resource_record_post_action 10:50:02 INFO - [mozharness: 2017-04-25 17:50:02.846334Z] Finished clobber step (success) 10:50:02 INFO - [mozharness: 2017-04-25 17:50:02.846492Z] Running read-buildbot-config step. 10:50:02 INFO - Running pre-action listener: _resource_record_pre_action 10:50:02 INFO - Running main action method: read_buildbot_config 10:50:02 INFO - Using buildbot properties: 10:50:02 INFO - { 10:50:02 INFO - "project": "", 10:50:02 INFO - "product": "firefox", 10:50:02 INFO - "script_repo_revision": "production", 10:50:02 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 10:50:02 INFO - "repository": "", 10:50:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 10:50:02 INFO - "buildid": "20170425094824", 10:50:02 INFO - "pgo_build": "False", 10:50:02 INFO - "basedir": "/builds/slave/test", 10:50:02 INFO - "buildnumber": 8, 10:50:02 INFO - "slavename": "t-yosemite-r7-0278", 10:50:02 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 10:50:02 INFO - "platform": "yosemite_r7", 10:50:02 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:50:02 INFO - "branch": "mozilla-beta", 10:50:02 INFO - "repo_path": "releases/mozilla-beta", 10:50:02 INFO - "revision": "419d01b08a9ef9d9f8698c73b573eb2ffeeef0c1", 10:50:02 INFO - "stage_platform": "macosx64", 10:50:02 INFO - "builduid": "0d626cc0ebf84365ba6f0d5b55a55119", 10:50:02 INFO - "slavebuilddir": "test" 10:50:02 INFO - } 10:50:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 10:50:02 INFO - Running post-action listener: _resource_record_post_action 10:50:02 INFO - [mozharness: 2017-04-25 17:50:02.849840Z] Finished read-buildbot-config step (success) 10:50:02 INFO - [mozharness: 2017-04-25 17:50:02.849939Z] Running download-and-extract step. 10:50:02 INFO - Running pre-action listener: _resource_record_pre_action 10:50:02 INFO - Running main action method: download_and_extract 10:50:02 INFO - mkdir: /builds/slave/test/build/tests 10:50:02 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')]} 10:50:02 INFO - trying https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 10:50:02 INFO - Downloading https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 10:50:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 10:50:04 INFO - Downloaded 1165 bytes. 10:50:04 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 10:50:04 INFO - Using the following test package requirements: 10:50:04 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 10:50:04 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:50:04 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 10:50:04 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:50:04 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 10:50:04 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:50:04 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:50:04 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 10:50:04 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 10:50:04 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:50:04 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 10:50:04 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:50:04 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 10:50:04 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:50:04 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 10:50:04 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:50:04 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 10:50:04 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 10:50:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 10:50:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 10:50:04 INFO - Fetch https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 10:50:05 INFO - Expected file size: 51221072 10:50:05 INFO - Obtained file size: 51221072 10:50:21 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 10:50:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 10:50:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 10:50:21 INFO - Fetch https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 10:50:23 INFO - Expected file size: 51221072 10:50:23 INFO - Obtained file size: 51221072 10:50:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 10:50:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 10:50:38 INFO - Fetch https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 10:50:39 INFO - Expected file size: 14404449 10:50:39 INFO - Obtained file size: 14404449 10:50:39 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')]} 10:50:39 INFO - trying https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 10:50:39 INFO - Downloading https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 10:50:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 10:50:41 INFO - Downloaded 59532350 bytes. 10:50:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 10:50:41 INFO - mkdir: /builds/slave/test/properties 10:50:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:50:41 INFO - Writing to file /builds/slave/test/properties/build_url 10:50:41 INFO - Contents: 10:50:41 INFO - build_url:https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 10:50:42 INFO - Running post-action listener: _resource_record_post_action 10:50:42 INFO - Running post-action listener: set_extra_try_arguments 10:50:42 INFO - [mozharness: 2017-04-25 17:50:42.335152Z] Finished download-and-extract step (success) 10:50:42 INFO - [mozharness: 2017-04-25 17:50:42.335277Z] Running populate-webroot step. 10:50:42 INFO - Running pre-action listener: _resource_record_pre_action 10:50:42 INFO - Running main action method: populate_webroot 10:50:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:50:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:50:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:50:42 INFO - '--tppagecycles', 10:50:42 INFO - '7'], 10:50:42 INFO - 'tests': ['tsvgm']}}, 10:50:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:50:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:50:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:50:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:50:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:50:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:50:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:50:42 INFO - 'talos_options': ['--disable-e10s'], 10:50:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:50:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:50:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:50:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:50:42 INFO - 'talos_options': ['--disable-e10s'], 10:50:42 INFO - 'tests': ['damp', 'tps']}, 10:50:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:50:42 INFO - 'tests': ['damp', 'tps']}, 10:50:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:50:42 INFO - 'tests': ['dromaeo_dom']}, 10:50:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:50:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:50:42 INFO - 'tests': ['basic_compositor_video']}, 10:50:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:50:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:50:42 INFO - 'tests': ['a11yr', 10:50:42 INFO - 'ts_paint', 10:50:42 INFO - 'tpaint', 10:50:42 INFO - 'sessionrestore', 10:50:42 INFO - 'sessionrestore_no_auto_restore', 10:50:42 INFO - 'tabpaint']}, 10:50:42 INFO - 'other-e10s': {'tests': ['a11yr', 10:50:42 INFO - 'ts_paint', 10:50:42 INFO - 'tpaint', 10:50:42 INFO - 'sessionrestore', 10:50:42 INFO - 'sessionrestore_no_auto_restore', 10:50:42 INFO - 'tabpaint']}, 10:50:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:50:42 INFO - 'ts_paint', 10:50:42 INFO - 'tpaint', 10:50:42 INFO - 'sessionrestore', 10:50:42 INFO - 'sessionrestore_no_auto_restore', 10:50:42 INFO - 'tabpaint']}, 10:50:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:50:42 INFO - 'ts_paint', 10:50:42 INFO - 'tpaint', 10:50:42 INFO - 'sessionrestore', 10:50:42 INFO - 'sessionrestore_no_auto_restore', 10:50:42 INFO - 'tabpaint']}, 10:50:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:50:42 INFO - 'tests': ['a11yr', 10:50:42 INFO - 'ts_paint', 10:50:42 INFO - 'tpaint', 10:50:42 INFO - 'sessionrestore', 10:50:42 INFO - 'sessionrestore_no_auto_restore', 10:50:42 INFO - 'tabpaint']}, 10:50:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:50:42 INFO - 'tests': ['a11yr', 10:50:42 INFO - 'ts_paint', 10:50:42 INFO - 'tpaint', 10:50:42 INFO - 'sessionrestore', 10:50:42 INFO - 'sessionrestore_no_auto_restore', 10:50:42 INFO - 'tabpaint']}, 10:50:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:50:42 INFO - 'tests': ['tsvgx', 10:50:42 INFO - 'tsvgr_opacity', 10:50:42 INFO - 'tart', 10:50:42 INFO - 'tscrollx', 10:50:42 INFO - 'cart', 10:50:42 INFO - 'tsvg_static']}, 10:50:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:50:42 INFO - 'tsvgr_opacity', 10:50:42 INFO - 'tart', 10:50:42 INFO - 'tscrollx', 10:50:42 INFO - 'cart', 10:50:42 INFO - 'tsvg_static']}, 10:50:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:50:42 INFO - 'talos_options': ['--disable-e10s'], 10:50:42 INFO - 'tests': ['tp5o']}, 10:50:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:50:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:50:42 INFO - 'talos_options': ['--disable-e10s', 10:50:42 INFO - '--xperf_path', 10:50:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:50:42 INFO - 'tests': ['tp5n']}, 10:50:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:50:42 INFO - 'talos_options': ['--xperf_path', 10:50:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:50:42 INFO - 'tests': ['tp5n']}}, 10:50:42 INFO - 'talos.zip': {'path': '', 10:50:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:50:42 INFO - Running post-action listener: _resource_record_post_action 10:50:42 INFO - [mozharness: 2017-04-25 17:50:42.353791Z] Finished populate-webroot step (success) 10:50:42 INFO - [mozharness: 2017-04-25 17:50:42.353910Z] Running create-virtualenv step. 10:50:42 INFO - Running pre-action listener: _resource_record_pre_action 10:50:42 INFO - Running main action method: create_virtualenv 10:50:42 INFO - Creating virtualenv /builds/slave/test/build/venv 10:50:42 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 10:50:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:50:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:50:42 INFO - Using real prefix '/tools/python27' 10:50:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:50:43 INFO - Installing distribute.............................................................................................................................................................................................done. 10:50:46 INFO - Installing pip.................done. 10:50:46 INFO - Return code: 0 10:50:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:50:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:50:46 INFO - Reading from file tmpfile_stdout 10:50:46 INFO - Output received: 10:50:46 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) 10:50:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:50:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:46 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 0x106191b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106194768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc273c74440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f6fd30>, '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 0x105e96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f64be8>, '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.0ms9ScJ8LL/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.iQH9Lirok7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 10:50:46 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 10:50:46 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 10:50:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0ms9ScJ8LL/Render', 10:50:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:46 INFO - 'HOME': '/Users/cltbld', 10:50:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:46 INFO - 'LOGNAME': 'cltbld', 10:50:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:46 INFO - 'MOZ_NO_REMOTE': '1', 10:50:46 INFO - 'NO_EM_RESTART': '1', 10:50:46 INFO - 'PAGER': '/bin/cat', 10:50:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:46 INFO - 'PWD': '/builds/slave/test', 10:50:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:46 INFO - 'SHELL': '/bin/bash', 10:50:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iQH9Lirok7/Listeners', 10:50:46 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 10:50:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:46 INFO - 'USER': 'cltbld', 10:50:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:46 INFO - 'XPC_FLAGS': '0x0', 10:50:46 INFO - 'XPC_SERVICE_NAME': '0', 10:50:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:46 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 10:50:46 INFO - Cleaning up... 10:50:46 INFO - Return code: 0 10:50:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:50:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:46 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 0x106191b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106194768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc273c74440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f6fd30>, '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 0x105e96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f64be8>, '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.0ms9ScJ8LL/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.iQH9Lirok7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 10:50:46 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 10:50:46 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 10:50:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0ms9ScJ8LL/Render', 10:50:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:46 INFO - 'HOME': '/Users/cltbld', 10:50:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:46 INFO - 'LOGNAME': 'cltbld', 10:50:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:46 INFO - 'MOZ_NO_REMOTE': '1', 10:50:46 INFO - 'NO_EM_RESTART': '1', 10:50:46 INFO - 'PAGER': '/bin/cat', 10:50:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:46 INFO - 'PWD': '/builds/slave/test', 10:50:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:46 INFO - 'SHELL': '/bin/bash', 10:50:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iQH9Lirok7/Listeners', 10:50:46 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 10:50:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:46 INFO - 'USER': 'cltbld', 10:50:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:46 INFO - 'XPC_FLAGS': '0x0', 10:50:46 INFO - 'XPC_SERVICE_NAME': '0', 10:50:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:46 INFO - Downloading/unpacking psutil>=3.1.1 10:50:46 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 10:50:46 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 10:50:46 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 10:50:46 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 10:50:46 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 10:50:46 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 10:50:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:50:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:50:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:50:50 INFO - Installing collected packages: psutil 10:50:50 INFO - Running setup.py install for psutil 10:50:50 INFO - building 'psutil._psutil_osx' extension 10:50:50 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 10:50:51 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 10:50:51 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 10:50:51 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 10:50:51 INFO - building 'psutil._psutil_posix' extension 10:50:51 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 10:50:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:50:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:50:51 INFO - ^ 10:50:51 INFO - 1 warning generated. 10:50:51 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 10:50:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:50:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:50:51 INFO - Successfully installed psutil 10:50:51 INFO - Cleaning up... 10:50:51 INFO - Return code: 0 10:50:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:50:51 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')]} 10:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:51 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')]} 10:50:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:51 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 0x106191b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106194768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc273c74440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f6fd30>, '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 0x105e96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f64be8>, '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.0ms9ScJ8LL/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.iQH9Lirok7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 10:50:51 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 10:50:51 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 10:50:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0ms9ScJ8LL/Render', 10:50:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:51 INFO - 'HOME': '/Users/cltbld', 10:50:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:51 INFO - 'LOGNAME': 'cltbld', 10:50:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:51 INFO - 'MOZ_NO_REMOTE': '1', 10:50:51 INFO - 'NO_EM_RESTART': '1', 10:50:51 INFO - 'PAGER': '/bin/cat', 10:50:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:51 INFO - 'PWD': '/builds/slave/test', 10:50:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:51 INFO - 'SHELL': '/bin/bash', 10:50:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iQH9Lirok7/Listeners', 10:50:51 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 10:50:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:51 INFO - 'USER': 'cltbld', 10:50:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:51 INFO - 'XPC_FLAGS': '0x0', 10:50:51 INFO - 'XPC_SERVICE_NAME': '0', 10:50:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:50:52 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 10:50:52 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 10:50:52 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 10:50:52 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 10:50:52 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 10:50:52 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 10:50:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:50:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:50:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:50:54 INFO - Installing collected packages: mozsystemmonitor 10:50:54 INFO - Running setup.py install for mozsystemmonitor 10:50:55 INFO - Successfully installed mozsystemmonitor 10:50:55 INFO - Cleaning up... 10:50:55 INFO - Return code: 0 10:50:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:50:55 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')]} 10:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:55 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')]} 10:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:55 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 0x106191b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106194768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc273c74440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f6fd30>, '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 0x105e96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f64be8>, '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.0ms9ScJ8LL/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.iQH9Lirok7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 10:50:55 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 10:50:55 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 10:50:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0ms9ScJ8LL/Render', 10:50:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:55 INFO - 'HOME': '/Users/cltbld', 10:50:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:55 INFO - 'LOGNAME': 'cltbld', 10:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:55 INFO - 'MOZ_NO_REMOTE': '1', 10:50:55 INFO - 'NO_EM_RESTART': '1', 10:50:55 INFO - 'PAGER': '/bin/cat', 10:50:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:55 INFO - 'PWD': '/builds/slave/test', 10:50:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:55 INFO - 'SHELL': '/bin/bash', 10:50:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iQH9Lirok7/Listeners', 10:50:55 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 10:50:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:55 INFO - 'USER': 'cltbld', 10:50:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:55 INFO - 'XPC_FLAGS': '0x0', 10:50:55 INFO - 'XPC_SERVICE_NAME': '0', 10:50:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:55 INFO - Downloading/unpacking jsonschema==2.5.1 10:50:55 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 10:50:55 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 10:50:55 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 10:50:55 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 10:50:55 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 10:50:55 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 10:50:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:50:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:50:58 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 10:50:58 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 10:50:58 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 10:50:58 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 10:50:58 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 10:50:58 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 10:50:58 INFO - Downloading functools32-3.2.3-2.tar.gz 10:50:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:50:58 INFO - warning: no files found matching '*.txt' 10:50:58 INFO - no previously-included directories found matching 'build' 10:50:58 INFO - no previously-included directories found matching 'dist' 10:50:58 INFO - no previously-included directories found matching '.git*' 10:50:58 INFO - Installing collected packages: jsonschema, functools32 10:50:58 INFO - Running setup.py install for functools32 10:50:58 INFO - warning: no files found matching '*.txt' 10:50:58 INFO - no previously-included directories found matching 'build' 10:50:58 INFO - no previously-included directories found matching 'dist' 10:50:58 INFO - no previously-included directories found matching '.git*' 10:50:58 INFO - Successfully installed jsonschema functools32 10:50:58 INFO - Cleaning up... 10:50:58 INFO - Return code: 0 10:50:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:50:58 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')]} 10:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:58 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')]} 10:50:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:58 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 0x106191b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106194768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc273c74440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f6fd30>, '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 0x105e96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f64be8>, '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.0ms9ScJ8LL/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.iQH9Lirok7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 10:50:58 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 10:50:58 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 10:50:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0ms9ScJ8LL/Render', 10:50:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:58 INFO - 'HOME': '/Users/cltbld', 10:50:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:58 INFO - 'LOGNAME': 'cltbld', 10:50:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:58 INFO - 'MOZ_NO_REMOTE': '1', 10:50:58 INFO - 'NO_EM_RESTART': '1', 10:50:58 INFO - 'PAGER': '/bin/cat', 10:50:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:58 INFO - 'PWD': '/builds/slave/test', 10:50:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:58 INFO - 'SHELL': '/bin/bash', 10:50:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iQH9Lirok7/Listeners', 10:50:58 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 10:50:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:58 INFO - 'USER': 'cltbld', 10:50:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:58 INFO - 'XPC_FLAGS': '0x0', 10:50:58 INFO - 'XPC_SERVICE_NAME': '0', 10:50:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:50:59 INFO - Cleaning up... 10:50:59 INFO - Return code: 0 10:50:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:50: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')]} 10:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50: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')]} 10:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50: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', '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 0x106191b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106194768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc273c74440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f6fd30>, '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 0x105e96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f64be8>, '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.0ms9ScJ8LL/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.iQH9Lirok7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 10:50: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:50: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 blobuploader==1.2.4 10:50:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0ms9ScJ8LL/Render', 10:50:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:59 INFO - 'HOME': '/Users/cltbld', 10:50:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:59 INFO - 'LOGNAME': 'cltbld', 10:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:59 INFO - 'MOZ_NO_REMOTE': '1', 10:50:59 INFO - 'NO_EM_RESTART': '1', 10:50:59 INFO - 'PAGER': '/bin/cat', 10:50:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:59 INFO - 'PWD': '/builds/slave/test', 10:50:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:59 INFO - 'SHELL': '/bin/bash', 10:50:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iQH9Lirok7/Listeners', 10:50:59 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 10:50:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:59 INFO - 'USER': 'cltbld', 10:50:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:59 INFO - 'XPC_FLAGS': '0x0', 10:50:59 INFO - 'XPC_SERVICE_NAME': '0', 10:50:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:59 INFO - Downloading/unpacking blobuploader==1.2.4 10:50:59 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 10:50:59 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 10:50:59 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 10:50:59 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 10:50:59 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 10:50:59 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 10:51:01 INFO - Downloading blobuploader-1.2.4.tar.gz 10:51:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:51:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:51:02 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 10:51:02 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 10:51:02 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 10:51:02 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 10:51:02 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 10:51:02 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 10:51:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:51:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:51:02 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 10:51:02 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 10:51:02 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 10:51:02 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 10:51:02 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 10:51:02 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 10:51:03 INFO - Downloading docopt-0.6.1.tar.gz 10:51:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:51:03 INFO - Installing collected packages: blobuploader, requests, docopt 10:51:03 INFO - Running setup.py install for blobuploader 10:51:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:51:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:51:03 INFO - Running setup.py install for requests 10:51:03 INFO - Running setup.py install for docopt 10:51:04 INFO - Successfully installed blobuploader requests docopt 10:51:04 INFO - Cleaning up... 10:51:04 INFO - Return code: 0 10:51:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51:04 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')]} 10:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:04 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')]} 10:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:04 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 0x106191b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106194768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc273c74440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f6fd30>, '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 0x105e96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f64be8>, '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.0ms9ScJ8LL/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.iQH9Lirok7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 10:51:04 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 10:51:04 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 10:51:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0ms9ScJ8LL/Render', 10:51:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:04 INFO - 'HOME': '/Users/cltbld', 10:51:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:04 INFO - 'LOGNAME': 'cltbld', 10:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:04 INFO - 'MOZ_NO_REMOTE': '1', 10:51:04 INFO - 'NO_EM_RESTART': '1', 10:51:04 INFO - 'PAGER': '/bin/cat', 10:51:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:04 INFO - 'PWD': '/builds/slave/test', 10:51:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:04 INFO - 'SHELL': '/bin/bash', 10:51:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iQH9Lirok7/Listeners', 10:51:04 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 10:51:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:04 INFO - 'USER': 'cltbld', 10:51:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:04 INFO - 'XPC_FLAGS': '0x0', 10:51:04 INFO - 'XPC_SERVICE_NAME': '0', 10:51:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:51:04 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-a2Is_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:51:04 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-cMcb61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:51:04 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-4sMftK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:51:04 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-X8WpfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:51:04 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-PUqMVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:51:04 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-fynZhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:51:05 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-wJjCUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:51:05 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-XJeezO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:51:05 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-4DdnD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:51:05 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-ZYCKqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:51:05 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-vAJNWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:51:05 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Xk9rrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:51:05 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Keyg01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:51:05 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-7aeKjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:05 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-cB4nNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:51:05 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-VUxkav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:51:06 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-aK0WLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:51:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:51:06 INFO - Running setup.py install for manifestparser 10:51:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:51:06 INFO - Running setup.py install for mozcrash 10:51:06 INFO - Running setup.py install for mozdebug 10:51:06 INFO - Running setup.py install for mozdevice 10:51:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:51:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:51:06 INFO - Running setup.py install for mozfile 10:51:06 INFO - Running setup.py install for mozhttpd 10:51:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:51:07 INFO - Running setup.py install for mozinfo 10:51:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:51:07 INFO - Running setup.py install for mozInstall 10:51:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:51:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:51:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:51:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:51:07 INFO - Running setup.py install for mozleak 10:51:07 INFO - Running setup.py install for mozlog 10:51:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:51:07 INFO - Running setup.py install for moznetwork 10:51:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:51:07 INFO - Running setup.py install for mozprocess 10:51:07 INFO - Running setup.py install for mozprofile 10:51:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:51:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:51:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:51:08 INFO - Running setup.py install for mozrunner 10:51:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:51:08 INFO - Running setup.py install for mozscreenshot 10:51:08 INFO - Running setup.py install for moztest 10:51:08 INFO - Running setup.py install for mozversion 10:51:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:51:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:51:08 INFO - Cleaning up... 10:51:08 INFO - Return code: 0 10:51:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:08 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 0x106191b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106194768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc273c74440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f6fd30>, '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 0x105e96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f64be8>, '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.0ms9ScJ8LL/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.iQH9Lirok7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 10:51:08 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 10:51:08 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 10:51:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0ms9ScJ8LL/Render', 10:51:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:08 INFO - 'HOME': '/Users/cltbld', 10:51:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:08 INFO - 'LOGNAME': 'cltbld', 10:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:08 INFO - 'MOZ_NO_REMOTE': '1', 10:51:08 INFO - 'NO_EM_RESTART': '1', 10:51:08 INFO - 'PAGER': '/bin/cat', 10:51:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:08 INFO - 'PWD': '/builds/slave/test', 10:51:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:08 INFO - 'SHELL': '/bin/bash', 10:51:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iQH9Lirok7/Listeners', 10:51:08 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 10:51:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:08 INFO - 'USER': 'cltbld', 10:51:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:08 INFO - 'XPC_FLAGS': '0x0', 10:51:08 INFO - 'XPC_SERVICE_NAME': '0', 10:51:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:51:09 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Ttld8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:51:09 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)) 10:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:51:09 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-r5phn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:51:09 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)) 10:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:51:09 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Aec9LL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:51:09 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)) 10:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:51:09 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-mk61h8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:51:09 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)) 10:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:51:09 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-GJHPTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:51:09 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)) 10:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:51:09 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Fqc_69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:51:09 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)) 10:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:51:09 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-sovbC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:51:09 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)) 10:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:51:09 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-fCNJC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:51:09 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)) 10:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:51:09 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-IsfGPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:51:09 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)) 10:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:51:09 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-FnNaHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:51:10 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)) 10:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:51:10 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-R5whaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:51:10 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)) 10:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:51:10 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-BbyhHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:51:10 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-KQOHlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:51:10 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)) 10:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:51:10 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-12HvO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:51:10 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)) 10:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:10 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-WPAuTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:10 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)) 10:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:51:10 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-GQbQMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:51:10 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)) 10:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:51:10 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-0HN65s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:51:10 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)) 10:51:10 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)) 10:51:10 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)) 10:51:10 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)) 10:51:10 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)) 10:51:10 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)) 10:51:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:13 INFO - Downloading blessings-1.6.tar.gz 10:51:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:51:13 INFO - Installing collected packages: blessings 10:51:13 INFO - Running setup.py install for blessings 10:51:13 INFO - Successfully installed blessings 10:51:13 INFO - Cleaning up... 10:51:13 INFO - Return code: 0 10:51:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:51:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:51:14 INFO - Reading from file tmpfile_stdout 10:51:14 INFO - Current package versions: 10:51:14 INFO - blessings == 1.6 10:51:14 INFO - blobuploader == 1.2.4 10:51:14 INFO - docopt == 0.6.1 10:51:14 INFO - functools32 == 3.2.3-2 10:51:14 INFO - jsonschema == 2.5.1 10:51:14 INFO - manifestparser == 1.1 10:51:14 INFO - mozInstall == 1.12 10:51:14 INFO - mozcrash == 1.0 10:51:14 INFO - mozdebug == 0.1 10:51:14 INFO - mozdevice == 0.49 10:51:14 INFO - mozfile == 1.2 10:51:14 INFO - mozhttpd == 0.7 10:51:14 INFO - mozinfo == 0.9 10:51:14 INFO - mozleak == 0.1 10:51:14 INFO - mozlog == 3.4 10:51:14 INFO - moznetwork == 0.27 10:51:14 INFO - mozprocess == 0.25 10:51:14 INFO - mozprofile == 0.28 10:51:14 INFO - mozrunner == 6.13 10:51:14 INFO - mozscreenshot == 0.1 10:51:14 INFO - mozsystemmonitor == 0.3 10:51:14 INFO - moztest == 0.8 10:51:14 INFO - mozversion == 1.4 10:51:14 INFO - psutil == 3.1.1 10:51:14 INFO - requests == 1.2.3 10:51:14 INFO - wsgiref == 0.1.2 10:51:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:14 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 0x106191b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106194768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc273c74440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f6fd30>, '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 0x105e96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f64be8>, '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.0ms9ScJ8LL/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.iQH9Lirok7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 10:51:14 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 10:51:14 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 10:51:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0ms9ScJ8LL/Render', 10:51:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:14 INFO - 'HOME': '/Users/cltbld', 10:51:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:14 INFO - 'LOGNAME': 'cltbld', 10:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:14 INFO - 'MOZ_NO_REMOTE': '1', 10:51:14 INFO - 'NO_EM_RESTART': '1', 10:51:14 INFO - 'PAGER': '/bin/cat', 10:51:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:14 INFO - 'PWD': '/builds/slave/test', 10:51:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:14 INFO - 'SHELL': '/bin/bash', 10:51:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iQH9Lirok7/Listeners', 10:51:14 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 10:51:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:14 INFO - 'USER': 'cltbld', 10:51:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:14 INFO - 'XPC_FLAGS': '0x0', 10:51:14 INFO - 'XPC_SERVICE_NAME': '0', 10:51:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:14 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)) 10:51:14 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)) 10:51:14 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)) 10:51:14 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)) 10:51:14 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)) 10:51:14 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)) 10:51:14 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)) 10:51:14 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)) 10:51:14 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)) 10:51:14 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)) 10:51:14 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)) 10:51:14 INFO - Cleaning up... 10:51:14 INFO - Return code: 0 10:51:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:14 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 0x106191b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106194768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc273c74440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f6fd30>, '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 0x105e96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f64be8>, '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.0ms9ScJ8LL/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.iQH9Lirok7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 10:51:14 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 10:51:14 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 10:51:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0ms9ScJ8LL/Render', 10:51:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:14 INFO - 'HOME': '/Users/cltbld', 10:51:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:14 INFO - 'LOGNAME': 'cltbld', 10:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:14 INFO - 'MOZ_NO_REMOTE': '1', 10:51:14 INFO - 'NO_EM_RESTART': '1', 10:51:14 INFO - 'PAGER': '/bin/cat', 10:51:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:14 INFO - 'PWD': '/builds/slave/test', 10:51:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:14 INFO - 'SHELL': '/bin/bash', 10:51:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iQH9Lirok7/Listeners', 10:51:14 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 10:51:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:14 INFO - 'USER': 'cltbld', 10:51:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:14 INFO - 'XPC_FLAGS': '0x0', 10:51:14 INFO - 'XPC_SERVICE_NAME': '0', 10:51:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:51:14 INFO - Cleaning up... 10:51:14 INFO - Return code: 0 10:51:14 INFO - Running post-action listener: _resource_record_post_action 10:51:14 INFO - Running post-action listener: _start_resource_monitoring 10:51:14 INFO - Starting resource monitoring. 10:51:14 INFO - [mozharness: 2017-04-25 17:51:14.616641Z] Finished create-virtualenv step (success) 10:51:14 INFO - [mozharness: 2017-04-25 17:51:14.617586Z] Running install step. 10:51:14 INFO - Running pre-action listener: _resource_record_pre_action 10:51:14 INFO - Running main action method: install 10:51:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:51:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:51:14 INFO - Reading from file tmpfile_stdout 10:51:14 INFO - Detecting whether we're running mozinstall >=1.0... 10:51:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:51:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:51:14 INFO - Reading from file tmpfile_stdout 10:51:14 INFO - Output received: 10:51:14 INFO - Usage: mozinstall [options] installer 10:51:14 INFO - Options: 10:51:14 INFO - -h, --help show this help message and exit 10:51:14 INFO - -d DEST, --destination=DEST 10:51:14 INFO - Directory to install application into. [default: 10:51:14 INFO - "/builds/slave/test"] 10:51:14 INFO - --app=APP Application being installed. [default: firefox] 10:51:14 INFO - mkdir: /builds/slave/test/build/application 10:51:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:51:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 10:51:29 INFO - Reading from file tmpfile_stdout 10:51:29 INFO - Output received: 10:51:29 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:51:29 INFO - Running post-action listener: _resource_record_post_action 10:51:29 INFO - [mozharness: 2017-04-25 17:51:29.454375Z] Finished install step (success) 10:51:29 INFO - [mozharness: 2017-04-25 17:51:29.454559Z] Running run-tests step. 10:51:29 INFO - Running pre-action listener: _resource_record_pre_action 10:51:29 INFO - Running main action method: run_tests 10:51:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:51:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:51:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:51:29 INFO - 2017-04-25 10:51:29.469 screenresolution[1645:7547] starting screenresolution argv=screenresolution get 10:51:29 INFO - 2017-04-25 10:51:29.471 screenresolution[1645:7547] Display 0: 1600x1200x32@60 10:51:29 INFO - 2017-04-25 10:51:29.477 screenresolution[1646:7549] starting screenresolution argv=screenresolution list 10:51:29 INFO - Available Modes on Display 0 10:51:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:51:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:51:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:51:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:51:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:51:29 INFO - Intel Iris: 10:51:29 INFO - Chipset Model: Intel Iris 10:51:29 INFO - Type: GPU 10:51:29 INFO - Bus: Built-In 10:51:29 INFO - VRAM (Dynamic, Max): 1536 MB 10:51:29 INFO - Vendor: Intel (0x8086) 10:51:29 INFO - Device ID: 0x0a2e 10:51:29 INFO - Revision ID: 0x0009 10:51:29 INFO - Displays: 10:51:29 INFO - Display: 10:51:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:51:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:51:29 INFO - Display Serial Number: 1600x1200 60 10:51:29 INFO - Main Display: Yes 10:51:29 INFO - Mirror: Off 10:51:29 INFO - Online: Yes 10:51:29 INFO - Rotation: Supported 10:51:29 INFO - Return code: 0 10:51:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:51:29 INFO - Python 2.7.3 10:51:29 INFO - Return code: 0 10:51:29 INFO - grabbing minidump binary from tooltool 10:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:29 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 0x105f6fd30>, '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 0x105e96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f64be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:51:29 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 10:51:29 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 10:51:29 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 10:51:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:51:29 INFO - Return code: 0 10:51:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:51:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:51:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:51:29 INFO - ENV: RUST_BACKTRACE is now 1 10:51:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:51:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:51:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0278', '--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 10:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0278 --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 10:51:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0ms9ScJ8LL/Render', 10:51:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:29 INFO - 'HOME': '/Users/cltbld', 10:51:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:29 INFO - 'LOGNAME': 'cltbld', 10:51:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:51:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:29 INFO - 'MOZ_NO_REMOTE': '1', 10:51:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:51:29 INFO - 'NO_EM_RESTART': '1', 10:51:29 INFO - 'PAGER': '/bin/cat', 10:51:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:29 INFO - 'PWD': '/builds/slave/test', 10:51:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:51:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:29 INFO - 'RUST_BACKTRACE': '1', 10:51:29 INFO - 'SHELL': '/bin/bash', 10:51:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iQH9Lirok7/Listeners', 10:51:29 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 10:51:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:29 INFO - 'USER': 'cltbld', 10:51:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:29 INFO - 'XPC_FLAGS': '0x0', 10:51:29 INFO - 'XPC_SERVICE_NAME': '0', 10:51:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0278', '--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 10:51:30 INFO - mozversion application_buildid: 20170425094824 10:51:30 INFO - mozversion application_changeset: 419d01b08a9ef9d9f8698c73b573eb2ffeeef0c1 10:51:30 INFO - mozversion application_display_name: Firefox 10:51:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:51:30 INFO - mozversion application_name: Firefox 10:51:30 INFO - mozversion application_remotingname: firefox 10:51:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:51:30 INFO - mozversion application_vendor: Mozilla 10:51:30 INFO - mozversion application_version: 54.0 10:51:30 INFO - mozversion platform_buildid: 20170425094824 10:51:30 INFO - mozversion platform_changeset: 419d01b08a9ef9d9f8698c73b573eb2ffeeef0c1 10:51:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:51:30 INFO - mozversion platform_version: 54.0 10:51:30 INFO - using testdate: 1493142690 10:51:30 INFO - actual date: 1493142690 10:51:30 INFO - starting webserver on 'localhost:49246' 10:51:30 INFO - SUITE-START | Running 2 tests 10:51:30 INFO - TEST-START | dromaeo_css 10:51:30 INFO - operating with platform_type : mac_ 10:51:30 INFO - Initialising browser for dromaeo_css test... 10:51:30 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpjFNEjm/profile http://localhost:49246/getInfo.html) 10:51:32 INFO - PROCESS | 1656 | 2017-04-25 10:51:32.841 plugin-container[1659:7712] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c47, name = 'com.apple.tsm.portname' 10:51:32 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:51:32 INFO - PROCESS | 1656 | 2017-04-25 10:51:32.843 plugin-container[1659:7712] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e1b, name = 'com.apple.CFPasteboardClient' 10:51:32 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:51:32 INFO - PROCESS | 1656 | 2017-04-25 10:51:32.843 plugin-container[1659:7712] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:51:32 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 10:51:32 INFO - PROCESS | 1656 | colorDepth:24 10:51:32 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 10:51:32 INFO - PROCESS | 1656 | __metrics 10:51:33 ERROR - PROCESS | 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 10:51:33 INFO - TEST-INFO | 1656: exit 0 10:51:33 INFO - Browser initialized. 10:51:33 INFO - Running cycle 1/1 for dromaeo_css test... 10:51:33 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpjFNEjm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:51:35 INFO - PROCESS | 1660 | 2017-04-25 10:51:35.993 plugin-container[1662:7839] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x433f, name = 'com.apple.tsm.portname' 10:51:35 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:51:35 INFO - PROCESS | 1660 | 2017-04-25 10:51:35.994 plugin-container[1662:7839] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8613, name = 'com.apple.CFPasteboardClient' 10:51:35 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:51:35 INFO - PROCESS | 1660 | 2017-04-25 10:51:35.994 plugin-container[1662:7839] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:51:45 INFO - PROCESS | 1660 | RSS: Main: 174297088 10:51:45 INFO - PROCESS | 1660 | 10:54:48 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 10:54:50 INFO - PROCESS | 1660 | RSS: Main: 189267968 10:54:50 INFO - PROCESS | 1660 | 10:57:52 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 10:57:52 INFO - PROCESS | 1660 | RSS: Main: 198979584 10:57:52 INFO - PROCESS | 1660 | 11:00:54 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 11:00:55 INFO - PROCESS | 1660 | RSS: Main: 204447744 11:00:55 INFO - PROCESS | 1660 | 11:03:57 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 11:03:58 INFO - PROCESS | 1660 | RSS: Main: 208637952 11:03:58 INFO - PROCESS | 1660 | 11:07:00 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 11:07:01 INFO - PROCESS | 1660 | RSS: Main: 211853312 11:07:01 INFO - PROCESS | 1660 | 11:10:03 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 11:10:04 INFO - PROCESS | 1660 | RSS: Main: 207581184 11:10:04 INFO - PROCESS | 1660 | 11:10:04 INFO - PROCESS | 1660 | __start_tp_report 11:10:04 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 11:10:04 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 11:10:04 INFO - PROCESS | 1660 | |i|pagename|runs| 11:10:04 INFO - PROCESS | 1660 | |0;dojo.html;3639.144800971772;3676.8345424455915;3677.8896633101017;3688.7049036077115;3708.777473351599;6204.534659900503;6222.751089956402;6258.593191442553;6261.780837670683;6291.119243305935;6274.654893980829;6277.905831412521;6311.242650881901;6317.147185130006;6323.367663233686;5575.553955683536;5649.4633009864;5670.518005969477;5683.943160568383;5744.569157313197;5709.286339207578;5740;5746.994276001704;5752.856178595527;5765.913511297334;5471.124620060791;5485.0949593317055;5715.71421428929;5719.227904232937;5725.914111288334;5580.079286917674;5587.8603034924045;5608.411116832755;5656;5663.773449062074;5569.637973531708;5648.971755141239;5649.745761440745;5655.123455864347;5747.339056008571;6209.503239740855;6351.98368261076;6357.205349331333;6365.586236894634;6377.394147555975;6375.788600166;6427.87144257117;6514.478841692653;6690.665466726693;6751.054852320679;6658.86682266352;6665.133532640774;6673.599584024974;6726.697298621574;6731.1922569292;6192.566520343623;6392.904106438407;6398.712057957403;6400.711967961406;6413.422791948747;6577.440917521969;6935.4104901082965;6938.895916561256;6957.304269573104;6980.127484064492;6431.260405053479;6459.257185423642;6472.385123413268;6473.708683109177;6616.768413105615;6756.155480564929;6775.864482710417;6788.898166527506;6790.456763458911;6803.4557235422035;6601.53789234749;6633.635150066696;6645;6674.966625166843;6697.464202863759;6347.301796802348;6412.551121421456;6498.220213574401;6593.241777195684;6657.667116644246;5379.112446446371;5427.104527752956;5436.456354364611;5439.456054394529;5444.346678398539;4754.548317909793;4774.259989701602;4791;4796.760161991887;4811.807527698923;6181.041938499539;6252.062190671345;6342.143810585604;6412.5190610704385;6412.9679351602945;6634.701438435282;6643.236027856762;6790.253072162058;6796.25241223465;6813.488988325896;6200.162977998003;6338.619682819046;6359.904601430982;6361.618302901748;6376.107344971708;5840.883182336414;5877.500412464903;5901.557383196277;5909.113632955091;5982.9401705983255;6652.334766523309;6745.763898263537;6958.547694399847;7020.22777494465;7033.226345102137;6662.56693314933;6708.865822683421;6721.294264102395;6734.932650673627;6736.056952026622;5784.334801497714;6659.83452895751;6996.090508233897;7019.6490175492045;7021.789346319414;4931.9753401232765;5255.474452554714;5790.826275211751;6191.4118158774845;6695.564788288746;6548.1814773153355;6606.933930660632;6700.631465269262;6750.3924646782025;6761.154855643044;6582.76960306387;6588.40704336612;6597.4392176663605;6612.867742645217;6615.636140012153;5359.919601205907;5542.916856247079;6477.902831457626;6583.769568065095;6613.941769316886;5175;6109.266887973472;6296.968515157395;6341.619502829845;6377.7130029147875;6592.637404942582;6611.404973552211;6628.204615446178;6633.170853643294;6646.302138275411;6428.774992875227;6434.581752186093;6458.160439142881;6481.902771458526;6485.77299794505 11:10:04 INFO - PROCESS | 1660 | |1;ext.html;748.7304570354671;788.2039140468128;807.5962018990505;994.7811481474082;1002.8245057115007;40489.3926591101;41420.37869431961;42180;42253.577464225345;42354.7882260589;32663.346733065326;38540.61459385405;40154.598454015526;40319.790406287786;40322;8221.383396245275;11375.488103035383;11595.478203480863;11780.293182409083;11793.292402455838;9332.72001839946;11360.943195284011;11387.202895797256;11443.885561144407;11489.138314626394;9521.714348569554;11483.368414737186;11484.310941343547;11516.136289778258;11566.59516916908;9477;11437.942810285937;11446.828297575543;11488.655340339761;11505.539778408895;11165.888341116566;11168.106551475863;11246.662600121928;11249.718757031058;11253.831192532036;35863.4620480693;36093.45859812105;36258.81870590657;36363.63636363629;36415.81792091049;3992.3612222044626;3999.9400008999887;4017.7589344639414;4042.8787136385954;4073.490813648294;26572.867135664197;26670.46659066808;26684.86657566719;27662;28354.716452835415;3174.7137532779593;3214.694604012615;3254.4142054430195;3308.669133086696;3407.6762707542994;340821;343513.28243358625;371401;375007;375541.61145971296;46279.76860115678;46312;46345.30482042772;46350.76824615923;46550;48321.03357932892;48534;48553.27170092452;48564.75717621389;48592;14775.40898364075;14909.254537273093;14911.328990195467;14920.776188357184;14922.626934326512;12598.496060157675;12794.68013299675;12865.871341286655;12891.935540322425;12902.548410805577;11026.834597481044;12347.69130771738;12500.312482813351;12531.624051278477;12579.308138052495;5239.502247286578;5438.075527160392;5772.826815195551;5833.649981001154;5851.32709738377;1049.4385503755454;1129.4014172488594;1172.7947609168532;1200.8198770184542;1216.8053111502118;27950.02174923868;28148;28220.85889570539;28307;28427.57358639622;1283.608499407671;1297.1179597873536;1309.7773378525674;1315.4606611289325;1325.787873940165;14448.638784030483;14545.854541454662;14704.779428308584;14715.92642036783;14789.112653240625;450902.49097509263;453760;453806;453930;454049.7297513557;51360.486395136315;61038;61317;61520.384796152364;61573.07640385398;1472.168224952898;1491.2171110167249;1513.5761986643756;1514.3185566495122;1515.9014664046801;28132.71867281383;28436.43127137487;28895.42209155763;29228.853855730584;29320.827166913085;42705.78647106745;43298.70103896888;43413.7829310864;43423.69728908138;43516.78241608771;421922;493142;494367;494653;494716.5264173656;30170.84914575413;30402.69597304087;30426;30545.098215669477;30618;39285.80357098196;39690.40464392979;40014.59985400225;40069.79965100156;40211.19577608373;27442.17673469799;28270.86916523316;28431.715682842907;28547.000854969978;29324.706752932198;28191.295217619725;28671.283217919718;28742.712572874003;28971.275718107216;29039.274018149714;26711.465770684867;33343.83328083344;33561;33609;33654;28019.159425217276;28622.713772862004;29221.85389073041;29340.413191735617;29362.119136425943;21139.788602114397;22695;23375.298741037797;23375.312343828085;23671.881640591688 11:10:04 INFO - PROCESS | 1660 | |2;jquery.html;407.21204469351807;430.19124046792024;441.2234467337487;446.93388779044625;452.129650422936;19912.303069392576;20759.377218683443;21971.34085977419;22120.88939555302;22173.33479995599;20619.27832525862;22203.6669449958;23140.65289020666;23334.88332558335;23462.530749385;6887.965560172192;6930.792076237721;7167.4982751207435;7192.460565457585;7196.316349946746;6912.3778859902595;7076.292370762934;7097.290270972913;7102.325279098477;7104.78685639429;6799.456043516531;7012.474064445161;7016.087908571904;7082.114735658043;7093.609851458168;6613.206415230203;6797.456203503708;7007.4394048476;7045.542039767399;7086.9999999999745;6856;6856.382925536675;6857.759978400782;6863.210730765976;6865.656717164172;26632.467350652878;26783;26970.921163153645;27199.1840244793;27334.726652733418;2910.3160757222035;3053.4656435123766;3071.7696172786905;3076.7846250762454;3082.969170308291;15711.292991815282;16010.279537420727;16276.267567959352;16665.33338666452;16722.498325050146;1856.016311354984;2042;2048.109072553444;2080.0847627044054;2162.9783702162936;131569;137000;160408;165444;168416;16779.328826846788;20284.898575507028;21430.785692143192;21440.463988400104;21601.135954561643;32383.352332953207;32453.51319730159;32538.67461325404;33091.83454082714;33137;10815.783684326427;10843.67468975932;11070;11079.50142243601;11180.329180249048;8579.270761985177;8750.431221970552;9232.307576931757;9261.536923153815;9426.952865235768;7743.7676869694;7895.802604934923;7931.484453510503;7954.681812727542;9783.46190959504;3976.2445135424177;4039.7576145431367;4058.3100872851096;4072.552019277877;4082.897927551835;875.4134729731095;970.8058388322364;987.5704068730125;1007.8057501860319;1021.8313978193515;22345.55308893813;23318.65022024671;23750.287491375286;24855.378615534755;24917.875410623194;960.2858896869055;961.2502248246379;979.7354714227118;991.504247876062;997.1374760831973;7237.89143162853;7242.855142897112;7324.743633972786;7360.263973602704;7473.85052298951;794490;797042;802356;803712;804234;152519;160759;172578;179347;186385.06807465875;1293.5084667826166;1395.0931894268604;1459.7956286119738;1487.2712370938161;1495.9476418325307;19495.415137545897;20785.792142078386;20848;21343.35969920905;21429.78570214278;55933.16100258418;59305.517362064566;61537;62227.37772622397;62520;82386;88928.5553572228;93992;96313;97154;9593.616255349987;11757.882421175678;11884.465199066235;12138.817917731418;12161.635150945485;13314.800277995644;13375.264360460269;13653.931730341284;13695.246761428218;13767.724645506833;11445;11525.769484610428;11563.768724625628;11751.236169649288;11936.52253909834;10598.417087060287;10625.25623206368;10815;10992.780144396907;11044.502997364978;11672.358020308964;11686.415679216176;11867.347295898808;11918.404079795802;12046.879531204575;11575.710607234887;11609.941950290195;11866.881331186578;11938.28370297785;12102.515899363927;9086.681966131153;11131.499082541142;11486.483108260316;11575.189736718348;11614.419279035845 11:10:04 INFO - PROCESS | 1660 | |3;mootools.html;1410.8800751936087;1592.609810596404;1647.0858673436246;1651.5045486354095;1658.204062050216;11034.062104721099;11721.941390293046;11748.941255293712;11862;12181.269123852575;11529.020033297158;11694.766104677923;11740.471678774455;11755.35345555994;11780.234284771484;1957.3149397710795;2023.9898800505978;2512.8115391345723;2516.8238223324374;2520.3825062859623;2432.2946345559853;2490.987545062272;2499.0003998400693;2500.099964012954;2511.108556462457;2371.4782747795457;2384.8092152627837;2396;2486.477839653666;2506.5112303100905;2432.525657496789;2480.2931164618;2498.1880888711153;2506.5738824399805;2509.9372515687164;2456.636566705478;2462.212092130519;2468.8148388870904;2470.6911636045493;2473.319837044809;11386.373749443777;11463.140264480196;11597;11603.07175425964;11618.941905290503;5937.228160339128;6062.181605483247;6098.756049758004;6135.601185922946;6155.353687862755;3044.4367791958557;3605.4772058051435;3631.182983828644;3655.3603119454256;3710.573284072312;950.6672664567416;1052.6736711619421;1109.2290857853795;1245.2404033539624;1255.2656695832948;12926.87073129266;14127.858721412756;14377.353019114165;15295.847041529665;15967;4850.854474365704;4951.034548263126;4968.1554135797005;4969;4970.453250142481;12128.696782580506;12280.692982675326;12291.446884890202;12294.692632684255;12299.93850030762;5949.851253718605;6093.177421048102;6115.755369785159;6137.324894261627;6139.2325959255095;5546.223528705985;5637.577181711388;5642;5648.265725455747;5663.575231857627;3949.2891279569953;4072;4103.4460347853255;4120.17596480705;4130.256553820341;1082.2694681090234;1085.4084523934475;1087.2932593814085;1095.8575385199872;1098.1215027977587;981.6466072213997;997.1075887081022;1004.6684594083935;1012.2458768217725;1015.7912084619279;5705.62913410627;6624.205095388488;6723.697433615401;6774.119364482684;6906.412954898889;940.9529523523796;1013.2299452416216;1019.1286450085071;1063.739383850946;1065.350136416785;4162.812673429703;4291.592298731615;4294.162638285567;4399.790057734149;4441;13607.115537490032;14176.93672974531;14204.786928196085;14207.36066876993;14220.217888016052;13914.51299204523;14043.648908777363;14058.789118163235;14089.577312680636;14132;10529.315594486487;10610.045095941403;10655.680329590125;10685.198610104273;10688.625898093529;6656.800295991128;6687.76592819249;6753.3246675332075;6846.281140480178;6905.965470172818;12466.812997804858;12473.376331183223;12677.985761138902;12692.873071269538;13203.735925281633;11545.422728863692;11658.591949282074;11927.880721192678;12880.549180778627;13395.330233488092;7746.8450630985935;9567.665131720356;9568.569414376509;9575.329726919048;9605.991370906233;10359.015893490106;10460.790784184426;10548.156147508334;10562.471876405994;10608.893911061099;8947.19475247231;9021.413608115452;9078.818423631623;9136.84419516548;9168.266538677024;7295.598742069237;8763.474191548528;8814.33892458081;8858.291336693179;8936;8162.755117346489;8182.345412367115;8192.18078192176;8221.630026648696;8232.259096681328;4902.436219834764;5196.038732834438;5375.247465354775;5923.437273459014;6248.531360148098;6089.812486565077;6101.5118790497545;6130.540209484396;6212.06818977157;6217.813465596039 11:10:04 INFO - PROCESS | 1660 | |4;prototype.html;395.3259692224757;400.4833764443867;400.5453809925733;400.9258287216865;406.4431728531912;4135.979320103403;4880.194328098604;5126.743662816853;5133.537981581657;5334.679919204846;4907.82822601209;5089.338386009823;5190.922136167951;5192.974035129819;5277.577793776498;3341.6157141928747;3652.6347365263396;4086.7522862425694;4148.481439820022;4189.245935731567;3408.2788191963023;3545.6421479716087;4036.535798383194;4119.940029985008;4138.441310423084;3528.231754085779;3784.6215378462207;3992.6207010333974;4101.011009660312;4115.218108559379;3553.502509648651;4025.6376926076646;4047.5345335286524;4073.1446396256674;4110.630043296118;3638.872639457633;3652.2878038782446;3662.7436079474446;3668.5414323209598;3699.6485333893506;4861.489543597907;4908.361912951329;5132.999065182291;5142.97428512855;5144.533807864741;4058.7767672777986;4172.833086676529;4290.884370063774;4332.870013899588;4745;4859.878503037417;5460.198134615567;5592.238444889887;5599.124293361729;5612.466815652507;3703.8333275002688;3837.4627552142724;4131.648809851136;4172.812223449952;4192.81132349045;4386.978065109686;4848.5151484851585;5025.623078269145;5632.971835140839;5910.399424253358;3312.635610082889;3396.966030339665;3697.6302369762807;4016.6385025347276;4164.541900390955;3841.8079096045644;4185.437872718751;4253.8723838284905;4275.593818587229;4283.657307415399;4132.938005929914;4321.891952701145;4338.230153895312;4408.448943882015;4802.27965805132;4708.788104535236;5540.672917374713;5573.7213139343685;5653.886922261532;5700.178411686159;1543.915084670354;1591.9015879043423;1737.557827003584;1764.7088230441834;1782.7147656375178;1246.2397937258265;1265.5191027409526;1280.2972047177232;1301.576987479073;1409.429181181623;4717.575418212377;4921.753912304371;5089.720065396365;5227.294315267466;5277.287566178594;5168.612354073384;5719.571032172604;5785;5845.678487683133;5893.793717219876;4834.863807005351;4882.072406242803;5264.894702105937;5278.841634750964;5291.761870715827;2623.370391106159;2773.8751756171023;2906.454125966318;2958.45268625305;2999.5950546676354;5253.1632918224495;5523.972380138154;5668.858278542987;5728.885422291531;6077.270727512727;4624.421947256593;5312.442193569696;5741.311042674905;5791.160281759206;5921.4670679638175;5088.92366614501;5798.9420105799245;5956.047032474783;6018.42824931622;6104.847378815565;5199.63602547818;5744.224529688438;5770;5782.7686892523825;5813.628095704396;4868.440129385024;5026.195808670595;5107.540321371094;5246.496602539562;5719.456651618089;5137.023965446553;5936.951751645848;6034.409526331826;6077.908831367621;6084.513238940963;4872.780724867319;4892.3884514435695;4895.4370247422;4925.581325587222;4948.505149485023;4886;5009.899802003866;5259.658122222043;5788.102844059177;5808;5037.899242015213;5515.751791169488;5568.777248909998;5576.665400076008;5576.832695019156;4522.773861306987;5558.805441809517;5611.91344760372;5615.8876822464135;5704.60067795267;5167;5250.317458730341;5406.675599464044;5452.591055670761;5463.207834864002;4617;5574.348801535001;5580.330360356783;5598.712296171985;5615.775368985358;4863.367762190893;5111.386633603991;5439.9456005441025;5466.316710411199;5523.143912693539 11:10:04 INFO - PROCESS | 1660 | |5;yui.html;646.7380710812123;709.8367375503634;757.5189754505888;788.8304014636852;822.8518866604011;13651.249181295025;13707.862921370783;16033.999999999985;16103;17376.826231737694;15774.447894323672;16144.273507692153;16250.18749062545;16321.428749993753;16336.34654613814;1004.2919741582203;1028.4703377760459;1029.3617956866754;1029.67050543826;1030.5105075089348;992.7617371830745;1024.4365598920601;1040.9167266618651;1048.444324508012;1051.363924825481;1068.0601071057458;1082.8592283003238;1085.3054045410943;1086.2667699302979;1086.538221255967;1056.572088304238;1079.2175672637354;1079.913606911449;1081.6268387406333;1083.6478144602995;805.7703554487001;806.1615919443772;806.2018601584389;808.3250485844327;809.6963638635511;16950.23723932426;17313.913430432895;17463.825361746472;17987.010714410702;18007.0096144712;14403.639909002359;14550.417983280657;14551.126932383984;14751;14783;12044.81932771009;12083.275003499819;12200.450979705935;12237.816432753516;12309.507619695201;3610.422332426799;3832.6742226910746;3886.9805650971566;3906.8437262509465;4076.7961601919787;117397.2390414153;123632;126321.10518342232;127274.3636281822;127841.36079319636;11437.428128593538;11444.771104578029;11676.532938682527;11749.647510574696;11783.410829458493;23976.64035039476;24286.878565607058;24295.0281988722;24337;24379.390515236908;8258.174182581693;8266.628001739937;8274.255317021498;8278.172182781795;8386.916130838736;3505;4482.843100491467;4525.615322697542;4594.632429405639;4646.372739680168;3663.5603727552866;3761.4169803679924;3762.078290818767;3764.6235376462137;3768.7361884668358;530.4668807848088;653.2422390027546;662.3277373465936;663.1114306828872;663.9402453779184;703.8672821351314;714.3463730686364;721.9133703955454;738.6343759838915;743.8177646476539;10619.94690026545;10640.201984851166;10781.299215550964;10813.62152324665;10851.294665846852;616.6649204472267;696.9512134150663;750.4259241680119;754.4756394305905;757.3978686943893;5021.4978502150225;5176.7152806596;5186.688798672092;5200.193969934666;5241.50205730455;109132.90867091228;111461;112679;114169.4291528537;116491.41754291343;81395.96510087296;95512.56731149038;97878.51060744793;99868.50065749625;103448.48275758573;74772.87840682395;76921.23078769252;77570;78299.60850195713;78661.60669196617;10076.496175191358;11059.170562207706;11204.775904482029;11471.024962877915;11524.193306468467;42724.35913461239;43010.35484467673;46314.76842615765;49790.50209497858;51002.23496647479;61073;65039;67133;68125;70148.29851701621;12807.679808004874;13118.212907225598;13455.259960702255;13634;13707.451701931812;14298.57104286873;14964.476243331432;15185.240737962837;15219.847801521842;15956.281967311732;13075.738485230433;13924.303784810922;14430;14554.708905822035;15072.376959169236;13704;13979.93010034984;14269.714605708035;14270.143791372551;14340.282985850874;13658.931705341807;13959.162450252612;14174.645633859236;14205.644858878612;14613.488527901472;10176.592936282466;10247.590096396061;10388.688339349832;10402.063814256753;10744.30162039465;11472.655820325404;11499;11595.362255075714;11717.531298747954;11727.296362218294 11:10:04 INFO - PROCESS | 1660 | __end_tp_report 11:10:04 INFO - PROCESS | 1660 | __start_cc_report 11:10:04 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,387 11:10:04 INFO - PROCESS | 1660 | __end_cc_report 11:10:04 INFO - PROCESS | 1660 | __startTimestamp1493143804196__endTimestamp 11:10:04 INFO - PROCESS | 1660 | 11:10:04 INFO - PROCESS | 1660 | ------- Summary: start ------- 11:10:04 INFO - PROCESS | 1660 | Number of tests: 6 11:10:04 INFO - PROCESS | 1660 | 11:10:04 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:6177.57 Median:6377.71 stddev:687.56 (10.8%) stddev-sans-first:660.20 11:10:04 INFO - PROCESS | 1660 | Values: 3639.1 3676.8 3677.9 3688.7 3708.8 6204.5 6222.8 6258.6 6261.8 6291.1 6274.7 6277.9 6311.2 6317.1 6323.4 5575.6 5649.5 5670.5 5683.9 5744.6 5709.3 5740.0 5747.0 5752.9 5765.9 5471.1 5485.1 5715.7 5719.2 5725.9 5580.1 5587.9 5608.4 5656.0 5663.8 5569.6 5649.0 5649.7 5655.1 5747.3 6209.5 6352.0 6357.2 6365.6 6377.4 6375.8 6427.9 6514.5 6690.7 6751.1 6658.9 6665.1 6673.6 6726.7 6731.2 6192.6 6392.9 6398.7 6400.7 6413.4 6577.4 6935.4 6938.9 6957.3 6980.1 6431.3 6459.3 6472.4 6473.7 6616.8 6756.2 6775.9 6788.9 6790.5 6803.5 6601.5 6633.6 6645.0 6675.0 6697.5 6347.3 6412.6 6498.2 6593.2 6657.7 5379.1 5427.1 5436.5 5439.5 5444.3 4754.5 4774.3 4791.0 4796.8 4811.8 6181.0 6252.1 6342.1 6412.5 6413.0 6634.7 6643.2 6790.3 6796.3 6813.5 6200.2 6338.6 6359.9 6361.6 6376.1 5840.9 5877.5 5901.6 5909.1 5982.9 6652.3 6745.8 6958.5 7020.2 7033.2 6662.6 6708.9 6721.3 6734.9 6736.1 5784.3 6659.8 6996.1 7019.6 7021.8 4932.0 5255.5 5790.8 6191.4 6695.6 6548.2 6606.9 6700.6 6750.4 6761.2 6582.8 6588.4 6597.4 6612.9 6615.6 5359.9 5542.9 6477.9 6583.8 6613.9 5175.0 6109.3 6297.0 6341.6 6377.7 6592.6 6611.4 6628.2 6633.2 6646.3 6428.8 6434.6 6458.2 6481.9 6485.8 11:10:04 INFO - PROCESS | 1660 | 11:10:04 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:56426.81 Median:29332.56 stddev:115478.76 (393.7%) stddev-sans-first:115727.05 11:10:04 INFO - PROCESS | 1660 | Values: 748.7 788.2 807.6 994.8 1002.8 40489.4 41420.4 42180.0 42253.6 42354.8 32663.3 38540.6 40154.6 40319.8 40322.0 8221.4 11375.5 11595.5 11780.3 11793.3 9332.7 11360.9 11387.2 11443.9 11489.1 9521.7 11483.4 11484.3 11516.1 11566.6 9477.0 11437.9 11446.8 11488.7 11505.5 11165.9 11168.1 11246.7 11249.7 11253.8 35863.5 36093.5 36258.8 36363.6 36415.8 3992.4 3999.9 4017.8 4042.9 4073.5 26572.9 26670.5 26684.9 27662.0 28354.7 3174.7 3214.7 3254.4 3308.7 3407.7 340821.0 343513.3 371401.0 375007.0 375541.6 46279.8 46312.0 46345.3 46350.8 46550.0 48321.0 48534.0 48553.3 48564.8 48592.0 14775.4 14909.3 14911.3 14920.8 14922.6 12598.5 12794.7 12865.9 12891.9 12902.5 11026.8 12347.7 12500.3 12531.6 12579.3 5239.5 5438.1 5772.8 5833.6 5851.3 1049.4 1129.4 1172.8 1200.8 1216.8 27950.0 28148.0 28220.9 28307.0 28427.6 1283.6 1297.1 1309.8 1315.5 1325.8 14448.6 14545.9 14704.8 14715.9 14789.1 450902.5 453760.0 453806.0 453930.0 454049.7 51360.5 61038.0 61317.0 61520.4 61573.1 1472.2 1491.2 1513.6 1514.3 1515.9 28132.7 28436.4 28895.4 29228.9 29320.8 42705.8 43298.7 43413.8 43423.7 43516.8 421922.0 493142.0 494367.0 494653.0 494716.5 30170.8 30402.7 30426.0 30545.1 30618.0 39285.8 39690.4 40014.6 40069.8 40211.2 27442.2 28270.9 28431.7 28547.0 29324.7 28191.3 28671.3 28742.7 28971.3 29039.3 26711.5 33343.8 33561.0 33609.0 33654.0 28019.2 28622.7 29221.9 29340.4 29362.1 21139.8 22695.0 23375.3 23375.3 23671.9 11:10:04 INFO - PROCESS | 1660 | 11:10:04 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:45161.10 Median:26707.73 stddev:133492.26 (499.8%) stddev-sans-first:133824.44 11:10:04 INFO - PROCESS | 1660 | Values: 407.2 430.2 441.2 446.9 452.1 19912.3 20759.4 21971.3 22120.9 22173.3 20619.3 22203.7 23140.7 23334.9 23462.5 6888.0 6930.8 7167.5 7192.5 7196.3 6912.4 7076.3 7097.3 7102.3 7104.8 6799.5 7012.5 7016.1 7082.1 7093.6 6613.2 6797.5 7007.4 7045.5 7087.0 6856.0 6856.4 6857.8 6863.2 6865.7 26632.5 26783.0 26970.9 27199.2 27334.7 2910.3 3053.5 3071.8 3076.8 3083.0 15711.3 16010.3 16276.3 16665.3 16722.5 1856.0 2042.0 2048.1 2080.1 2163.0 131569.0 137000.0 160408.0 165444.0 168416.0 16779.3 20284.9 21430.8 21440.5 21601.1 32383.4 32453.5 32538.7 33091.8 33137.0 10815.8 10843.7 11070.0 11079.5 11180.3 8579.3 8750.4 9232.3 9261.5 9427.0 7743.8 7895.8 7931.5 7954.7 9783.5 3976.2 4039.8 4058.3 4072.6 4082.9 875.4 970.8 987.6 1007.8 1021.8 22345.6 23318.7 23750.3 24855.4 24917.9 960.3 961.3 979.7 991.5 997.1 7237.9 7242.9 7324.7 7360.3 7473.9 794490.0 797042.0 802356.0 803712.0 804234.0 152519.0 160759.0 172578.0 179347.0 186385.1 1293.5 1395.1 1459.8 1487.3 1495.9 19495.4 20785.8 20848.0 21343.4 21429.8 55933.2 59305.5 61537.0 62227.4 62520.0 82386.0 88928.6 93992.0 96313.0 97154.0 9593.6 11757.9 11884.5 12138.8 12161.6 13314.8 13375.3 13653.9 13695.2 13767.7 11445.0 11525.8 11563.8 11751.2 11936.5 10598.4 10625.3 10815.0 10992.8 11044.5 11672.4 11686.4 11867.3 11918.4 12046.9 11575.7 11609.9 11866.9 11938.3 12102.5 9086.7 11131.5 11486.5 11575.2 11614.4 11:10:04 INFO - PROCESS | 1660 | 11:10:04 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:6907.44 Median:2494.59 stddev:4308.76 (172.7%) stddev-sans-first:4301.05 11:10:04 INFO - PROCESS | 1660 | Values: 1410.9 1592.6 1647.1 1651.5 1658.2 11034.1 11721.9 11748.9 11862.0 12181.3 11529.0 11694.8 11740.5 11755.4 11780.2 1957.3 2024.0 2512.8 2516.8 2520.4 2432.3 2491.0 2499.0 2500.1 2511.1 2371.5 2384.8 2396.0 2486.5 2506.5 2432.5 2480.3 2498.2 2506.6 2509.9 2456.6 2462.2 2468.8 2470.7 2473.3 11386.4 11463.1 11597.0 11603.1 11618.9 5937.2 6062.2 6098.8 6135.6 6155.4 3044.4 3605.5 3631.2 3655.4 3710.6 950.7 1052.7 1109.2 1245.2 1255.3 12926.9 14127.9 14377.4 15295.8 15967.0 4850.9 4951.0 4968.2 4969.0 4970.5 12128.7 12280.7 12291.4 12294.7 12299.9 5949.9 6093.2 6115.8 6137.3 6139.2 5546.2 5637.6 5642.0 5648.3 5663.6 3949.3 4072.0 4103.4 4120.2 4130.3 1082.3 1085.4 1087.3 1095.9 1098.1 981.6 997.1 1004.7 1012.2 1015.8 5705.6 6624.2 6723.7 6774.1 6906.4 941.0 1013.2 1019.1 1063.7 1065.4 4162.8 4291.6 4294.2 4399.8 4441.0 13607.1 14176.9 14204.8 14207.4 14220.2 13914.5 14043.6 14058.8 14089.6 14132.0 10529.3 10610.0 10655.7 10685.2 10688.6 6656.8 6687.8 6753.3 6846.3 6906.0 12466.8 12473.4 12678.0 12692.9 13203.7 11545.4 11658.6 11927.9 12880.5 13395.3 7746.8 9567.7 9568.6 9575.3 9606.0 10359.0 10460.8 10548.2 10562.5 10608.9 8947.2 9021.4 9078.8 9136.8 9168.3 7295.6 8763.5 8814.3 8858.3 8936.0 8162.8 8182.3 8192.2 8221.6 8232.3 4902.4 5196.0 5375.2 5923.4 6248.5 6089.8 6101.5 6130.5 6212.1 6217.8 11:10:04 INFO - PROCESS | 1660 | 11:10:04 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:4551.18 Median:4915.06 stddev:1305.60 (26.6%) stddev-sans-first:1271.45 11:10:04 INFO - PROCESS | 1660 | Values: 395.3 400.5 400.5 400.9 406.4 4136.0 4880.2 5126.7 5133.5 5334.7 4907.8 5089.3 5190.9 5193.0 5277.6 3341.6 3652.6 4086.8 4148.5 4189.2 3408.3 3545.6 4036.5 4119.9 4138.4 3528.2 3784.6 3992.6 4101.0 4115.2 3553.5 4025.6 4047.5 4073.1 4110.6 3638.9 3652.3 3662.7 3668.5 3699.6 4861.5 4908.4 5133.0 5143.0 5144.5 4058.8 4172.8 4290.9 4332.9 4745.0 4859.9 5460.2 5592.2 5599.1 5612.5 3703.8 3837.5 4131.6 4172.8 4192.8 4387.0 4848.5 5025.6 5633.0 5910.4 3312.6 3397.0 3697.6 4016.6 4164.5 3841.8 4185.4 4253.9 4275.6 4283.7 4132.9 4321.9 4338.2 4408.4 4802.3 4708.8 5540.7 5573.7 5653.9 5700.2 1543.9 1591.9 1737.6 1764.7 1782.7 1246.2 1265.5 1280.3 1301.6 1409.4 4717.6 4921.8 5089.7 5227.3 5277.3 5168.6 5719.6 5785.0 5845.7 5893.8 4834.9 4882.1 5264.9 5278.8 5291.8 2623.4 2773.9 2906.5 2958.5 2999.6 5253.2 5524.0 5668.9 5728.9 6077.3 4624.4 5312.4 5741.3 5791.2 5921.5 5088.9 5798.9 5956.0 6018.4 6104.8 5199.6 5744.2 5770.0 5782.8 5813.6 4868.4 5026.2 5107.5 5246.5 5719.5 5137.0 5937.0 6034.4 6077.9 6084.5 4872.8 4892.4 4895.4 4925.6 4948.5 4886.0 5009.9 5259.7 5788.1 5808.0 5037.9 5515.8 5568.8 5576.7 5576.8 4522.8 5558.8 5611.9 5615.9 5704.6 5167.0 5250.3 5406.7 5452.6 5463.2 4617.0 5574.3 5580.3 5598.7 5615.8 4863.4 5111.4 5439.9 5466.3 5523.1 11:10:04 INFO - PROCESS | 1660 | 11:10:04 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:21742.61 Median:15497.15 stddev:31934.59 (206.1%) stddev-sans-first:31984.89 11:10:04 INFO - PROCESS | 1660 | Values: 646.7 709.8 757.5 788.8 822.9 13651.2 13707.9 16034.0 16103.0 17376.8 15774.4 16144.3 16250.2 16321.4 16336.3 1004.3 1028.5 1029.4 1029.7 1030.5 992.8 1024.4 1040.9 1048.4 1051.4 1068.1 1082.9 1085.3 1086.3 1086.5 1056.6 1079.2 1079.9 1081.6 1083.6 805.8 806.2 806.2 808.3 809.7 16950.2 17313.9 17463.8 17987.0 18007.0 14403.6 14550.4 14551.1 14751.0 14783.0 12044.8 12083.3 12200.5 12237.8 12309.5 3610.4 3832.7 3887.0 3906.8 4076.8 117397.2 123632.0 126321.1 127274.4 127841.4 11437.4 11444.8 11676.5 11749.6 11783.4 23976.6 24286.9 24295.0 24337.0 24379.4 8258.2 8266.6 8274.3 8278.2 8386.9 3505.0 4482.8 4525.6 4594.6 4646.4 3663.6 3761.4 3762.1 3764.6 3768.7 530.5 653.2 662.3 663.1 663.9 703.9 714.3 721.9 738.6 743.8 10619.9 10640.2 10781.3 10813.6 10851.3 616.7 697.0 750.4 754.5 757.4 5021.5 5176.7 5186.7 5200.2 5241.5 109132.9 111461.0 112679.0 114169.4 116491.4 81396.0 95512.6 97878.5 99868.5 103448.5 74772.9 76921.2 77570.0 78299.6 78661.6 10076.5 11059.2 11204.8 11471.0 11524.2 42724.4 43010.4 46314.8 49790.5 51002.2 61073.0 65039.0 67133.0 68125.0 70148.3 12807.7 13118.2 13455.3 13634.0 13707.5 14298.6 14964.5 15185.2 15219.8 15956.3 13075.7 13924.3 14430.0 14554.7 15072.4 13704.0 13979.9 14269.7 14270.1 14340.3 13658.9 13959.2 14174.6 14205.6 14613.5 10176.6 10247.6 10388.7 10402.1 10744.3 11472.7 11499.0 11595.4 11717.5 11727.3 11:10:04 INFO - PROCESS | 1660 | -------- Summary: end -------- 11:10:04 INFO - PROCESS | 1660 | 11:10:04 INFO - TEST-INFO | 1660: exit 0 11:10:04 INFO - TEST-OK | dromaeo_css | took 1114678ms 11:10:04 INFO - TEST-START | kraken 11:10:04 INFO - operating with platform_type : mac_ 11:10:04 INFO - Initialising browser for kraken test... 11:10:04 INFO - TEST-INFO | started process 1780 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpMYY2rB/profile http://localhost:49246/getInfo.html) 11:10:07 INFO - PROCESS | 1780 | 2017-04-25 11:10:07.277 plugin-container[1783:10396] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x874b, name = 'com.apple.tsm.portname' 11:10:07 INFO - PROCESS | 1780 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:10:07 INFO - PROCESS | 1780 | 2017-04-25 11:10:07.277 plugin-container[1783:10396] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x420f, name = 'com.apple.CFPasteboardClient' 11:10:07 INFO - PROCESS | 1780 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:10:07 INFO - PROCESS | 1780 | 2017-04-25 11:10:07.277 plugin-container[1783:10396] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:10:07 INFO - PROCESS | 1780 | __metrics Screen width/height:1600/1200 11:10:07 INFO - PROCESS | 1780 | colorDepth:24 11:10:07 INFO - PROCESS | 1780 | Browser inner width/height: 1024/689 11:10:07 INFO - PROCESS | 1780 | __metrics 11:10:07 ERROR - PROCESS | 1780 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 11:10:08 INFO - TEST-INFO | 1780: exit 0 11:10:08 INFO - Browser initialized. 11:10:08 INFO - Running cycle 1/1 for kraken test... 11:10:08 INFO - TEST-INFO | started process 1784 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpMYY2rB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:10:10 INFO - PROCESS | 1784 | 2017-04-25 11:10:10.207 plugin-container[1785:10515] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8443, name = 'com.apple.tsm.portname' 11:10:10 INFO - PROCESS | 1784 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:10:10 INFO - PROCESS | 1784 | 2017-04-25 11:10:10.208 plugin-container[1785:10515] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4223, name = 'com.apple.CFPasteboardClient' 11:10:10 INFO - PROCESS | 1784 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:10:10 INFO - PROCESS | 1784 | 2017-04-25 11:10:10.208 plugin-container[1785:10515] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:10:20 INFO - PROCESS | 1784 | RSS: Main: 174718976 11:10:20 INFO - PROCESS | 1784 | 11:10:22 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 11:10:23 INFO - PROCESS | 1784 | RSS: Main: 188260352 11:10:23 INFO - PROCESS | 1784 | 11:10:26 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 11:10:26 INFO - PROCESS | 1784 | RSS: Main: 196333568 11:10:26 INFO - PROCESS | 1784 | 11:10:30 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 11:10:30 INFO - PROCESS | 1784 | RSS: Main: 200019968 11:10:30 INFO - PROCESS | 1784 | 11:10:32 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 11:10:33 INFO - PROCESS | 1784 | RSS: Main: 201646080 11:10:33 INFO - PROCESS | 1784 | 11:10:35 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:10:35 INFO - PROCESS | 1784 | RSS: Main: 201494528 11:10:35 INFO - PROCESS | 1784 | 11:10:39 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 11:10:39 INFO - PROCESS | 1784 | RSS: Main: 205381632 11:10:39 INFO - PROCESS | 1784 | 11:10:42 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 11:10:43 INFO - PROCESS | 1784 | RSS: Main: 206307328 11:10:43 INFO - PROCESS | 1784 | 11:10:46 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 11:10:46 INFO - PROCESS | 1784 | RSS: Main: 206061568 11:10:46 INFO - PROCESS | 1784 | 11:10:48 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:10:49 INFO - PROCESS | 1784 | RSS: Main: 205336576 11:10:49 INFO - PROCESS | 1784 | 11:10:50 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:10:51 INFO - PROCESS | 1784 | RSS: Main: 205381632 11:10:51 INFO - PROCESS | 1784 | 11:10:53 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:10:54 INFO - PROCESS | 1784 | RSS: Main: 205348864 11:10:54 INFO - PROCESS | 1784 | 11:10:57 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:10:57 INFO - PROCESS | 1784 | RSS: Main: 205410304 11:10:57 INFO - PROCESS | 1784 | 11:11:00 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:11:01 INFO - PROCESS | 1784 | RSS: Main: 205795328 11:11:01 INFO - PROCESS | 1784 | 11:11:03 INFO - PROCESS | 1784 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 11:11:03 INFO - PROCESS | 1784 | RSS: Main: 207769600 11:11:03 INFO - PROCESS | 1784 | 11:11:03 INFO - PROCESS | 1784 | __start_tp_report 11:11:03 INFO - PROCESS | 1784 | _x_x_mozilla_page_load 11:11:03 INFO - PROCESS | 1784 | _x_x_mozilla_page_load_details 11:11:03 INFO - PROCESS | 1784 | |i|pagename|runs| 11:11:03 INFO - PROCESS | 1784 | |0;ai-astar;109;120;118;117;124;119;118;120;120;118 11:11:03 INFO - PROCESS | 1784 | |1;audio-beat-detection;140;132;96;170;143;145;113;112;126;109 11:11:03 INFO - PROCESS | 1784 | |2;audio-dft;191;198;191;197;192;199;195;195;198;196 11:11:03 INFO - PROCESS | 1784 | |3;audio-fft;94;87;51;81;69;78;85;51;85;85 11:11:03 INFO - PROCESS | 1784 | |4;audio-oscillator;102;72;83;73;71;71;82;72;72;82 11:11:03 INFO - PROCESS | 1784 | |5;imaging-gaussian-blur;88;89;88;88;88;115;82;136;137;88 11:11:03 INFO - PROCESS | 1784 | |6;imaging-darkroom;106;94;95;95;94;95;95;95;96;95 11:11:03 INFO - PROCESS | 1784 | |7;imaging-desaturate;87;95;91;91;94;84;102;88;99;139 11:11:03 INFO - PROCESS | 1784 | |8;json-parse-financial;65;70;63;68;68;66;77;109;106;67 11:11:03 INFO - PROCESS | 1784 | |9;json-stringify-tinderbox;57;60;59;65;63;56;57;59;59;58 11:11:03 INFO - PROCESS | 1784 | |10;stanford-crypto-aes;78;74;97;78;84;70;88;100;108;105 11:11:03 INFO - PROCESS | 1784 | |11;stanford-crypto-ccm;136;142;129;135;137;135;137;138;177;137 11:11:03 INFO - PROCESS | 1784 | |12;stanford-crypto-pbkdf2;208;224;166;163;163;162;162;168;162;164 11:11:03 INFO - PROCESS | 1784 | |13;stanford-crypto-sha256-iterative;65;64;65;66;68;74;85;80;82;82 11:11:03 INFO - PROCESS | 1784 | __end_tp_report 11:11:03 INFO - PROCESS | 1784 | __start_cc_report 11:11:03 INFO - PROCESS | 1784 | _x_x_mozilla_cycle_collect,1007 11:11:03 INFO - PROCESS | 1784 | __end_cc_report 11:11:03 INFO - PROCESS | 1784 | __startTimestamp1493143863460__endTimestamp 11:11:03 INFO - PROCESS | 1784 | 11:11:03 INFO - PROCESS | 1784 | ------- Summary: start ------- 11:11:03 INFO - PROCESS | 1784 | Number of tests: 14 11:11:03 INFO - PROCESS | 1784 | 11:11:03 INFO - PROCESS | 1784 | [#0] ai-astar Cycles:10 Average:118.30 Median:119.50 stddev:3.80 (3.2%) stddev-sans-first:2.06 11:11:03 INFO - PROCESS | 1784 | Values: 109.0 120.0 118.0 117.0 124.0 119.0 118.0 120.0 120.0 118.0 11:11:03 INFO - PROCESS | 1784 | 11:11:03 INFO - PROCESS | 1784 | [#1] audio-beat-detection Cycles:10 Average:128.60 Median:141.50 stddev:21.87 (15.5%) stddev-sans-first:22.80 11:11:03 INFO - PROCESS | 1784 | Values: 140.0 132.0 96.0 170.0 143.0 145.0 113.0 112.0 126.0 109.0 11:11:03 INFO - PROCESS | 1784 | 11:11:03 INFO - PROCESS | 1784 | [#2] audio-dft Cycles:10 Average:195.20 Median:196.50 stddev:2.97 (1.5%) stddev-sans-first:2.74 11:11:03 INFO - PROCESS | 1784 | Values: 191.0 198.0 191.0 197.0 192.0 199.0 195.0 195.0 198.0 196.0 11:11:03 INFO - PROCESS | 1784 | 11:11:03 INFO - PROCESS | 1784 | [#3] audio-fft Cycles:10 Average:76.60 Median:85.00 stddev:14.95 (17.6%) stddev-sans-first:14.47 11:11:03 INFO - PROCESS | 1784 | Values: 94.0 87.0 51.0 81.0 69.0 78.0 85.0 51.0 85.0 85.0 11:11:03 INFO - PROCESS | 1784 | 11:11:03 INFO - PROCESS | 1784 | [#4] audio-oscillator Cycles:10 Average:78.00 Median:72.50 stddev:9.80 (13.5%) stddev-sans-first:5.29 11:11:03 INFO - PROCESS | 1784 | Values: 102.0 72.0 83.0 73.0 71.0 71.0 82.0 72.0 72.0 82.0 11:11:03 INFO - PROCESS | 1784 | 11:11:03 INFO - PROCESS | 1784 | [#5] imaging-gaussian-blur Cycles:10 Average:99.90 Median:88.00 stddev:21.23 (24.1%) stddev-sans-first:22.07 11:11:03 INFO - PROCESS | 1784 | Values: 88.0 89.0 88.0 88.0 88.0 115.0 82.0 136.0 137.0 88.0 11:11:03 INFO - PROCESS | 1784 | 11:11:03 INFO - PROCESS | 1784 | [#6] imaging-darkroom Cycles:10 Average:96.00 Median:95.00 stddev:3.56 (3.7%) stddev-sans-first:0.60 11:11:03 INFO - PROCESS | 1784 | Values: 106.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 96.0 95.0 11:11:03 INFO - PROCESS | 1784 | 11:11:03 INFO - PROCESS | 1784 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:91.00 stddev:15.73 (17.3%) stddev-sans-first:16.27 11:11:03 INFO - PROCESS | 1784 | Values: 87.0 95.0 91.0 91.0 94.0 84.0 102.0 88.0 99.0 139.0 11:11:03 INFO - PROCESS | 1784 | 11:11:03 INFO - PROCESS | 1784 | [#8] json-parse-financial Cycles:10 Average:75.90 Median:67.50 stddev:17.08 (25.3%) stddev-sans-first:17.65 11:11:03 INFO - PROCESS | 1784 | Values: 65.0 70.0 63.0 68.0 68.0 66.0 77.0 109.0 106.0 67.0 11:11:03 INFO - PROCESS | 1784 | 11:11:03 INFO - PROCESS | 1784 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:2.79 (4.7%) stddev-sans-first:2.83 11:11:03 INFO - PROCESS | 1784 | Values: 57.0 60.0 59.0 65.0 63.0 56.0 57.0 59.0 59.0 58.0 11:11:03 INFO - PROCESS | 1784 | 11:11:03 INFO - PROCESS | 1784 | [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:78.00 stddev:13.54 (17.4%) stddev-sans-first:13.85 11:11:03 INFO - PROCESS | 1784 | Values: 78.0 74.0 97.0 78.0 84.0 70.0 88.0 100.0 108.0 105.0 11:11:03 INFO - PROCESS | 1784 | 11:11:03 INFO - PROCESS | 1784 | [#11] stanford-crypto-ccm Cycles:10 Average:140.30 Median:137.00 stddev:13.29 (9.7%) stddev-sans-first:14.01 11:11:03 INFO - PROCESS | 1784 | Values: 136.0 142.0 129.0 135.0 137.0 135.0 137.0 138.0 177.0 137.0 11:11:03 INFO - PROCESS | 1784 | 11:11:03 INFO - PROCESS | 1784 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:165.00 stddev:22.43 (13.6%) stddev-sans-first:20.19 11:11:03 INFO - PROCESS | 1784 | Values: 208.0 224.0 166.0 163.0 163.0 162.0 162.0 168.0 162.0 164.0 11:11:03 INFO - PROCESS | 1784 | 11:11:03 INFO - PROCESS | 1784 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:77.00 stddev:8.43 (10.9%) stddev-sans-first:8.41 11:11:03 INFO - PROCESS | 1784 | Values: 65.0 64.0 65.0 66.0 68.0 74.0 85.0 80.0 82.0 82.0 11:11:03 INFO - PROCESS | 1784 | -------- Summary: end -------- 11:11:03 INFO - PROCESS | 1784 | 11:11:04 INFO - TEST-INFO | 1784: exit 0 11:11:04 INFO - TEST-OK | kraken | took 59654ms 11:11:04 INFO - SUITE-END | took 1174s 11:11:04 INFO - Completed test suite (00:19:34) 11:11:04 INFO - javascript benchmark 11:11:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7900.317604320527, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3639.144800971772, 3676.8345424455915, 3677.8896633101017, 3688.7049036077115, 3708.777473351599, 6204.534659900503, 6222.751089956402, 6258.593191442553, 6261.780837670683, 6291.119243305935, 6274.654893980829, 6277.905831412521, 6311.242650881901, 6317.147185130006, 6323.367663233686, 5575.553955683536, 5649.4633009864, 5670.518005969477, 5683.943160568383, 5744.569157313197, 5709.286339207578, 5740.0, 5746.994276001704, 5752.856178595527, 5765.913511297334, 5471.124620060791, 5485.0949593317055, 5715.71421428929, 5719.227904232937, 5725.914111288334, 5580.079286917674, 5587.8603034924045, 5608.411116832755, 5656.0, 5663.773449062074, 5569.637973531708, 5648.971755141239, 5649.745761440745, 5655.123455864347, 5747.339056008571, 6209.503239740855, 6351.98368261076, 6357.205349331333, 6365.586236894634, 6377.394147555975, 6375.788600166, 6427.87144257117, 6514.478841692653, 6690.665466726693, 6751.054852320679, 6658.86682266352, 6665.133532640774, 6673.599584024974, 6726.697298621574, 6731.1922569292, 6192.566520343623, 6392.904106438407, 6398.712057957403, 6400.711967961406, 6413.422791948747, 6577.440917521969, 6935.4104901082965, 6938.895916561256, 6957.304269573104, 6980.127484064492, 6431.260405053479, 6459.257185423642, 6472.385123413268, 6473.708683109177, 6616.768413105615, 6756.155480564929, 6775.864482710417, 6788.898166527506, 6790.456763458911, 6803.4557235422035, 6601.53789234749, 6633.635150066696, 6645.0, 6674.966625166843, 6697.464202863759, 6347.301796802348, 6412.551121421456, 6498.220213574401, 6593.241777195684, 6657.667116644246, 5379.112446446371, 5427.104527752956, 5436.456354364611, 5439.456054394529, 5444.346678398539, 4754.548317909793, 4774.259989701602, 4791.0, 4796.760161991887, 4811.807527698923, 6181.041938499539, 6252.062190671345, 6342.143810585604, 6412.5190610704385, 6412.9679351602945, 6634.701438435282, 6643.236027856762, 6790.253072162058, 6796.25241223465, 6813.488988325896, 6200.162977998003, 6338.619682819046, 6359.904601430982, 6361.618302901748, 6376.107344971708, 5840.883182336414, 5877.500412464903, 5901.557383196277, 5909.113632955091, 5982.9401705983255, 6652.334766523309, 6745.763898263537, 6958.547694399847, 7020.22777494465, 7033.226345102137, 6662.56693314933, 6708.865822683421, 6721.294264102395, 6734.932650673627, 6736.056952026622, 5784.334801497714, 6659.83452895751, 6996.090508233897, 7019.6490175492045, 7021.789346319414, 4931.9753401232765, 5255.474452554714, 5790.826275211751, 6191.4118158774845, 6695.564788288746, 6548.1814773153355, 6606.933930660632, 6700.631465269262, 6750.3924646782025, 6761.154855643044, 6582.76960306387, 6588.40704336612, 6597.4392176663605, 6612.867742645217, 6615.636140012153, 5359.919601205907, 5542.916856247079, 6477.902831457626, 6583.769568065095, 6613.941769316886, 5175.0, 6109.266887973472, 6296.968515157395, 6341.619502829845, 6377.7130029147875, 6592.637404942582, 6611.404973552211, 6628.204615446178, 6633.170853643294, 6646.302138275411, 6428.774992875227, 6434.581752186093, 6458.160439142881, 6481.902771458526, 6485.77299794505], "value": 6136.134427134838, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.7304570354671, 788.2039140468128, 807.5962018990505, 994.7811481474082, 1002.8245057115007, 40489.3926591101, 41420.37869431961, 42180.0, 42253.577464225345, 42354.7882260589, 32663.346733065326, 38540.61459385405, 40154.598454015526, 40319.790406287786, 40322.0, 8221.383396245275, 11375.488103035383, 11595.478203480863, 11780.293182409083, 11793.292402455838, 9332.72001839946, 11360.943195284011, 11387.202895797256, 11443.885561144407, 11489.138314626394, 9521.714348569554, 11483.368414737186, 11484.310941343547, 11516.136289778258, 11566.59516916908, 9477.0, 11437.942810285937, 11446.828297575543, 11488.655340339761, 11505.539778408895, 11165.888341116566, 11168.106551475863, 11246.662600121928, 11249.718757031058, 11253.831192532036, 35863.4620480693, 36093.45859812105, 36258.81870590657, 36363.63636363629, 36415.81792091049, 3992.3612222044626, 3999.9400008999887, 4017.7589344639414, 4042.8787136385954, 4073.490813648294, 26572.867135664197, 26670.46659066808, 26684.86657566719, 27662.0, 28354.716452835415, 3174.7137532779593, 3214.694604012615, 3254.4142054430195, 3308.669133086696, 3407.6762707542994, 340821.0, 343513.28243358625, 371401.0, 375007.0, 375541.61145971296, 46279.76860115678, 46312.0, 46345.30482042772, 46350.76824615923, 46550.0, 48321.03357932892, 48534.0, 48553.27170092452, 48564.75717621389, 48592.0, 14775.40898364075, 14909.254537273093, 14911.328990195467, 14920.776188357184, 14922.626934326512, 12598.496060157675, 12794.68013299675, 12865.871341286655, 12891.935540322425, 12902.548410805577, 11026.834597481044, 12347.69130771738, 12500.312482813351, 12531.624051278477, 12579.308138052495, 5239.502247286578, 5438.075527160392, 5772.826815195551, 5833.649981001154, 5851.32709738377, 1049.4385503755454, 1129.4014172488594, 1172.7947609168532, 1200.8198770184542, 1216.8053111502118, 27950.02174923868, 28148.0, 28220.85889570539, 28307.0, 28427.57358639622, 1283.608499407671, 1297.1179597873536, 1309.7773378525674, 1315.4606611289325, 1325.787873940165, 14448.638784030483, 14545.854541454662, 14704.779428308584, 14715.92642036783, 14789.112653240625, 450902.49097509263, 453760.0, 453806.0, 453930.0, 454049.7297513557, 51360.486395136315, 61038.0, 61317.0, 61520.384796152364, 61573.07640385398, 1472.168224952898, 1491.2171110167249, 1513.5761986643756, 1514.3185566495122, 1515.9014664046801, 28132.71867281383, 28436.43127137487, 28895.42209155763, 29228.853855730584, 29320.827166913085, 42705.78647106745, 43298.70103896888, 43413.7829310864, 43423.69728908138, 43516.78241608771, 421922.0, 493142.0, 494367.0, 494653.0, 494716.5264173656, 30170.84914575413, 30402.69597304087, 30426.0, 30545.098215669477, 30618.0, 39285.80357098196, 39690.40464392979, 40014.59985400225, 40069.79965100156, 40211.19577608373, 27442.17673469799, 28270.86916523316, 28431.715682842907, 28547.000854969978, 29324.706752932198, 28191.295217619725, 28671.283217919718, 28742.712572874003, 28971.275718107216, 29039.274018149714, 26711.465770684867, 33343.83328083344, 33561.0, 33609.0, 33654.0, 28019.159425217276, 28622.713772862004, 29221.85389073041, 29340.413191735617, 29362.119136425943, 21139.788602114397, 22695.0, 23375.298741037797, 23375.312343828085, 23671.881640591688], "value": 18964.495260106134, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.21204469351807, 430.19124046792024, 441.2234467337487, 446.93388779044625, 452.129650422936, 19912.303069392576, 20759.377218683443, 21971.34085977419, 22120.88939555302, 22173.33479995599, 20619.27832525862, 22203.6669449958, 23140.65289020666, 23334.88332558335, 23462.530749385, 6887.965560172192, 6930.792076237721, 7167.4982751207435, 7192.460565457585, 7196.316349946746, 6912.3778859902595, 7076.292370762934, 7097.290270972913, 7102.325279098477, 7104.78685639429, 6799.456043516531, 7012.474064445161, 7016.087908571904, 7082.114735658043, 7093.609851458168, 6613.206415230203, 6797.456203503708, 7007.4394048476, 7045.542039767399, 7086.9999999999745, 6856.0, 6856.382925536675, 6857.759978400782, 6863.210730765976, 6865.656717164172, 26632.467350652878, 26783.0, 26970.921163153645, 27199.1840244793, 27334.726652733418, 2910.3160757222035, 3053.4656435123766, 3071.7696172786905, 3076.7846250762454, 3082.969170308291, 15711.292991815282, 16010.279537420727, 16276.267567959352, 16665.33338666452, 16722.498325050146, 1856.016311354984, 2042.0, 2048.109072553444, 2080.0847627044054, 2162.9783702162936, 131569.0, 137000.0, 160408.0, 165444.0, 168416.0, 16779.328826846788, 20284.898575507028, 21430.785692143192, 21440.463988400104, 21601.135954561643, 32383.352332953207, 32453.51319730159, 32538.67461325404, 33091.83454082714, 33137.0, 10815.783684326427, 10843.67468975932, 11070.0, 11079.50142243601, 11180.329180249048, 8579.270761985177, 8750.431221970552, 9232.307576931757, 9261.536923153815, 9426.952865235768, 7743.7676869694, 7895.802604934923, 7931.484453510503, 7954.681812727542, 9783.46190959504, 3976.2445135424177, 4039.7576145431367, 4058.3100872851096, 4072.552019277877, 4082.897927551835, 875.4134729731095, 970.8058388322364, 987.5704068730125, 1007.8057501860319, 1021.8313978193515, 22345.55308893813, 23318.65022024671, 23750.287491375286, 24855.378615534755, 24917.875410623194, 960.2858896869055, 961.2502248246379, 979.7354714227118, 991.504247876062, 997.1374760831973, 7237.89143162853, 7242.855142897112, 7324.743633972786, 7360.263973602704, 7473.85052298951, 794490.0, 797042.0, 802356.0, 803712.0, 804234.0, 152519.0, 160759.0, 172578.0, 179347.0, 186385.06807465875, 1293.5084667826166, 1395.0931894268604, 1459.7956286119738, 1487.2712370938161, 1495.9476418325307, 19495.415137545897, 20785.792142078386, 20848.0, 21343.35969920905, 21429.78570214278, 55933.16100258418, 59305.517362064566, 61537.0, 62227.37772622397, 62520.0, 82386.0, 88928.5553572228, 93992.0, 96313.0, 97154.0, 9593.616255349987, 11757.882421175678, 11884.465199066235, 12138.817917731418, 12161.635150945485, 13314.800277995644, 13375.264360460269, 13653.931730341284, 13695.246761428218, 13767.724645506833, 11445.0, 11525.769484610428, 11563.768724625628, 11751.236169649288, 11936.52253909834, 10598.417087060287, 10625.25623206368, 10815.0, 10992.780144396907, 11044.502997364978, 11672.358020308964, 11686.415679216176, 11867.347295898808, 11918.404079795802, 12046.879531204575, 11575.710607234887, 11609.941950290195, 11866.881331186578, 11938.28370297785, 12102.515899363927, 9086.681966131153, 11131.499082541142, 11486.483108260316, 11575.189736718348, 11614.419279035845], "value": 11776.374206463504, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1410.8800751936087, 1592.609810596404, 1647.0858673436246, 1651.5045486354095, 1658.204062050216, 11034.062104721099, 11721.941390293046, 11748.941255293712, 11862.0, 12181.269123852575, 11529.020033297158, 11694.766104677923, 11740.471678774455, 11755.35345555994, 11780.234284771484, 1957.3149397710795, 2023.9898800505978, 2512.8115391345723, 2516.8238223324374, 2520.3825062859623, 2432.2946345559853, 2490.987545062272, 2499.0003998400693, 2500.099964012954, 2511.108556462457, 2371.4782747795457, 2384.8092152627837, 2396.0, 2486.477839653666, 2506.5112303100905, 2432.525657496789, 2480.2931164618, 2498.1880888711153, 2506.5738824399805, 2509.9372515687164, 2456.636566705478, 2462.212092130519, 2468.8148388870904, 2470.6911636045493, 2473.319837044809, 11386.373749443777, 11463.140264480196, 11597.0, 11603.07175425964, 11618.941905290503, 5937.228160339128, 6062.181605483247, 6098.756049758004, 6135.601185922946, 6155.353687862755, 3044.4367791958557, 3605.4772058051435, 3631.182983828644, 3655.3603119454256, 3710.573284072312, 950.6672664567416, 1052.6736711619421, 1109.2290857853795, 1245.2404033539624, 1255.2656695832948, 12926.87073129266, 14127.858721412756, 14377.353019114165, 15295.847041529665, 15967.0, 4850.854474365704, 4951.034548263126, 4968.1554135797005, 4969.0, 4970.453250142481, 12128.696782580506, 12280.692982675326, 12291.446884890202, 12294.692632684255, 12299.93850030762, 5949.851253718605, 6093.177421048102, 6115.755369785159, 6137.324894261627, 6139.2325959255095, 5546.223528705985, 5637.577181711388, 5642.0, 5648.265725455747, 5663.575231857627, 3949.2891279569953, 4072.0, 4103.4460347853255, 4120.17596480705, 4130.256553820341, 1082.2694681090234, 1085.4084523934475, 1087.2932593814085, 1095.8575385199872, 1098.1215027977587, 981.6466072213997, 997.1075887081022, 1004.6684594083935, 1012.2458768217725, 1015.7912084619279, 5705.62913410627, 6624.205095388488, 6723.697433615401, 6774.119364482684, 6906.412954898889, 940.9529523523796, 1013.2299452416216, 1019.1286450085071, 1063.739383850946, 1065.350136416785, 4162.812673429703, 4291.592298731615, 4294.162638285567, 4399.790057734149, 4441.0, 13607.115537490032, 14176.93672974531, 14204.786928196085, 14207.36066876993, 14220.217888016052, 13914.51299204523, 14043.648908777363, 14058.789118163235, 14089.577312680636, 14132.0, 10529.315594486487, 10610.045095941403, 10655.680329590125, 10685.198610104273, 10688.625898093529, 6656.800295991128, 6687.76592819249, 6753.3246675332075, 6846.281140480178, 6905.965470172818, 12466.812997804858, 12473.376331183223, 12677.985761138902, 12692.873071269538, 13203.735925281633, 11545.422728863692, 11658.591949282074, 11927.880721192678, 12880.549180778627, 13395.330233488092, 7746.8450630985935, 9567.665131720356, 9568.569414376509, 9575.329726919048, 9605.991370906233, 10359.015893490106, 10460.790784184426, 10548.156147508334, 10562.471876405994, 10608.893911061099, 8947.19475247231, 9021.413608115452, 9078.818423631623, 9136.84419516548, 9168.266538677024, 7295.598742069237, 8763.474191548528, 8814.33892458081, 8858.291336693179, 8936.0, 8162.755117346489, 8182.345412367115, 8192.18078192176, 8221.630026648696, 8232.259096681328, 4902.436219834764, 5196.038732834438, 5375.247465354775, 5923.437273459014, 6248.531360148098, 6089.812486565077, 6101.5118790497545, 6130.540209484396, 6212.06818977157, 6217.813465596039], "value": 5264.884078415649, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.3259692224757, 400.4833764443867, 400.5453809925733, 400.9258287216865, 406.4431728531912, 4135.979320103403, 4880.194328098604, 5126.743662816853, 5133.537981581657, 5334.679919204846, 4907.82822601209, 5089.338386009823, 5190.922136167951, 5192.974035129819, 5277.577793776498, 3341.6157141928747, 3652.6347365263396, 4086.7522862425694, 4148.481439820022, 4189.245935731567, 3408.2788191963023, 3545.6421479716087, 4036.535798383194, 4119.940029985008, 4138.441310423084, 3528.231754085779, 3784.6215378462207, 3992.6207010333974, 4101.011009660312, 4115.218108559379, 3553.502509648651, 4025.6376926076646, 4047.5345335286524, 4073.1446396256674, 4110.630043296118, 3638.872639457633, 3652.2878038782446, 3662.7436079474446, 3668.5414323209598, 3699.6485333893506, 4861.489543597907, 4908.361912951329, 5132.999065182291, 5142.97428512855, 5144.533807864741, 4058.7767672777986, 4172.833086676529, 4290.884370063774, 4332.870013899588, 4745.0, 4859.878503037417, 5460.198134615567, 5592.238444889887, 5599.124293361729, 5612.466815652507, 3703.8333275002688, 3837.4627552142724, 4131.648809851136, 4172.812223449952, 4192.81132349045, 4386.978065109686, 4848.5151484851585, 5025.623078269145, 5632.971835140839, 5910.399424253358, 3312.635610082889, 3396.966030339665, 3697.6302369762807, 4016.6385025347276, 4164.541900390955, 3841.8079096045644, 4185.437872718751, 4253.8723838284905, 4275.593818587229, 4283.657307415399, 4132.938005929914, 4321.891952701145, 4338.230153895312, 4408.448943882015, 4802.27965805132, 4708.788104535236, 5540.672917374713, 5573.7213139343685, 5653.886922261532, 5700.178411686159, 1543.915084670354, 1591.9015879043423, 1737.557827003584, 1764.7088230441834, 1782.7147656375178, 1246.2397937258265, 1265.5191027409526, 1280.2972047177232, 1301.576987479073, 1409.429181181623, 4717.575418212377, 4921.753912304371, 5089.720065396365, 5227.294315267466, 5277.287566178594, 5168.612354073384, 5719.571032172604, 5785.0, 5845.678487683133, 5893.793717219876, 4834.863807005351, 4882.072406242803, 5264.894702105937, 5278.841634750964, 5291.761870715827, 2623.370391106159, 2773.8751756171023, 2906.454125966318, 2958.45268625305, 2999.5950546676354, 5253.1632918224495, 5523.972380138154, 5668.858278542987, 5728.885422291531, 6077.270727512727, 4624.421947256593, 5312.442193569696, 5741.311042674905, 5791.160281759206, 5921.4670679638175, 5088.92366614501, 5798.9420105799245, 5956.047032474783, 6018.42824931622, 6104.847378815565, 5199.63602547818, 5744.224529688438, 5770.0, 5782.7686892523825, 5813.628095704396, 4868.440129385024, 5026.195808670595, 5107.540321371094, 5246.496602539562, 5719.456651618089, 5137.023965446553, 5936.951751645848, 6034.409526331826, 6077.908831367621, 6084.513238940963, 4872.780724867319, 4892.3884514435695, 4895.4370247422, 4925.581325587222, 4948.505149485023, 4886.0, 5009.899802003866, 5259.658122222043, 5788.102844059177, 5808.0, 5037.899242015213, 5515.751791169488, 5568.777248909998, 5576.665400076008, 5576.832695019156, 4522.773861306987, 5558.805441809517, 5611.91344760372, 5615.8876822464135, 5704.60067795267, 5167.0, 5250.317458730341, 5406.675599464044, 5452.591055670761, 5463.207834864002, 4617.0, 5574.348801535001, 5580.330360356783, 5598.712296171985, 5615.775368985358, 4863.367762190893, 5111.386633603991, 5439.9456005441025, 5466.316710411199, 5523.143912693539], "value": 4193.874931749307, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.7380710812123, 709.8367375503634, 757.5189754505888, 788.8304014636852, 822.8518866604011, 13651.249181295025, 13707.862921370783, 16033.999999999985, 16103.0, 17376.826231737694, 15774.447894323672, 16144.273507692153, 16250.18749062545, 16321.428749993753, 16336.34654613814, 1004.2919741582203, 1028.4703377760459, 1029.3617956866754, 1029.67050543826, 1030.5105075089348, 992.7617371830745, 1024.4365598920601, 1040.9167266618651, 1048.444324508012, 1051.363924825481, 1068.0601071057458, 1082.8592283003238, 1085.3054045410943, 1086.2667699302979, 1086.538221255967, 1056.572088304238, 1079.2175672637354, 1079.913606911449, 1081.6268387406333, 1083.6478144602995, 805.7703554487001, 806.1615919443772, 806.2018601584389, 808.3250485844327, 809.6963638635511, 16950.23723932426, 17313.913430432895, 17463.825361746472, 17987.010714410702, 18007.0096144712, 14403.639909002359, 14550.417983280657, 14551.126932383984, 14751.0, 14783.0, 12044.81932771009, 12083.275003499819, 12200.450979705935, 12237.816432753516, 12309.507619695201, 3610.422332426799, 3832.6742226910746, 3886.9805650971566, 3906.8437262509465, 4076.7961601919787, 117397.2390414153, 123632.0, 126321.10518342232, 127274.3636281822, 127841.36079319636, 11437.428128593538, 11444.771104578029, 11676.532938682527, 11749.647510574696, 11783.410829458493, 23976.64035039476, 24286.878565607058, 24295.0281988722, 24337.0, 24379.390515236908, 8258.174182581693, 8266.628001739937, 8274.255317021498, 8278.172182781795, 8386.916130838736, 3505.0, 4482.843100491467, 4525.615322697542, 4594.632429405639, 4646.372739680168, 3663.5603727552866, 3761.4169803679924, 3762.078290818767, 3764.6235376462137, 3768.7361884668358, 530.4668807848088, 653.2422390027546, 662.3277373465936, 663.1114306828872, 663.9402453779184, 703.8672821351314, 714.3463730686364, 721.9133703955454, 738.6343759838915, 743.8177646476539, 10619.94690026545, 10640.201984851166, 10781.299215550964, 10813.62152324665, 10851.294665846852, 616.6649204472267, 696.9512134150663, 750.4259241680119, 754.4756394305905, 757.3978686943893, 5021.4978502150225, 5176.7152806596, 5186.688798672092, 5200.193969934666, 5241.50205730455, 109132.90867091228, 111461.0, 112679.0, 114169.4291528537, 116491.41754291343, 81395.96510087296, 95512.56731149038, 97878.51060744793, 99868.50065749625, 103448.48275758573, 74772.87840682395, 76921.23078769252, 77570.0, 78299.60850195713, 78661.60669196617, 10076.496175191358, 11059.170562207706, 11204.775904482029, 11471.024962877915, 11524.193306468467, 42724.35913461239, 43010.35484467673, 46314.76842615765, 49790.50209497858, 51002.23496647479, 61073.0, 65039.0, 67133.0, 68125.0, 70148.29851701621, 12807.679808004874, 13118.212907225598, 13455.259960702255, 13634.0, 13707.451701931812, 14298.57104286873, 14964.476243331432, 15185.240737962837, 15219.847801521842, 15956.281967311732, 13075.738485230433, 13924.303784810922, 14430.0, 14554.708905822035, 15072.376959169236, 13704.0, 13979.93010034984, 14269.714605708035, 14270.143791372551, 14340.282985850874, 13658.931705341807, 13959.162450252612, 14174.645633859236, 14205.644858878612, 14613.488527901472, 10176.592936282466, 10247.590096396061, 10388.688339349832, 10402.063814256753, 10744.30162039465, 11472.655820325404, 11499.0, 11595.362255075714, 11717.531298747954, 11727.296362218294], "value": 8034.788637279468, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1500.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 120.0, 118.0, 117.0, 124.0, 119.0, 118.0, 120.0, 120.0, 118.0], "value": 118.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 132.0, 96.0, 170.0, 143.0, 145.0, 113.0, 112.0, 126.0, 109.0], "value": 128.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 198.0, 191.0, 197.0, 192.0, 199.0, 195.0, 195.0, 198.0, 196.0], "value": 195.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 87.0, 51.0, 81.0, 69.0, 78.0, 85.0, 51.0, 85.0, 85.0], "value": 76.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 72.0, 83.0, 73.0, 71.0, 71.0, 82.0, 72.0, 72.0, 82.0], "value": 78.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 88.0, 88.0, 88.0, 115.0, 82.0, 136.0, 137.0, 88.0], "value": 99.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 95.0, 91.0, 91.0, 94.0, 84.0, 102.0, 88.0, 99.0, 139.0], "value": 97.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 63.0, 68.0, 68.0, 66.0, 77.0, 109.0, 106.0, 67.0], "value": 75.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 60.0, 59.0, 65.0, 63.0, 56.0, 57.0, 59.0, 59.0, 58.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 97.0, 78.0, 84.0, 70.0, 88.0, 100.0, 108.0, 105.0], "value": 88.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 142.0, 129.0, 135.0, 137.0, 135.0, 137.0, 138.0, 177.0, 137.0], "value": 140.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [208.0, 224.0, 166.0, 163.0, 163.0, 162.0, 162.0, 168.0, 162.0, 164.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 66.0, 68.0, 74.0, 85.0, 80.0, 82.0, 82.0], "value": 73.1, "unit": "score"}]}]} 11:11:04 INFO - Return code: 0 11:11:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:11:04 ERROR - # TBPL SUCCESS # 11:11:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:11:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:11:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:11:04 INFO - 2017-04-25 11:11:04.794 screenresolution[1794:10896] starting screenresolution argv=screenresolution get 11:11:04 INFO - 2017-04-25 11:11:04.797 screenresolution[1794:10896] Display 0: 1600x1200x32@60 11:11:04 INFO - 2017-04-25 11:11:04.803 screenresolution[1795:10899] starting screenresolution argv=screenresolution list 11:11:04 INFO - Available Modes on Display 0 11:11:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:11:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:11:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:11:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:11:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:11:05 INFO - Intel Iris: 11:11:05 INFO - Chipset Model: Intel Iris 11:11:05 INFO - Type: GPU 11:11:05 INFO - Bus: Built-In 11:11:05 INFO - VRAM (Dynamic, Max): 1536 MB 11:11:05 INFO - Vendor: Intel (0x8086) 11:11:05 INFO - Device ID: 0x0a2e 11:11:05 INFO - Revision ID: 0x0009 11:11:05 INFO - Displays: 11:11:05 INFO - Display: 11:11:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:11:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:11:05 INFO - Display Serial Number: 1600x1200 60 11:11:05 INFO - Main Display: Yes 11:11:05 INFO - Mirror: Off 11:11:05 INFO - Online: Yes 11:11:05 INFO - Rotation: Supported 11:11:05 INFO - Return code: 0 11:11:05 INFO - Running post-action listener: _resource_record_post_action 11:11:05 INFO - [mozharness: 2017-04-25 18:11:05.049156Z] Finished run-tests step (success) 11:11:05 INFO - Running post-run listener: _resource_record_post_run 11:11:05 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 41760768; Write bytes: 431248896; Read time: 277; Write time: 1523 11:11:05 INFO - TinderboxPrint: CPU usage
54.4% 11:11:05 INFO - TinderboxPrint: I/O read bytes / time
41,760,768 / 277 11:11:05 INFO - TinderboxPrint: I/O write bytes / time
431,248,896 / 1,523 11:11:05 INFO - TinderboxPrint: CPU idle
2,171.6 (45.6%) 11:11:05 INFO - TinderboxPrint: CPU system
955.0 (20.1%) 11:11:05 INFO - TinderboxPrint: CPU user
1,634.9 (34.3%) 11:11:05 INFO - TinderboxPrint: Swap in / out
161,927,168 / 0 11:11:05 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 118747648; Write bytes: 116529152; Read time: 10094; Write time: 260 11:11:05 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 35381248; Write bytes: 302910976; Read time: 215; Write time: 1220 11:11:05 INFO - Running post-run listener: _upload_blobber_files 11:11:05 INFO - Blob upload gear active. 11:11:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:11:05 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 11:11:05 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:11:05 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:11:05 INFO - (blobuploader) - INFO - Open directory for files ... 11:11:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:11:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:11:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:06 INFO - (blobuploader) - INFO - Done attempting. 11:11:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:11:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:11:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:08 INFO - (blobuploader) - INFO - Done attempting. 11:11:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:11:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:11:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:09 INFO - (blobuploader) - INFO - Done attempting. 11:11:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:11:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:11:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:11 INFO - (blobuploader) - INFO - Done attempting. 11:11:11 INFO - (blobuploader) - INFO - Iteration through files over. 11:11:11 INFO - Return code: 0 11:11:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:11:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:11:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6501fe49ce6f7baa503f321aaf69da2e8b752726d529e4241093e8b3b66e6736def27744b2dbfe7c8aa8b8b62812b74f05c2d54085b3c32e4d8228187332000b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9470718ea7e8612ccfb82e1d648898875c0a1ad90ab6e3af793edfa7d659afbb27d2cca0c6bdd06137a83357d3e69d782a7a50d4965a7fab571dd73df497bddb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/faa31e1d900a6041f68459c2fa2e857188c9c52a871840a45c6f447f46cb66d7fb738bf7bee8db4fb26207a068839326dba852b84ef86a7703e1fa4d4743ccf1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b81fa9198acab22bd23570cee435702406211ffe9808c7cfdae7eb287e0f4fe66c1ca7cbd83a98a524ce2c7d44ba1e64851f6dd46a1fdfa545d5df0147f5c4fd"} 11:11:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:11:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:11:11 INFO - Contents: 11:11:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6501fe49ce6f7baa503f321aaf69da2e8b752726d529e4241093e8b3b66e6736def27744b2dbfe7c8aa8b8b62812b74f05c2d54085b3c32e4d8228187332000b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9470718ea7e8612ccfb82e1d648898875c0a1ad90ab6e3af793edfa7d659afbb27d2cca0c6bdd06137a83357d3e69d782a7a50d4965a7fab571dd73df497bddb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/faa31e1d900a6041f68459c2fa2e857188c9c52a871840a45c6f447f46cb66d7fb738bf7bee8db4fb26207a068839326dba852b84ef86a7703e1fa4d4743ccf1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b81fa9198acab22bd23570cee435702406211ffe9808c7cfdae7eb287e0f4fe66c1ca7cbd83a98a524ce2c7d44ba1e64851f6dd46a1fdfa545d5df0147f5c4fd"} 11:11:11 INFO - Running post-run listener: copy_logs_to_upload_dir 11:11:11 INFO - Copying logs to upload dir... 11:11:11 INFO - mkdir: /builds/slave/test/build/upload/logs 11:11:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.639471 ========= master_lag: 0.13 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2017-04-25 11:11:11.934665) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-25 11:11:11.938059) ========= 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.0ms9ScJ8LL/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.iQH9Lirok7/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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/Mozilla-Beta/sha512/6501fe49ce6f7baa503f321aaf69da2e8b752726d529e4241093e8b3b66e6736def27744b2dbfe7c8aa8b8b62812b74f05c2d54085b3c32e4d8228187332000b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9470718ea7e8612ccfb82e1d648898875c0a1ad90ab6e3af793edfa7d659afbb27d2cca0c6bdd06137a83357d3e69d782a7a50d4965a7fab571dd73df497bddb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/faa31e1d900a6041f68459c2fa2e857188c9c52a871840a45c6f447f46cb66d7fb738bf7bee8db4fb26207a068839326dba852b84ef86a7703e1fa4d4743ccf1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b81fa9198acab22bd23570cee435702406211ffe9808c7cfdae7eb287e0f4fe66c1ca7cbd83a98a524ce2c7d44ba1e64851f6dd46a1fdfa545d5df0147f5c4fd"} build_url:https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011183 build_url: 'https://queue.taskcluster.net/v1/task/P8D13ObLQxu_ptB4VEUmaA/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6501fe49ce6f7baa503f321aaf69da2e8b752726d529e4241093e8b3b66e6736def27744b2dbfe7c8aa8b8b62812b74f05c2d54085b3c32e4d8228187332000b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9470718ea7e8612ccfb82e1d648898875c0a1ad90ab6e3af793edfa7d659afbb27d2cca0c6bdd06137a83357d3e69d782a7a50d4965a7fab571dd73df497bddb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/faa31e1d900a6041f68459c2fa2e857188c9c52a871840a45c6f447f46cb66d7fb738bf7bee8db4fb26207a068839326dba852b84ef86a7703e1fa4d4743ccf1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b81fa9198acab22bd23570cee435702406211ffe9808c7cfdae7eb287e0f4fe66c1ca7cbd83a98a524ce2c7d44ba1e64851f6dd46a1fdfa545d5df0147f5c4fd"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-25 11:11:11.978584) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 11:11:11.978954) ========= 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.0ms9ScJ8LL/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.iQH9Lirok7/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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.005337 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 11:11:12.030926) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 11:11:12.031546) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 11:11:12.032543) ========= ========= Total master_lag: 2.19 =========