builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0206 starttime: 1494378571.46 results: success (0) buildid: 20170509162817 builduid: 570929af9a3540e7b6066c8687a4da56 revision: a19d8e32acfe02ee96b810bd93e438fee68a7fb6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-09 18:09:31.464392) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-09 18:09:31.464826) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-09 18:09:31.465154) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-09 18:09:31.490080) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 18:09:31.490383) ========= 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.U018OGi7eh/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.CWEybJlRmi/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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-05-09 18:09:31-- 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% 44.8M=0s 2017-05-09 18:09:31 (44.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.158281 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 18:09:31.669244) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 18:09:31.669553) ========= 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.U018OGi7eh/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.CWEybJlRmi/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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.026789 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 18:09:31.717350) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-09 18:09:31.717669) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a19d8e32acfe02ee96b810bd93e438fee68a7fb6 --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 a19d8e32acfe02ee96b810bd93e438fee68a7fb6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.U018OGi7eh/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.CWEybJlRmi/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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-05-09 18:09:31,818 truncating revision to first 12 chars 2017-05-09 18:09:31,818 Setting DEBUG logging. 2017-05-09 18:09:31,818 attempt 1/10 2017-05-09 18:09:31,818 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a19d8e32acfe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-09 18:09:33,350 unpacking tar archive at: mozilla-beta-a19d8e32acfe/testing/mozharness/ program finished with exit code 0 elapsedTime=1.804979 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-09 18:09:33.542801) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-09 18:09:33.543161) ========= script_repo_revision: a19d8e32acfe02ee96b810bd93e438fee68a7fb6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-09 18:09:33.543540) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-09 18:09:33.543858) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-09 18:09:33.562527) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-05-09 18:09:33.562828) ========= /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.U018OGi7eh/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.CWEybJlRmi/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 18:09:33 INFO - MultiFileLogger online at 20170509 18:09:33 in /builds/slave/test 18:09:33 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 18:09:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:09:33 INFO - {'append_to_log': False, 18:09:33 INFO - 'base_work_dir': '/builds/slave/test', 18:09:33 INFO - 'blob_upload_branch': 'Mozilla-Beta', 18:09:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:09:33 INFO - 'branch': 'Mozilla-Beta', 18:09:33 INFO - 'buildbot_json_path': 'buildprops.json', 18:09:33 INFO - 'config_files': ('talos/mac_config.py',), 18:09:33 INFO - 'default_actions': ('clobber', 18:09:33 INFO - 'read-buildbot-config', 18:09:33 INFO - 'download-and-extract', 18:09:33 INFO - 'populate-webroot', 18:09:33 INFO - 'create-virtualenv', 18:09:33 INFO - 'install', 18:09:33 INFO - 'run-tests'), 18:09:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:09:33 INFO - 'download_minidump_stackwalk': True, 18:09:33 INFO - 'download_symbols': 'ondemand', 18:09:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:09:33 INFO - 'tooltool.py': '/tools/tooltool.py', 18:09:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:09:33 INFO - '/tools/misc-python/virtualenv.py')}, 18:09:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:09:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:09:33 INFO - 'gecko_profile': False, 18:09:33 INFO - 'gecko_profile_interval': 0, 18:09:33 INFO - 'installer_path': 'installer.exe', 18:09:33 INFO - 'log_level': 'info', 18:09:33 INFO - 'log_name': 'talos', 18:09:33 INFO - 'log_to_console': True, 18:09:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:09:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:09:33 INFO - 'opt_config_files': (), 18:09:33 INFO - 'pip_index': False, 18:09:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:09:33 INFO - 'cmd': ('bash', 18:09:33 INFO - '-c', 18:09:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:09:33 INFO - 'enabled': True, 18:09:33 INFO - 'halt_on_failure': False, 18:09:33 INFO - 'name': 'check_screen_resolution'},), 18:09:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:09:33 INFO - 'cmd': ('bash', 18:09:33 INFO - '-c', 18:09:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:09:33 INFO - 'enabled': True, 18:09:33 INFO - 'halt_on_failure': False, 18:09:33 INFO - 'name': 'check_screen_resolution'},), 18:09:33 INFO - 'run_cmd_checks_enabled': True, 18:09:33 INFO - 'suite': 'dromaeojs-e10s', 18:09:33 INFO - 'system_bits': '32', 18:09:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:09:33 INFO - 'title': 't-yosemite-r7-0206', 18:09:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:09:33 INFO - 'use_talos_json': True, 18:09:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:09:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:09:33 INFO - 'work_dir': 'build'} 18:09:33 INFO - [mozharness: 2017-05-10 01:09:33.772428Z] Running clobber step. 18:09:33 INFO - Running pre-action listener: _resource_record_pre_action 18:09:33 INFO - Running main action method: clobber 18:09:33 INFO - rmtree: /builds/slave/test/build 18:09:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:09:36 INFO - Running post-action listener: _resource_record_post_action 18:09:36 INFO - [mozharness: 2017-05-10 01:09:36.189093Z] Finished clobber step (success) 18:09:36 INFO - [mozharness: 2017-05-10 01:09:36.189221Z] Running read-buildbot-config step. 18:09:36 INFO - Running pre-action listener: _resource_record_pre_action 18:09:36 INFO - Running main action method: read_buildbot_config 18:09:36 INFO - Using buildbot properties: 18:09:36 INFO - { 18:09:36 INFO - "project": "", 18:09:36 INFO - "product": "firefox", 18:09:36 INFO - "script_repo_revision": "production", 18:09:36 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 18:09:36 INFO - "repository": "", 18:09:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 18:09:36 INFO - "buildid": "20170509162817", 18:09:36 INFO - "pgo_build": "False", 18:09:36 INFO - "basedir": "/builds/slave/test", 18:09:36 INFO - "buildnumber": 27, 18:09:36 INFO - "slavename": "t-yosemite-r7-0206", 18:09:36 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 18:09:36 INFO - "platform": "yosemite_r7", 18:09:36 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 18:09:36 INFO - "branch": "mozilla-beta", 18:09:36 INFO - "repo_path": "releases/mozilla-beta", 18:09:36 INFO - "revision": "a19d8e32acfe02ee96b810bd93e438fee68a7fb6", 18:09:36 INFO - "stage_platform": "macosx64", 18:09:36 INFO - "builduid": "570929af9a3540e7b6066c8687a4da56", 18:09:36 INFO - "slavebuilddir": "test" 18:09:36 INFO - } 18:09:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/R5LOVKxHQXmkX6fD0zF5qg/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 18:09:36 INFO - Running post-action listener: _resource_record_post_action 18:09:36 INFO - [mozharness: 2017-05-10 01:09:36.192746Z] Finished read-buildbot-config step (success) 18:09:36 INFO - [mozharness: 2017-05-10 01:09:36.192887Z] Running download-and-extract step. 18:09:36 INFO - Running pre-action listener: _resource_record_pre_action 18:09:36 INFO - Running main action method: download_and_extract 18:09:36 INFO - mkdir: /builds/slave/test/build/tests 18:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:36 INFO - trying https://queue.taskcluster.net/v1/task/R5LOVKxHQXmkX6fD0zF5qg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 18:09:36 INFO - Downloading https://queue.taskcluster.net/v1/task/R5LOVKxHQXmkX6fD0zF5qg/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 18:09:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R5LOVKxHQXmkX6fD0zF5qg/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 18:09:37 INFO - Downloaded 1287 bytes. 18:09:37 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 18:09:37 INFO - Using the following test package requirements: 18:09:37 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 18:09:37 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 18:09:37 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 18:09:37 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 18:09:37 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 18:09:37 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 18:09:37 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 18:09:37 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 18:09:37 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 18:09:37 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 18:09:37 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 18:09:37 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 18:09:37 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 18:09:37 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 18:09:37 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 18:09:37 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 18:09:37 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 18:09:37 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 18:09:37 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 18:09:37 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 18:09:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R5LOVKxHQXmkX6fD0zF5qg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 18:09:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R5LOVKxHQXmkX6fD0zF5qg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 18:09:37 INFO - Fetch https://queue.taskcluster.net/v1/task/R5LOVKxHQXmkX6fD0zF5qg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 18:09:39 INFO - Expected file size: 51225544 18:09:39 INFO - Obtained file size: 51225544 18:09:54 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 18:09:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R5LOVKxHQXmkX6fD0zF5qg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 18:09:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R5LOVKxHQXmkX6fD0zF5qg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 18:09:54 INFO - Fetch https://queue.taskcluster.net/v1/task/R5LOVKxHQXmkX6fD0zF5qg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 18:09:56 INFO - Expected file size: 51225544 18:09:56 INFO - Obtained file size: 51225544 18:10:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R5LOVKxHQXmkX6fD0zF5qg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 18:10:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R5LOVKxHQXmkX6fD0zF5qg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 18:10:11 INFO - Fetch https://queue.taskcluster.net/v1/task/R5LOVKxHQXmkX6fD0zF5qg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 18:10:12 INFO - Expected file size: 14404449 18:10:12 INFO - Obtained file size: 14404449 18:10:12 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')]} 18:10:12 INFO - trying https://queue.taskcluster.net/v1/task/R5LOVKxHQXmkX6fD0zF5qg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 18:10:12 INFO - Downloading https://queue.taskcluster.net/v1/task/R5LOVKxHQXmkX6fD0zF5qg/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 18:10:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R5LOVKxHQXmkX6fD0zF5qg/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 18:10:14 INFO - Downloaded 59570725 bytes. 18:10:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R5LOVKxHQXmkX6fD0zF5qg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 18:10:14 INFO - mkdir: /builds/slave/test/properties 18:10:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:10:14 INFO - Writing to file /builds/slave/test/properties/build_url 18:10:14 INFO - Contents: 18:10:14 INFO - build_url:https://queue.taskcluster.net/v1/task/R5LOVKxHQXmkX6fD0zF5qg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 18:10:15 INFO - Running post-action listener: _resource_record_post_action 18:10:15 INFO - Running post-action listener: set_extra_try_arguments 18:10:15 INFO - [mozharness: 2017-05-10 01:10:15.022395Z] Finished download-and-extract step (success) 18:10:15 INFO - [mozharness: 2017-05-10 01:10:15.022522Z] Running populate-webroot step. 18:10:15 INFO - Running pre-action listener: _resource_record_pre_action 18:10:15 INFO - Running main action method: populate_webroot 18:10:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:10:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:10:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:10:15 INFO - '--tppagecycles', 18:10:15 INFO - '7'], 18:10:15 INFO - 'tests': ['tsvgm']}}, 18:10:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:10:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:10:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:10:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:10:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:10:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:10:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:10:15 INFO - 'talos_options': ['--disable-e10s'], 18:10:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:10:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:10:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:10:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:10:15 INFO - 'talos_options': ['--disable-e10s'], 18:10:15 INFO - 'tests': ['damp', 'tps']}, 18:10:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:10:15 INFO - 'tests': ['damp', 'tps']}, 18:10:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:10:15 INFO - 'tests': ['dromaeo_dom']}, 18:10:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:10:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:10:15 INFO - 'tests': ['basic_compositor_video']}, 18:10:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:10:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:10:15 INFO - 'tests': ['a11yr', 18:10:15 INFO - 'ts_paint', 18:10:15 INFO - 'tpaint', 18:10:15 INFO - 'sessionrestore', 18:10:15 INFO - 'sessionrestore_no_auto_restore', 18:10:15 INFO - 'tabpaint']}, 18:10:15 INFO - 'other-e10s': {'tests': ['a11yr', 18:10:15 INFO - 'ts_paint', 18:10:15 INFO - 'tpaint', 18:10:15 INFO - 'sessionrestore', 18:10:15 INFO - 'sessionrestore_no_auto_restore', 18:10:15 INFO - 'tabpaint']}, 18:10:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:10:15 INFO - 'ts_paint', 18:10:15 INFO - 'tpaint', 18:10:15 INFO - 'sessionrestore', 18:10:15 INFO - 'sessionrestore_no_auto_restore', 18:10:15 INFO - 'tabpaint']}, 18:10:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:10:15 INFO - 'ts_paint', 18:10:15 INFO - 'tpaint', 18:10:15 INFO - 'sessionrestore', 18:10:15 INFO - 'sessionrestore_no_auto_restore', 18:10:15 INFO - 'tabpaint']}, 18:10:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:10:15 INFO - 'tests': ['a11yr', 18:10:15 INFO - 'ts_paint', 18:10:15 INFO - 'tpaint', 18:10:15 INFO - 'sessionrestore', 18:10:15 INFO - 'sessionrestore_no_auto_restore', 18:10:15 INFO - 'tabpaint']}, 18:10:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:10:15 INFO - 'tests': ['a11yr', 18:10:15 INFO - 'ts_paint', 18:10:15 INFO - 'tpaint', 18:10:15 INFO - 'sessionrestore', 18:10:15 INFO - 'sessionrestore_no_auto_restore', 18:10:15 INFO - 'tabpaint']}, 18:10:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:10:15 INFO - 'tests': ['tsvgx', 18:10:15 INFO - 'tsvgr_opacity', 18:10:15 INFO - 'tart', 18:10:15 INFO - 'tscrollx', 18:10:15 INFO - 'cart', 18:10:15 INFO - 'tsvg_static']}, 18:10:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:10:15 INFO - 'tsvgr_opacity', 18:10:15 INFO - 'tart', 18:10:15 INFO - 'tscrollx', 18:10:15 INFO - 'cart', 18:10:15 INFO - 'tsvg_static']}, 18:10:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:10:15 INFO - 'talos_options': ['--disable-e10s'], 18:10:15 INFO - 'tests': ['tp5o']}, 18:10:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:10:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:10:15 INFO - 'talos_options': ['--disable-e10s', 18:10:15 INFO - '--xperf_path', 18:10:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:10:15 INFO - 'tests': ['tp5n']}, 18:10:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:10:15 INFO - 'talos_options': ['--xperf_path', 18:10:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:10:15 INFO - 'tests': ['tp5n']}}, 18:10:15 INFO - 'talos.zip': {'path': '', 18:10:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:10:15 INFO - Running post-action listener: _resource_record_post_action 18:10:15 INFO - [mozharness: 2017-05-10 01:10:15.041551Z] Finished populate-webroot step (success) 18:10:15 INFO - [mozharness: 2017-05-10 01:10:15.041683Z] Running create-virtualenv step. 18:10:15 INFO - Running pre-action listener: _resource_record_pre_action 18:10:15 INFO - Running main action method: create_virtualenv 18:10:15 INFO - Creating virtualenv /builds/slave/test/build/venv 18:10:15 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 18:10:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:10:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:10:15 INFO - Using real prefix '/tools/python27' 18:10:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:10:15 INFO - Installing distribute.............................................................................................................................................................................................done. 18:10:18 INFO - Installing pip.................done. 18:10:18 INFO - Return code: 0 18:10:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:10:19 INFO - Reading from file tmpfile_stdout 18:10:19 INFO - Output received: 18:10:19 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) 18:10:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:10:19 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')]} 18:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:19 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')]} 18:10:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:19 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 0x10b194b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b197768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeab4be0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af72d30>, '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 0x10ae99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af67be8>, '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.U018OGi7eh/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.CWEybJlRmi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 18:10:19 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 18:10:19 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 18:10:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U018OGi7eh/Render', 18:10:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:19 INFO - 'HOME': '/Users/cltbld', 18:10:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:19 INFO - 'LOGNAME': 'cltbld', 18:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:19 INFO - 'MOZ_NO_REMOTE': '1', 18:10:19 INFO - 'NO_EM_RESTART': '1', 18:10:19 INFO - 'PAGER': '/bin/cat', 18:10:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:19 INFO - 'PWD': '/builds/slave/test', 18:10:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:19 INFO - 'SHELL': '/bin/bash', 18:10:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CWEybJlRmi/Listeners', 18:10:19 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 18:10:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:19 INFO - 'USER': 'cltbld', 18:10:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:19 INFO - 'XPC_FLAGS': '0x0', 18:10:19 INFO - 'XPC_SERVICE_NAME': '0', 18:10:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:19 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 18:10:19 INFO - Cleaning up... 18:10:19 INFO - Return code: 0 18:10:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:10:19 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')]} 18:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:19 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')]} 18:10:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:19 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 0x10b194b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b197768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeab4be0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af72d30>, '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 0x10ae99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af67be8>, '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.U018OGi7eh/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.CWEybJlRmi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 18:10:19 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 18:10:19 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 18:10:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U018OGi7eh/Render', 18:10:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:19 INFO - 'HOME': '/Users/cltbld', 18:10:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:19 INFO - 'LOGNAME': 'cltbld', 18:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:19 INFO - 'MOZ_NO_REMOTE': '1', 18:10:19 INFO - 'NO_EM_RESTART': '1', 18:10:19 INFO - 'PAGER': '/bin/cat', 18:10:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:19 INFO - 'PWD': '/builds/slave/test', 18:10:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:19 INFO - 'SHELL': '/bin/bash', 18:10:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CWEybJlRmi/Listeners', 18:10:19 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 18:10:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:19 INFO - 'USER': 'cltbld', 18:10:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:19 INFO - 'XPC_FLAGS': '0x0', 18:10:19 INFO - 'XPC_SERVICE_NAME': '0', 18:10:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:19 INFO - Downloading/unpacking psutil>=3.1.1 18:10:19 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 18:10:19 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 18:10:19 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 18:10:19 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 18:10:19 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 18:10:19 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 18:10:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:10:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:10:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:10:21 INFO - Installing collected packages: psutil 18:10:21 INFO - Running setup.py install for psutil 18:10:21 INFO - building 'psutil._psutil_osx' extension 18:10:21 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 18:10:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 18:10:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 18:10:22 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 18:10:22 INFO - building 'psutil._psutil_posix' extension 18:10:22 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 18:10:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:10:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:10:22 INFO - ^ 18:10:22 INFO - 1 warning generated. 18:10:22 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 18:10:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:10:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:10:22 INFO - Successfully installed psutil 18:10:22 INFO - Cleaning up... 18:10:23 INFO - Return code: 0 18:10:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:10:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b194b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b197768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeab4be0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af72d30>, '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 0x10ae99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af67be8>, '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.U018OGi7eh/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.CWEybJlRmi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 18:10:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:10:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:10:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U018OGi7eh/Render', 18:10:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:23 INFO - 'HOME': '/Users/cltbld', 18:10:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:23 INFO - 'LOGNAME': 'cltbld', 18:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:23 INFO - 'MOZ_NO_REMOTE': '1', 18:10:23 INFO - 'NO_EM_RESTART': '1', 18:10:23 INFO - 'PAGER': '/bin/cat', 18:10:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:23 INFO - 'PWD': '/builds/slave/test', 18:10:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:23 INFO - 'SHELL': '/bin/bash', 18:10:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CWEybJlRmi/Listeners', 18:10:23 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 18:10:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:23 INFO - 'USER': 'cltbld', 18:10:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:23 INFO - 'XPC_FLAGS': '0x0', 18:10:23 INFO - 'XPC_SERVICE_NAME': '0', 18:10:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:10:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:10:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:10:24 INFO - Installing collected packages: mozsystemmonitor 18:10:24 INFO - Running setup.py install for mozsystemmonitor 18:10:24 INFO - Successfully installed mozsystemmonitor 18:10:24 INFO - Cleaning up... 18:10:24 INFO - Return code: 0 18:10:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:24 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 0x10b194b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b197768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeab4be0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af72d30>, '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 0x10ae99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af67be8>, '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.U018OGi7eh/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.CWEybJlRmi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 18:10:24 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 18:10:24 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 18:10:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U018OGi7eh/Render', 18:10:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:24 INFO - 'HOME': '/Users/cltbld', 18:10:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:24 INFO - 'LOGNAME': 'cltbld', 18:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:24 INFO - 'MOZ_NO_REMOTE': '1', 18:10:24 INFO - 'NO_EM_RESTART': '1', 18:10:24 INFO - 'PAGER': '/bin/cat', 18:10:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:24 INFO - 'PWD': '/builds/slave/test', 18:10:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:24 INFO - 'SHELL': '/bin/bash', 18:10:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CWEybJlRmi/Listeners', 18:10:24 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 18:10:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:24 INFO - 'USER': 'cltbld', 18:10:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:24 INFO - 'XPC_FLAGS': '0x0', 18:10:24 INFO - 'XPC_SERVICE_NAME': '0', 18:10:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:25 INFO - Downloading/unpacking jsonschema==2.5.1 18:10:25 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 18:10:25 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 18:10:25 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 18:10:25 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 18:10:25 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 18:10:25 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 18:10:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:10:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:26 INFO - Downloading functools32-3.2.3-2.tar.gz 18:10:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:10:26 INFO - warning: no files found matching '*.txt' 18:10:26 INFO - no previously-included directories found matching 'build' 18:10:26 INFO - no previously-included directories found matching 'dist' 18:10:26 INFO - no previously-included directories found matching '.git*' 18:10:26 INFO - Installing collected packages: jsonschema, functools32 18:10:27 INFO - Running setup.py install for functools32 18:10:27 INFO - warning: no files found matching '*.txt' 18:10:27 INFO - no previously-included directories found matching 'build' 18:10:27 INFO - no previously-included directories found matching 'dist' 18:10:27 INFO - no previously-included directories found matching '.git*' 18:10:27 INFO - Successfully installed jsonschema functools32 18:10:27 INFO - Cleaning up... 18:10:27 INFO - Return code: 0 18:10:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b194b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b197768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeab4be0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af72d30>, '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 0x10ae99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af67be8>, '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.U018OGi7eh/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.CWEybJlRmi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 18:10:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:10:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U018OGi7eh/Render', 18:10:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:27 INFO - 'HOME': '/Users/cltbld', 18:10:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:27 INFO - 'LOGNAME': 'cltbld', 18:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:27 INFO - 'MOZ_NO_REMOTE': '1', 18:10:27 INFO - 'NO_EM_RESTART': '1', 18:10:27 INFO - 'PAGER': '/bin/cat', 18:10:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:27 INFO - 'PWD': '/builds/slave/test', 18:10:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:27 INFO - 'SHELL': '/bin/bash', 18:10:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CWEybJlRmi/Listeners', 18:10:27 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 18:10:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:27 INFO - 'USER': 'cltbld', 18:10:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:27 INFO - 'XPC_FLAGS': '0x0', 18:10:27 INFO - 'XPC_SERVICE_NAME': '0', 18:10:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:10:27 INFO - Cleaning up... 18:10:27 INFO - Return code: 0 18:10:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:28 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 0x10b194b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b197768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeab4be0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af72d30>, '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 0x10ae99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af67be8>, '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.U018OGi7eh/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.CWEybJlRmi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 18:10:28 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 18:10:28 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 18:10:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U018OGi7eh/Render', 18:10:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:28 INFO - 'HOME': '/Users/cltbld', 18:10:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:28 INFO - 'LOGNAME': 'cltbld', 18:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:28 INFO - 'MOZ_NO_REMOTE': '1', 18:10:28 INFO - 'NO_EM_RESTART': '1', 18:10:28 INFO - 'PAGER': '/bin/cat', 18:10:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:28 INFO - 'PWD': '/builds/slave/test', 18:10:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:28 INFO - 'SHELL': '/bin/bash', 18:10:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CWEybJlRmi/Listeners', 18:10:28 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 18:10:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:28 INFO - 'USER': 'cltbld', 18:10:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:28 INFO - 'XPC_FLAGS': '0x0', 18:10:28 INFO - 'XPC_SERVICE_NAME': '0', 18:10:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:28 INFO - Downloading/unpacking blobuploader==1.2.4 18:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:30 INFO - Downloading blobuploader-1.2.4.tar.gz 18:10:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:10:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:10:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:31 INFO - Downloading docopt-0.6.1.tar.gz 18:10:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:10:31 INFO - Installing collected packages: blobuploader, requests, docopt 18:10:31 INFO - Running setup.py install for blobuploader 18:10:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:10:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:10:31 INFO - Running setup.py install for requests 18:10:31 INFO - Running setup.py install for docopt 18:10:32 INFO - Successfully installed blobuploader requests docopt 18:10:32 INFO - Cleaning up... 18:10:32 INFO - Return code: 0 18:10:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:32 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 0x10b194b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b197768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeab4be0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af72d30>, '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 0x10ae99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af67be8>, '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.U018OGi7eh/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.CWEybJlRmi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 18:10:32 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 18:10:32 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 18:10:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U018OGi7eh/Render', 18:10:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:32 INFO - 'HOME': '/Users/cltbld', 18:10:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:32 INFO - 'LOGNAME': 'cltbld', 18:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:32 INFO - 'MOZ_NO_REMOTE': '1', 18:10:32 INFO - 'NO_EM_RESTART': '1', 18:10:32 INFO - 'PAGER': '/bin/cat', 18:10:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:32 INFO - 'PWD': '/builds/slave/test', 18:10:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:32 INFO - 'SHELL': '/bin/bash', 18:10:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CWEybJlRmi/Listeners', 18:10:32 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 18:10:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:32 INFO - 'USER': 'cltbld', 18:10:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:32 INFO - 'XPC_FLAGS': '0x0', 18:10:32 INFO - 'XPC_SERVICE_NAME': '0', 18:10:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:10:32 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-fY0JUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:10:32 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-V6ypyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:10:33 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-OpyZmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:10:33 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-yihlsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:10:33 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-fTAgus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:10:33 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-reAq4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:10:33 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-1BOGxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:10:33 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-esQwtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:10:33 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-Jm7blZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:10:33 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-9vHe1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:10:33 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-HpGgYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:10:34 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-5gTmrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:10:34 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-eVDIDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:10:34 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-2AoMoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:10:34 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-J0z3xc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:10:34 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-iBjKM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:10:34 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-wJGOyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:10:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:10:34 INFO - Running setup.py install for manifestparser 18:10:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:10:34 INFO - Running setup.py install for mozcrash 18:10:34 INFO - Running setup.py install for mozdebug 18:10:35 INFO - Running setup.py install for mozdevice 18:10:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:10:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:10:35 INFO - Running setup.py install for mozfile 18:10:35 INFO - Running setup.py install for mozhttpd 18:10:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:10:35 INFO - Running setup.py install for mozinfo 18:10:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:10:35 INFO - Running setup.py install for mozInstall 18:10:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:10:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:10:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:10:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:10:35 INFO - Running setup.py install for mozleak 18:10:35 INFO - Running setup.py install for mozlog 18:10:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:10:36 INFO - Running setup.py install for moznetwork 18:10:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:10:36 INFO - Running setup.py install for mozprocess 18:10:36 INFO - Running setup.py install for mozprofile 18:10:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:10:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:10:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:10:36 INFO - Running setup.py install for mozrunner 18:10:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:10:36 INFO - Running setup.py install for mozscreenshot 18:10:36 INFO - Running setup.py install for moztest 18:10:37 INFO - Running setup.py install for mozversion 18:10:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:10:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:10:37 INFO - Cleaning up... 18:10:37 INFO - Return code: 0 18:10:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:37 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 0x10b194b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b197768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeab4be0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af72d30>, '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 0x10ae99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af67be8>, '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.U018OGi7eh/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.CWEybJlRmi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 18:10:37 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 18:10:37 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 18:10:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U018OGi7eh/Render', 18:10:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:37 INFO - 'HOME': '/Users/cltbld', 18:10:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:37 INFO - 'LOGNAME': 'cltbld', 18:10:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:37 INFO - 'MOZ_NO_REMOTE': '1', 18:10:37 INFO - 'NO_EM_RESTART': '1', 18:10:37 INFO - 'PAGER': '/bin/cat', 18:10:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:37 INFO - 'PWD': '/builds/slave/test', 18:10:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:37 INFO - 'SHELL': '/bin/bash', 18:10:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CWEybJlRmi/Listeners', 18:10:37 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 18:10:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:37 INFO - 'USER': 'cltbld', 18:10:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:37 INFO - 'XPC_FLAGS': '0x0', 18:10:37 INFO - 'XPC_SERVICE_NAME': '0', 18:10:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:10:37 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-0u5FDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:10:37 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)) 18:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:10:37 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-GYhkwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:10:37 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)) 18:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:10:37 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-E1glfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:10:37 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)) 18:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:10:37 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-YiJvx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:10:37 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)) 18:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:10:37 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-nW4CJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:10:38 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)) 18:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:10:38 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-2sn5yY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:10:38 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)) 18:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:10:38 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-WOdjr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:10:38 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)) 18:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:10:38 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-1Qembz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:10:38 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)) 18:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:10:38 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-UN6m6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:10:38 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)) 18:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:10:38 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-nB2uLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:10:38 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)) 18:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:10:38 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-cs6GqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:10:38 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)) 18:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:10:38 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-kUGRJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:10:38 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)) 18:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:10:38 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-c_5aJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:10:38 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)) 18:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:10:38 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-3VM1Bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:10:38 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)) 18:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:10:38 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-B371Fq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:10:39 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)) 18:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:10:39 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-O0xVAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:10:39 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)) 18:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:10:39 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-SPQVct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:10:39 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)) 18:10:39 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)) 18:10:39 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)) 18:10:39 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)) 18:10:39 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)) 18:10:39 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)) 18:10:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:40 INFO - Downloading blessings-1.6.tar.gz 18:10:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:10:40 INFO - Installing collected packages: blessings 18:10:40 INFO - Running setup.py install for blessings 18:10:40 INFO - Successfully installed blessings 18:10:40 INFO - Cleaning up... 18:10:41 INFO - Return code: 0 18:10:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:10:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:10:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:10:41 INFO - Reading from file tmpfile_stdout 18:10:41 INFO - Current package versions: 18:10:41 INFO - blessings == 1.6 18:10:41 INFO - blobuploader == 1.2.4 18:10:41 INFO - docopt == 0.6.1 18:10:41 INFO - functools32 == 3.2.3-2 18:10:41 INFO - jsonschema == 2.5.1 18:10:41 INFO - manifestparser == 1.1 18:10:41 INFO - mozInstall == 1.12 18:10:41 INFO - mozcrash == 1.0 18:10:41 INFO - mozdebug == 0.1 18:10:41 INFO - mozdevice == 0.49 18:10:41 INFO - mozfile == 1.2 18:10:41 INFO - mozhttpd == 0.7 18:10:41 INFO - mozinfo == 0.9 18:10:41 INFO - mozleak == 0.1 18:10:41 INFO - mozlog == 3.4 18:10:41 INFO - moznetwork == 0.27 18:10:41 INFO - mozprocess == 0.25 18:10:41 INFO - mozprofile == 0.28 18:10:41 INFO - mozrunner == 6.13 18:10:41 INFO - mozscreenshot == 0.1 18:10:41 INFO - mozsystemmonitor == 0.3 18:10:41 INFO - moztest == 0.8 18:10:41 INFO - mozversion == 1.4 18:10:41 INFO - psutil == 3.1.1 18:10:41 INFO - requests == 1.2.3 18:10:41 INFO - wsgiref == 0.1.2 18:10:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:41 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 0x10b194b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b197768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeab4be0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af72d30>, '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 0x10ae99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af67be8>, '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.U018OGi7eh/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.CWEybJlRmi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 18:10:41 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 18:10:41 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 18:10:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U018OGi7eh/Render', 18:10:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:41 INFO - 'HOME': '/Users/cltbld', 18:10:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:41 INFO - 'LOGNAME': 'cltbld', 18:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:41 INFO - 'MOZ_NO_REMOTE': '1', 18:10:41 INFO - 'NO_EM_RESTART': '1', 18:10:41 INFO - 'PAGER': '/bin/cat', 18:10:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:41 INFO - 'PWD': '/builds/slave/test', 18:10:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:41 INFO - 'SHELL': '/bin/bash', 18:10:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CWEybJlRmi/Listeners', 18:10:41 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 18:10:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:41 INFO - 'USER': 'cltbld', 18:10:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:41 INFO - 'XPC_FLAGS': '0x0', 18:10:41 INFO - 'XPC_SERVICE_NAME': '0', 18:10:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:41 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)) 18:10:41 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)) 18:10:41 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)) 18:10:41 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)) 18:10:41 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)) 18:10:41 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)) 18:10:41 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)) 18:10:41 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)) 18:10:41 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)) 18:10:41 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)) 18:10:41 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)) 18:10:41 INFO - Cleaning up... 18:10:41 INFO - Return code: 0 18:10:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:41 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 0x10b194b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b197768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeab4be0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af72d30>, '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 0x10ae99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af67be8>, '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.U018OGi7eh/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.CWEybJlRmi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 18:10:41 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 18:10:41 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 18:10:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U018OGi7eh/Render', 18:10:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:41 INFO - 'HOME': '/Users/cltbld', 18:10:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:41 INFO - 'LOGNAME': 'cltbld', 18:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:41 INFO - 'MOZ_NO_REMOTE': '1', 18:10:41 INFO - 'NO_EM_RESTART': '1', 18:10:41 INFO - 'PAGER': '/bin/cat', 18:10:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:41 INFO - 'PWD': '/builds/slave/test', 18:10:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:41 INFO - 'SHELL': '/bin/bash', 18:10:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CWEybJlRmi/Listeners', 18:10:41 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 18:10:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:41 INFO - 'USER': 'cltbld', 18:10:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:41 INFO - 'XPC_FLAGS': '0x0', 18:10:41 INFO - 'XPC_SERVICE_NAME': '0', 18:10:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:10:41 INFO - Cleaning up... 18:10:41 INFO - Return code: 0 18:10:41 INFO - Running post-action listener: _resource_record_post_action 18:10:41 INFO - Running post-action listener: _start_resource_monitoring 18:10:41 INFO - Starting resource monitoring. 18:10:41 INFO - [mozharness: 2017-05-10 01:10:41.869172Z] Finished create-virtualenv step (success) 18:10:41 INFO - [mozharness: 2017-05-10 01:10:41.870115Z] Running install step. 18:10:41 INFO - Running pre-action listener: _resource_record_pre_action 18:10:41 INFO - Running main action method: install 18:10:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:10:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:10:42 INFO - Reading from file tmpfile_stdout 18:10:42 INFO - Detecting whether we're running mozinstall >=1.0... 18:10:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:10:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:10:42 INFO - Reading from file tmpfile_stdout 18:10:42 INFO - Output received: 18:10:42 INFO - Usage: mozinstall [options] installer 18:10:42 INFO - Options: 18:10:42 INFO - -h, --help show this help message and exit 18:10:42 INFO - -d DEST, --destination=DEST 18:10:42 INFO - Directory to install application into. [default: 18:10:42 INFO - "/builds/slave/test"] 18:10:42 INFO - --app=APP Application being installed. [default: firefox] 18:10:42 INFO - mkdir: /builds/slave/test/build/application 18:10:42 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'] 18:10:42 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 18:10:57 INFO - Reading from file tmpfile_stdout 18:10:57 INFO - Output received: 18:10:57 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 18:10:57 INFO - Running post-action listener: _resource_record_post_action 18:10:57 INFO - [mozharness: 2017-05-10 01:10:57.302880Z] Finished install step (success) 18:10:57 INFO - [mozharness: 2017-05-10 01:10:57.303008Z] Running run-tests step. 18:10:57 INFO - Running pre-action listener: _resource_record_pre_action 18:10:57 INFO - Running main action method: run_tests 18:10:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:10:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:10:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:10:57 INFO - 2017-05-09 18:10:57.318 screenresolution[1630:7468] starting screenresolution argv=screenresolution get 18:10:57 INFO - 2017-05-09 18:10:57.320 screenresolution[1630:7468] Display 0: 1600x1200x32@60 18:10:57 INFO - 2017-05-09 18:10:57.326 screenresolution[1631:7470] starting screenresolution argv=screenresolution list 18:10:57 INFO - Available Modes on Display 0 18:10:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:10:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:10:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:10:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:10:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:10:57 INFO - Intel Iris: 18:10:57 INFO - Chipset Model: Intel Iris 18:10:57 INFO - Type: GPU 18:10:57 INFO - Bus: Built-In 18:10:57 INFO - VRAM (Dynamic, Max): 1536 MB 18:10:57 INFO - Vendor: Intel (0x8086) 18:10:57 INFO - Device ID: 0x0a2e 18:10:57 INFO - Revision ID: 0x0009 18:10:57 INFO - Displays: 18:10:57 INFO - Display: 18:10:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:10:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:10:57 INFO - Display Serial Number: 1600x1200 60 18:10:57 INFO - Main Display: Yes 18:10:57 INFO - Mirror: Off 18:10:57 INFO - Online: Yes 18:10:57 INFO - Rotation: Supported 18:10:57 INFO - Return code: 0 18:10:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:10:57 INFO - Python 2.7.3 18:10:57 INFO - Return code: 0 18:10:57 INFO - grabbing minidump binary from tooltool 18:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:57 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 0x10af72d30>, '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 0x10ae99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af67be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:10:57 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 18:10:57 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 18:10:57 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 18:10:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:10:57 INFO - Return code: 0 18:10:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:10:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:10:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:10:57 INFO - ENV: RUST_BACKTRACE is now 1 18:10:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:10:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:10:57 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/R5LOVKxHQXmkX6fD0zF5qg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0206', '--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 18:10:57 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/R5LOVKxHQXmkX6fD0zF5qg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0206 --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 18:10:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U018OGi7eh/Render', 18:10:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:57 INFO - 'HOME': '/Users/cltbld', 18:10:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:57 INFO - 'LOGNAME': 'cltbld', 18:10:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:10:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:57 INFO - 'MOZ_NO_REMOTE': '1', 18:10:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:10:57 INFO - 'NO_EM_RESTART': '1', 18:10:57 INFO - 'PAGER': '/bin/cat', 18:10:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:57 INFO - 'PWD': '/builds/slave/test', 18:10:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:10:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:57 INFO - 'RUST_BACKTRACE': '1', 18:10:57 INFO - 'SHELL': '/bin/bash', 18:10:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CWEybJlRmi/Listeners', 18:10:57 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 18:10:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:57 INFO - 'USER': 'cltbld', 18:10:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:57 INFO - 'XPC_FLAGS': '0x0', 18:10:57 INFO - 'XPC_SERVICE_NAME': '0', 18:10:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:57 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/R5LOVKxHQXmkX6fD0zF5qg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0206', '--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 18:10:57 INFO - mozversion application_buildid: 20170509162817 18:10:57 INFO - mozversion application_changeset: a19d8e32acfe02ee96b810bd93e438fee68a7fb6 18:10:57 INFO - mozversion application_display_name: Firefox 18:10:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:10:57 INFO - mozversion application_name: Firefox 18:10:57 INFO - mozversion application_remotingname: firefox 18:10:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 18:10:57 INFO - mozversion application_vendor: Mozilla 18:10:57 INFO - mozversion application_version: 54.0 18:10:57 INFO - mozversion platform_buildid: 20170509162817 18:10:57 INFO - mozversion platform_changeset: a19d8e32acfe02ee96b810bd93e438fee68a7fb6 18:10:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 18:10:57 INFO - mozversion platform_version: 54.0 18:10:57 INFO - using testdate: 1494378657 18:10:57 INFO - actual date: 1494378657 18:10:57 INFO - starting webserver on 'localhost:49235' 18:10:57 INFO - SUITE-START | Running 2 tests 18:10:57 INFO - TEST-START | dromaeo_css 18:10:57 INFO - operating with platform_type : mac_ 18:10:57 INFO - Initialising browser for dromaeo_css test... 18:10:57 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/tmpl4vqf7/profile http://localhost:49235/getInfo.html) 18:11:00 INFO - PROCESS | 1641 | 2017-05-09 18:11:00.792 plugin-container[1644:7637] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a53, name = 'com.apple.tsm.portname' 18:11:00 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:11:00 INFO - PROCESS | 1641 | 2017-05-09 18:11:00.792 plugin-container[1644:7637] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 18:11:00 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:11:00 INFO - PROCESS | 1641 | 2017-05-09 18:11:00.792 plugin-container[1644:7637] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:11:00 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 18:11:00 INFO - PROCESS | 1641 | colorDepth:24 18:11:00 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 18:11:00 INFO - PROCESS | 1641 | __metrics 18:11:00 ERROR - PROCESS | 1641 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 18:11:01 INFO - TEST-INFO | 1641: exit 0 18:11:01 INFO - Browser initialized. 18:11:01 INFO - Running cycle 1/1 for dromaeo_css test... 18:11:01 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/tmpl4vqf7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:11:03 INFO - PROCESS | 1645 | 2017-05-09 18:11:03.868 plugin-container[1646:7779] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x844f, name = 'com.apple.tsm.portname' 18:11:03 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:11:03 INFO - PROCESS | 1645 | 2017-05-09 18:11:03.868 plugin-container[1646:7779] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b03, name = 'com.apple.CFPasteboardClient' 18:11:03 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:11:03 INFO - PROCESS | 1645 | 2017-05-09 18:11:03.868 plugin-container[1646:7779] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:11:13 INFO - PROCESS | 1645 | RSS: Main: 174243840 18:11:13 INFO - PROCESS | 1645 | 18:14:16 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 18:14:18 INFO - PROCESS | 1645 | RSS: Main: 189259776 18:14:18 INFO - PROCESS | 1645 | 18:17:20 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 18:17:21 INFO - PROCESS | 1645 | RSS: Main: 199675904 18:17:21 INFO - PROCESS | 1645 | 18:20:23 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 18:20:23 INFO - PROCESS | 1645 | RSS: Main: 203280384 18:20:23 INFO - PROCESS | 1645 | 18:23:25 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 18:23:26 INFO - PROCESS | 1645 | RSS: Main: 207138816 18:23:26 INFO - PROCESS | 1645 | 18:26:29 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 18:26:29 INFO - PROCESS | 1645 | RSS: Main: 209764352 18:26:29 INFO - PROCESS | 1645 | 18:29:32 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 18:29:32 INFO - PROCESS | 1645 | RSS: Main: 207650816 18:29:32 INFO - PROCESS | 1645 | 18:29:32 INFO - PROCESS | 1645 | __start_tp_report 18:29:32 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 18:29:32 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 18:29:32 INFO - PROCESS | 1645 | |i|pagename|runs| 18:29:32 INFO - PROCESS | 1645 | |0;dojo.html;3586.4082426399646;3590.9640903590957;3608.2783443311346;3637.8726744563946;3654.086478380405;4482.30524268738;6185.319614842364;6185.505159587234;6221.751129954808;6236.220472440945;6090.269167699882;6100.603460775046;6101.633901965885;6148.6618235997;6149.477294429978;5375.623706340568;5433.483819037185;5438.075527160392;5447.536959358459;5508.862278443051;5497.697626630534;5515.09001014832;5525.723713814293;5534.833954981357;5570.248016517779;5411.350637923455;5439.129739241722;5459.099248623992;5513.9448605513835;5523.475269849358;5609.887802243932;5619.381867994517;5625.46558076982;5645.096784514499;5651.689157096358;5557.138643510262;5625.54995600351;5643.6049476536655;5655.8586035349035;5682.971585142048;5613.915791263134;5981.820545383645;6243.594166379171;6286.402791734778;6297.27581328144;5400.378956419983;6370.681465926685;6469.51478639104;6511.641859697715;6528.347165283481;6722.260551339349;6725.327467253284;6730.226024007253;6731.798046058626;6748.582797612507;6285.182926219653;6295.24457065146;6315.147455093549;6344.841378965517;6356.8410789729705;5870.882582348329;6312.810615681537;6506.056621789814;6696.330366963265;6815.659217039228;6438.420542151229;6476.740930362733;6486.318936511692;6489.415952564292;6510.804675859732;6596.307387724316;6611.305812889577;6641.402273795382;6667.599944003376;6683.398494135551;6282.308946016026;6303.149074874925;6376.713047912763;6537.313582073909;6565.901511477332;5346.97326513365;6273.8745225095245;6513.12072870166;6608.900866487006;6611.636360000246;5191.974040129775;5227.006868694936;5228.6339956203465;5231.450697676689;5271.683698978073;4150.958490415057;4243.387512745137;4635.490096089427;4675.509071547506;4676.859694209179;5289.471052894757;5869.559783016291;6280.5603607747935;6297.023961286008;6305.274893387227;6512.967435162888;6513.316101809337;6527.053577231275;6576.5067619928695;6601.33986601336;6322.114903913363;6322.462590679844;6336.398042185985;6349.9682501587195;6370.458511026614;5894.469497745224;5913;5923.437273459014;5930.851728706817;5948.940510594925;6551.705173267214;6559.278479367361;6773.322667733188;6825.419839313615;6825.931740682529;6614.140161778938;6695.799126026227;6698.598084114774;6703.798886033427;6736.225334086643;6816.947717139591;6904.861902761816;6949.513534052568;6950.930490695028;6975.407090397373;6290.339514350927;6311.936880631135;6483.902741458787;6578.80263592093;6582.243042050225;6554.705038273384;6660.533762636569;6698.531102822755;6705.2959439258175;6738.66306684654;6422.3577642235405;6464.806055818145;6481.319461456667;6482.319356467503;6488.578242414228;5570.331560212639;6237.781677641261;6257.937420625735;6381.904271436025;6500.382463665944;5639.689817060101;5762.913556296743;5827.6794776286015;6303.275123360872;6306.46395056407;6474.4173024426145;6479.028145778171;6498.577592456475;6498.870022599427;6506.934930650633;6183.628982261079;6242.719077641608;6279.183706118358;6279.372062793684;6330.3669633036325 18:29:32 INFO - PROCESS | 1645 | |1;ext.html;788.0267869181563;831.5758962928907;851.5188918261184;926.6061923682433;984.0405604535574;35342.64657353432;39881.601183988154;40774.796126019406;42502;42786.572134278606;40653.390199147034;40715;40955.77132686024;40961.566345177926;40995.38506922399;8327.375446841495;8439.113893041234;11052.613158539452;11301.717457063556;11706.122040846927;11348.943255283712;11413;11491.080713542897;11491.540338386454;11492.425378731072;11356.545738170464;11467.139964502654;11474.942625286862;11477.368744719037;11483.885161148406;9037.909620903773;11385.943070284637;11419.257748246337;11446.48490817911;11459.427028648533;10853.51159197838;10871.565137394495;10878.72803179919;10917.344959302467;10974.231803773739;35021;35082.473762893576;35248.471272930925;35381.64618353809;35455.75904843318;3937.4881265435597;3946.8223929922933;3978.980105099456;4001.4397984282223;4044.474218351625;26063.478730425286;26327.73672263272;26514.73485265161;27536;27576;3218.5815843940372;3256.3975664501904;3293.6212335581477;3294.7364210863075;3408.7784294021058;357842;360897;376383;379054;394755;44699;44853;44918;44956.55043449589;45635;46650.367237146536;46804.76597617058;46909.53090469052;47031.29453058207;47230.291545626846;11545.538178472934;14344.784828227585;14471.710565788626;14506.709865802835;14509;12428.75142497145;12641.620751377473;12693.048021398432;12710.745785084431;12730.554430594884;12143;12150.513979440724;12161.756764864653;12206.291119243313;12229.755404891852;4752.477227504972;5651.067573850269;5689.089745640677;5703.287089113861;5707.686077265707;1136.2671077155353;1156.2888823373733;1157.3345326437332;1178.5933852820763;1212.6968257935516;26823.195304140907;27367.92646169385;27528;27708.722912771016;29209.707902921124;996.277698668474;1102.9779404412027;1108.512254607986;1119.5857532712785;1150.2753265442718;15573.987690800062;16664.416745414095;17193;17201.1399430028;17422.564435889206;507784;510449;510517;511296;512209;61689.691551542855;61942.38057619366;62043;62264;62305;1532.2415404374906;1576.0386164439683;1580.5258422473212;1584.3504163292994;1592.2118551316942;30107.69892301049;31083.067507974796;31571.21071973219;31778;32072.5189122168;36020;36517.45223821592;50997.470075897785;51667.483325166264;52121.696957576365;407276;408682.9565852152;411361;411571;413170;27810.74851631641;28375.858120709265;33006.50490242696;33352.33295334128;34957.30085398329;41075.97310067272;41092.383614246406;41144;41456.75629731113;42037.949051273965;28297;28537.28656783597;28602;29114;30038.948636797606;29568;29818.31934194867;30165.396692066475;31465.21336966594;31612.893548725686;35539.82230088833;36056.639433606375;36278;36354.27291454209;36384.27231455409;29596.852015739783;30223.546646800754;30271.9404820839;30466.390672186877;30828.612712428443;21087;21954.34136975893;24202.15292464755;24556.38609034717;24688.50622987566 18:29:32 INFO - PROCESS | 1645 | |2;jquery.html;418.3933296719757;431.2410158121705;431.7802208760252;442.38950248656846;447.01433339486437;18078.186481608325;19944.202231910724;20636.071376788044;22108.447288817788;22803.885980570114;22818.31545053651;23100.960456779445;23656.645150322758;23714.881425592892;23969.5206095878;6800.183977922631;6879.8624027519545;6981.965090174542;7157.3916217121605;7168.498205125643;6880.483963702717;7008.789736307919;7012.579245245276;7016.7544135954995;7710.691572337099;8106.432549721522;8126.593670316461;8185.508869467822;8222.958885205595;8231.83536329273;7989.360851131924;8081.959590202041;8118.10700822909;8158.877616835753;8172.918270817275;6839.418649414805;7722.459427840054;7991.880121798177;8017.398695097891;8026.077001144827;27184.864075679692;29604.70395296041;30849.537256941163;31037.689623103706;31436.05691829249;3090.1965488972805;3359.1434184283094;3379.662033796625;3538.8230588470733;3568.571771387424;14179.220142892136;17304.91347543267;17475.737863932052;17573.7363939541;17766.91116544422;2087.290321290753;2127.5213077057538;2128.3508529898377;2144.1101942693917;2214.878181700006;160011;161437;164086.1795691026;185054.99999999866;187651.0617446904;25546.872265638554;26579.069732559266;27552.724472755417;27566.5865012025;27572.586411203847;35086.64913350885;44509.55490445054;44526.77366131745;45903;45939.310910336375;12116.030717542575;12417.75164496705;12448.377581120907;12493.50025998968;12588.87411125877;10065.647702330383;10120.848187277197;10124.139448146843;10166.390016599027;10264.230182736324;9803.705888823346;11725;12025.699357516132;12032.639020829389;12076;4488.798004089824;4563.977180114078;4819.783109760069;4880.8779780505065;4952.504749525018;851.438050886412;920.3787443475627;932.7108596335022;961.3703024518951;974.5760594141572;22765.430864228525;22847.200347987742;23153.813353430407;23255.18606848786;23312.950917208767;952.4285428742699;962.7063745557532;963.6290028339;971.2909576009412;985.1970643925322;9347.813043739086;12379.69050773738;12751.107422480338;12950.287734174522;13015.544455944186;529360;529705;530966;701886;728407;96336.51831740796;110614.44692776646;141621;153969.4603053955;155025.22487387492;1197.0124647165949;1302.9413676384586;1337.739140867541;1380.178793617816;1384.1072508232135;16917.238724257193;18075.46358559537;19672.311469098513;20115.39653810388;20234.79765202329;60678;61441;62275.13174604769;62316.37683623106;62920;81991;83241.58379208065;83840.58079709807;84680;85881;8453.408261421642;11607.30356178632;11808.291502509877;11842.993345565379;12012.819807703067;12949.870501295243;13016.28410437435;13053.02102342309;13288.800667990181;13370.465181392636;10940.890591094305;11206.943965280121;11309.773804524028;11443.485043173243;11461.197716159788;9984.251181161588;10007.899921000697;10114.898851011396;10247.282690211614;10282.485875706036;9474.715758527254;11078.889211107786;11600.767984640092;11728.061755059403;11728.882711172779;11704.180707350404;11725.41372931367;11925.224860384395;12037.916587507167;12057.336846473529;11525.596604118815;11532.308061516336;11644.53421863116;11761.705957351134;11944.283342999448 18:29:32 INFO - PROCESS | 1645 | |3;mootools.html;1478.3125846481387;1598.0252046251778;1621.4811260396677;1625.699245639556;1636.2963925512033;9848.21214302854;10119.69640910772;11082.445877706112;11779.23434976726;11809.586664466746;10988.450577471134;11373.601923932663;11398.145139114558;11539.365334906577;11540.019098376648;1951.780137414116;2277.521720438706;2309.145616122029;2312.9306120816404;2316.2356422380576;2407.723111842143;2421.370443684637;2426.696662917135;2434.9269521914284;2442.572549803786;1864.9067546622682;2242.9439264018365;2257.548490301946;2258.5369999150216;2270.4550907782177;2371.3360259127385;2371.9525609487714;2375.4536456615074;2376.500934803676;2403.8677872716994;1847.8429333506667;2404.771546703078;2420.552197843387;2422.697162854643;2424.963625545618;9873;11224.943875280653;11412.372319522423;11483.13876459269;11527.13546484017;5252.634315078069;5819;5843.298804143487;6001.609895356788;6001.699915004232;3411.283630437611;3533.840977156034;3709.8145092745253;3734.906627334311;3760.5897788329376;1197.9580714674944;1246.345668524023;1264.2035517623838;1310.678883673506;1319.089828018664;15824.446144385007;15884.602884927854;15893.364265429369;15895.841041589667;15912.761308580264;4700.7179569225955;4902.4362198346935;4932.235503496964;4946.08497427977;4991.176455884811;13279.269640169883;13340.399682014333;13354.332283385791;13362.599122026355;13383.263920484273;5993.220881285405;6029.186059881948;6037.6679282639;6040.063790112539;6042.969785151134;4363.629091527192;5215.530602245816;5354.330708661418;5376.327959005124;5387.892242155135;4105.747746937153;4155.937660935088;4166.500019997619;4187.602177793105;4197.223513649985;1123.3203911633343;1125.909927205838;1128.430142777892;1134.1833879606836;1135.6195674449152;948.7011591348703;949.6723630347519;971.9611215551299;978.5498670611598;1011.418275213285;6599.901001484982;6663.500237482208;6683.198016237985;6849.828754281083;6934.583924964519;994.2592768387453;1017.8752478511286;1025.6358992557534;1043.6138628707274;1058.655936820521;3953.8566839362775;4099.344104943195;4143.777585612252;4307.396964424983;4349.238883195429;11585.362805045635;13777.586672399844;13787.172769633855;13879.722405552035;13891.235982020884;13296.268705221113;13716.314184290944;13786.310684465736;13920.025598208029;13936.512222072179;9457.91234008084;9819.9018009819;10237.23220758446;10374.429406382722;10561.524731387106;6521.576097553644;6567.704453299709;6639.170103737033;6691.665416729047;6751.966240168767;12233.3271670059;12258.570950016707;12308.876911230773;12391.75216495683;12438.689032774253;12648.177868438523;12776;12817.679558011125;12932.482700691868;13043.282619455642;9377.624895004396;9395.483248421402;9407.43555386679;9442.008589098046;9496.240300775784;10386.844197336895;10407.427591482541;10502.737431564272;10505.107065899485;10513.106385956973;7505.437092217996;7517.661705223169;7525.435592330487;8889.911100889167;8950.373473856767;6484.578502397329;7229.530080544748;7255.56466612005;7280.453965952681;7349.338559529668;6770;7653.349465295512;7838.372930165687;7972.800679983046;8055.395845311742;5436.972815135899;5513.5037846594;5555.00009998188;5701.087825947829;5736.42635736423;5768.134779783066;5960.046392577166;6006.87986240264;6129.877402451837;6144.907826382519 18:29:32 INFO - PROCESS | 1645 | |4;prototype.html;392.5524901612161;396.1937457274447;396.8987908083439;397.89058009047505;399.65629558579633;4626.866417727657;5321.973390133054;5346.326836581709;5386.55260633195;5430.56555475562;4270.765107919063;5042.495750424956;5313.57491400688;5319.143620874874;5319.989202051607;3391.96608033919;4122.216778812031;4153.840003198335;4164.3961625564425;4169.457300798708;3430.382531144393;3556.28874225156;4169.457970463851;4208.894777630569;4241.597048280409;3887.300285948528;4004.5594984551676;4163.521195062576;4187.539370669239;4202.474690663667;3598.478220658016;3637.544657356274;4078.225137223918;4117.300058989979;4142.979285103585;3152.7162555369896;3568.678818906311;3704.2776658551593;3729.384651532494;3736.9439458408146;4481.887952801206;4956.157453232959;5221.6083793715625;5225.477452254782;5234.659747116425;4423.51341352451;4800.791635847514;4846.5880400166025;4900.534449227318;5104.9744751276;5211.609129315317;5273.789048438096;5526.894621075801;5622.887542249173;5711.228984087178;4098.549159592442;4136.338185890273;4542.841000564964;4546.590806827368;4670.435404139617;4845.297431872394;5245.423003469616;5324.627276090714;5599.496045355938;5782.848347650541;4592.494825569184;4681.438227412732;4731.361266229083;4732.716037037789;4760.59534939534;4326.286162783105;4505.61702255312;4616.399208617284;4859.975700121548;4888.60891128716;4303.472267345048;4485.46174459067;4586.220342541776;4920.434150072788;5169.862630221345;4734.976325118352;5280.313559237351;5489.282805011465;5492.890142197213;5751.85620359486;1329.335332333833;1480.9411270941114;1514.0317587136678;1533.8496127904073;1612.2825342722376;991.4844280973854;1005.1054561440324;1116.3636727065657;1211.497228650118;1217.0202986595875;4762.547557982056;4866.741601099038;5341.370881881064;5458.5087342139395;5486.286782718301;5074.797008119708;5147.948520514822;5590.748416321276;5750.016244395677;5914.556408269397;4730.52306554682;4848.03039392123;4886.389201349832;5092.6435149539175;5265.894682106336;3068.8925887593828;3083.152133163353;3103.4413805515223;3108.3161704425443;3111.191090316489;5176.80933385316;5633.267675202197;6102.877942441126;6114.969425152845;6269.749210031548;4936.6297527685565;5540.7006092471975;5919.348871624118;6014.894786824577;6021.548383871227;5695.772169113189;5758.366579676316;5890.49930755882;6123.203983482119;6176.629402235881;5305.487935938239;5486.50621444056;5644.8024319148635;5975.790847320497;6050.515958723379;5857.736401861841;5860.066178161282;5891.440313170242;5897.351291357862;5924.437178468039;5447.319085114361;5602.551795856403;5651.717414129195;5668.858278542904;5686.317641883001;4072.837086516506;4200.348945913388;4641.907161856811;4655.72065676047;4658.627309815139;5634.414975058163;5674.971625141848;5938.910916336345;5943.138244954544;5997.070454079625;4724.881877953078;5486.725663716878;5546.112621980626;5554.2779438672715;5722.370539240764;5111.2621708619245;5115.18157094863;5124.9743751281;5149.021685879671;5831.7375718091935;4680.929786053144;5281.603879709114;5618.971905140448;5668.348139963792;5676.262085928803;4970.130227210296;5461.9453805461435;5487.807926722546;5688.288963879515;5805.332386775406;4695.436547614171;5385.030694475032;5631.8592035199445;5662.5469962402085;5676.148577713211 18:29:32 INFO - PROCESS | 1645 | |5;yui.html;680.5644387591942;761.93904487641;901.5086777706149;903.2954295649394;911.7401540560942;16743.162841857906;17036.403725869583;17079.91460042701;17577.29690812366;17580.208890599923;16275.674486510263;16301.83698163018;16314.021158730455;16388.26252818623;16509.33962641493;984.5372674842848;987.965421210256;1008.8890222075565;1016.9694909152701;1023.0434543701625;1012.4128005756644;1021.0606242257104;1025.1952217509256;1025.8461230815362;1029.4543891737392;1055.5883205549842;1064.6486659402417;1072.6460268111505;1073.683263437284;1076.8061748885198;1064.5741703318656;1066.306900514664;1066.568039943824;1067.7864427114569;1069.2301542889106;786.5949036246337;786.8072322281078;789.498668345599;789.5026133535893;790.1269097647074;16715.331386744514;16961.57596060096;17760.023198724066;18324.175412106488;18645.627087458175;14478.782818257734;14801.259937003108;14815.18516481593;14906.105633662015;15124.168170750605;11738.706532336675;12052.397380130958;12099.334536600483;12147.149699521036;12337.69155771104;3863;3880.546482912459;3895.61043895611;3940.192260586573;3972.6226008529143;112514;117325.99999999914;120614.9846253842;120718.79281207251;121705.39147304295;11547.538098475967;11649.47577359021;11687.590934317259;11757.412129393497;12221.144519883523;23811.642825357634;24084.27747167588;24478.87760561186;24552;24583.508329833305;8202.671893124327;8204.712835050745;8219.506829590244;8398.882012377695;8417.70538031166;3935.586763389803;4556.20266453376;4702.506236845151;4715.24556071027;4793.01743142655;3648.4162533994963;3728.3848165052464;3734.2344819311975;3761.8307176177136;3883.475730776309;652.9869402611921;656.4289068510426;658.5291516565678;668.9632070236087;669.3072669786748;684.7055766020659;698.4935921456903;716.77421612192;724.6702750248625;744.4354199781808;9075.727728168165;10188.9811018899;10811.324244742078;10982.945085274683;11107.055900248408;705.9047028651066;724.6231959381198;733.3216774483582;737.9188289288174;747.2042274977132;4502.986827963682;5171.224316352577;5173.22401639757;5275.657082289639;5290.762832166976;104691;107325;109485.90514094917;112063.87936120697;112521.43739281251;76423;94481.0551894486;96509.03490965141;97937;98815.50592247136;74139;85630;87589.12410875937;87642.56178719066;87934;10994.450277485934;11149.108071354434;11384.203105782515;11555.364454955059;11653.59212427561;39001;47180.52819471761;47869;48990.75504622597;50663.49336506588;60707.69646151741;62348;62547.6872615634;62581.374186259374;63365.68317158385;13145.310725457784;13425.328733563478;13474.79787803164;13624.04631675773;13733.931330343285;14921.403143874557;14954.925225373803;15138.924305378403;15349.309281082602;15670.686586268439;14123.364448600043;14217.360218790385;14262.001659884123;14430.278486075444;14454.855451445352;14135.293235338399;14163.362648680628;14441.49454769078;14567.198804065878;15030;13858.376373063034;14310.928445357707;14343.641408964859;14377.496787612383;14536.200508972108;10043;10107.241956853119;10139.391636501834;10319.432431216055;10323.587056517656;10133.899428423156;11516.391001330236;11655.125865560287;11658.06735461178;11756.588519402121 18:29:32 INFO - PROCESS | 1645 | __end_tp_report 18:29:32 INFO - PROCESS | 1645 | __start_cc_report 18:29:32 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,400 18:29:32 INFO - PROCESS | 1645 | __end_cc_report 18:29:32 INFO - PROCESS | 1645 | __startTimestamp1494379772631__endTimestamp 18:29:32 INFO - PROCESS | 1645 | 18:29:32 INFO - PROCESS | 1645 | ------- Summary: start ------- 18:29:32 INFO - PROCESS | 1645 | Number of tests: 6 18:29:32 INFO - PROCESS | 1645 | 18:29:32 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:6068.96 Median:6303.15 stddev:705.96 (11.2%) stddev-sans-first:680.73 18:29:32 INFO - PROCESS | 1645 | Values: 3586.4 3591.0 3608.3 3637.9 3654.1 4482.3 6185.3 6185.5 6221.8 6236.2 6090.3 6100.6 6101.6 6148.7 6149.5 5375.6 5433.5 5438.1 5447.5 5508.9 5497.7 5515.1 5525.7 5534.8 5570.2 5411.4 5439.1 5459.1 5513.9 5523.5 5609.9 5619.4 5625.5 5645.1 5651.7 5557.1 5625.5 5643.6 5655.9 5683.0 5613.9 5981.8 6243.6 6286.4 6297.3 5400.4 6370.7 6469.5 6511.6 6528.3 6722.3 6725.3 6730.2 6731.8 6748.6 6285.2 6295.2 6315.1 6344.8 6356.8 5870.9 6312.8 6506.1 6696.3 6815.7 6438.4 6476.7 6486.3 6489.4 6510.8 6596.3 6611.3 6641.4 6667.6 6683.4 6282.3 6303.1 6376.7 6537.3 6565.9 5347.0 6273.9 6513.1 6608.9 6611.6 5192.0 5227.0 5228.6 5231.5 5271.7 4151.0 4243.4 4635.5 4675.5 4676.9 5289.5 5869.6 6280.6 6297.0 6305.3 6513.0 6513.3 6527.1 6576.5 6601.3 6322.1 6322.5 6336.4 6350.0 6370.5 5894.5 5913.0 5923.4 5930.9 5948.9 6551.7 6559.3 6773.3 6825.4 6825.9 6614.1 6695.8 6698.6 6703.8 6736.2 6816.9 6904.9 6949.5 6950.9 6975.4 6290.3 6311.9 6483.9 6578.8 6582.2 6554.7 6660.5 6698.5 6705.3 6738.7 6422.4 6464.8 6481.3 6482.3 6488.6 5570.3 6237.8 6257.9 6381.9 6500.4 5639.7 5762.9 5827.7 6303.3 6306.5 6474.4 6479.0 6498.6 6498.9 6506.9 6183.6 6242.7 6279.2 6279.4 6330.4 18:29:32 INFO - PROCESS | 1645 | 18:29:32 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:56839.41 Median:31695.45 stddev:115611.99 (364.8%) stddev-sans-first:115859.72 18:29:32 INFO - PROCESS | 1645 | Values: 788.0 831.6 851.5 926.6 984.0 35342.6 39881.6 40774.8 42502.0 42786.6 40653.4 40715.0 40955.8 40961.6 40995.4 8327.4 8439.1 11052.6 11301.7 11706.1 11348.9 11413.0 11491.1 11491.5 11492.4 11356.5 11467.1 11474.9 11477.4 11483.9 9037.9 11385.9 11419.3 11446.5 11459.4 10853.5 10871.6 10878.7 10917.3 10974.2 35021.0 35082.5 35248.5 35381.6 35455.8 3937.5 3946.8 3979.0 4001.4 4044.5 26063.5 26327.7 26514.7 27536.0 27576.0 3218.6 3256.4 3293.6 3294.7 3408.8 357842.0 360897.0 376383.0 379054.0 394755.0 44699.0 44853.0 44918.0 44956.6 45635.0 46650.4 46804.8 46909.5 47031.3 47230.3 11545.5 14344.8 14471.7 14506.7 14509.0 12428.8 12641.6 12693.0 12710.7 12730.6 12143.0 12150.5 12161.8 12206.3 12229.8 4752.5 5651.1 5689.1 5703.3 5707.7 1136.3 1156.3 1157.3 1178.6 1212.7 26823.2 27367.9 27528.0 27708.7 29209.7 996.3 1103.0 1108.5 1119.6 1150.3 15574.0 16664.4 17193.0 17201.1 17422.6 507784.0 510449.0 510517.0 511296.0 512209.0 61689.7 61942.4 62043.0 62264.0 62305.0 1532.2 1576.0 1580.5 1584.4 1592.2 30107.7 31083.1 31571.2 31778.0 32072.5 36020.0 36517.5 50997.5 51667.5 52121.7 407276.0 408683.0 411361.0 411571.0 413170.0 27810.7 28375.9 33006.5 33352.3 34957.3 41076.0 41092.4 41144.0 41456.8 42037.9 28297.0 28537.3 28602.0 29114.0 30038.9 29568.0 29818.3 30165.4 31465.2 31612.9 35539.8 36056.6 36278.0 36354.3 36384.3 29596.9 30223.5 30271.9 30466.4 30828.6 21087.0 21954.3 24202.2 24556.4 24688.5 18:29:32 INFO - PROCESS | 1645 | 18:29:32 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:39859.78 Median:23484.80 stddev:103274.33 (439.7%) stddev-sans-first:103521.58 18:29:32 INFO - PROCESS | 1645 | Values: 418.4 431.2 431.8 442.4 447.0 18078.2 19944.2 20636.1 22108.4 22803.9 22818.3 23101.0 23656.6 23714.9 23969.5 6800.2 6879.9 6982.0 7157.4 7168.5 6880.5 7008.8 7012.6 7016.8 7710.7 8106.4 8126.6 8185.5 8223.0 8231.8 7989.4 8082.0 8118.1 8158.9 8172.9 6839.4 7722.5 7991.9 8017.4 8026.1 27184.9 29604.7 30849.5 31037.7 31436.1 3090.2 3359.1 3379.7 3538.8 3568.6 14179.2 17304.9 17475.7 17573.7 17766.9 2087.3 2127.5 2128.4 2144.1 2214.9 160011.0 161437.0 164086.2 185055.0 187651.1 25546.9 26579.1 27552.7 27566.6 27572.6 35086.6 44509.6 44526.8 45903.0 45939.3 12116.0 12417.8 12448.4 12493.5 12588.9 10065.6 10120.8 10124.1 10166.4 10264.2 9803.7 11725.0 12025.7 12032.6 12076.0 4488.8 4564.0 4819.8 4880.9 4952.5 851.4 920.4 932.7 961.4 974.6 22765.4 22847.2 23153.8 23255.2 23313.0 952.4 962.7 963.6 971.3 985.2 9347.8 12379.7 12751.1 12950.3 13015.5 529360.0 529705.0 530966.0 701886.0 728407.0 96336.5 110614.4 141621.0 153969.5 155025.2 1197.0 1302.9 1337.7 1380.2 1384.1 16917.2 18075.5 19672.3 20115.4 20234.8 60678.0 61441.0 62275.1 62316.4 62920.0 81991.0 83241.6 83840.6 84680.0 85881.0 8453.4 11607.3 11808.3 11843.0 12012.8 12949.9 13016.3 13053.0 13288.8 13370.5 10940.9 11206.9 11309.8 11443.5 11461.2 9984.3 10007.9 10114.9 10247.3 10282.5 9474.7 11078.9 11600.8 11728.1 11728.9 11704.2 11725.4 11925.2 12037.9 12057.3 11525.6 11532.3 11644.5 11761.7 11944.3 18:29:32 INFO - PROCESS | 1645 | 18:29:32 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:6778.80 Median:2422.03 stddev:4324.42 (178.5%) stddev-sans-first:4318.21 18:29:32 INFO - PROCESS | 1645 | Values: 1478.3 1598.0 1621.5 1625.7 1636.3 9848.2 10119.7 11082.4 11779.2 11809.6 10988.5 11373.6 11398.1 11539.4 11540.0 1951.8 2277.5 2309.1 2312.9 2316.2 2407.7 2421.4 2426.7 2434.9 2442.6 1864.9 2242.9 2257.5 2258.5 2270.5 2371.3 2372.0 2375.5 2376.5 2403.9 1847.8 2404.8 2420.6 2422.7 2425.0 9873.0 11224.9 11412.4 11483.1 11527.1 5252.6 5819.0 5843.3 6001.6 6001.7 3411.3 3533.8 3709.8 3734.9 3760.6 1198.0 1246.3 1264.2 1310.7 1319.1 15824.4 15884.6 15893.4 15895.8 15912.8 4700.7 4902.4 4932.2 4946.1 4991.2 13279.3 13340.4 13354.3 13362.6 13383.3 5993.2 6029.2 6037.7 6040.1 6043.0 4363.6 5215.5 5354.3 5376.3 5387.9 4105.7 4155.9 4166.5 4187.6 4197.2 1123.3 1125.9 1128.4 1134.2 1135.6 948.7 949.7 972.0 978.5 1011.4 6599.9 6663.5 6683.2 6849.8 6934.6 994.3 1017.9 1025.6 1043.6 1058.7 3953.9 4099.3 4143.8 4307.4 4349.2 11585.4 13777.6 13787.2 13879.7 13891.2 13296.3 13716.3 13786.3 13920.0 13936.5 9457.9 9819.9 10237.2 10374.4 10561.5 6521.6 6567.7 6639.2 6691.7 6752.0 12233.3 12258.6 12308.9 12391.8 12438.7 12648.2 12776.0 12817.7 12932.5 13043.3 9377.6 9395.5 9407.4 9442.0 9496.2 10386.8 10407.4 10502.7 10505.1 10513.1 7505.4 7517.7 7525.4 8889.9 8950.4 6484.6 7229.5 7255.6 7280.5 7349.3 6770.0 7653.3 7838.4 7972.8 8055.4 5437.0 5513.5 5555.0 5701.1 5736.4 5768.1 5960.0 6006.9 6129.9 6144.9 18:29:32 INFO - PROCESS | 1645 | 18:29:32 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4662.96 Median:5098.81 stddev:1336.45 (26.2%) stddev-sans-first:1301.19 18:29:32 INFO - PROCESS | 1645 | Values: 392.6 396.2 396.9 397.9 399.7 4626.9 5322.0 5346.3 5386.6 5430.6 4270.8 5042.5 5313.6 5319.1 5320.0 3392.0 4122.2 4153.8 4164.4 4169.5 3430.4 3556.3 4169.5 4208.9 4241.6 3887.3 4004.6 4163.5 4187.5 4202.5 3598.5 3637.5 4078.2 4117.3 4143.0 3152.7 3568.7 3704.3 3729.4 3736.9 4481.9 4956.2 5221.6 5225.5 5234.7 4423.5 4800.8 4846.6 4900.5 5105.0 5211.6 5273.8 5526.9 5622.9 5711.2 4098.5 4136.3 4542.8 4546.6 4670.4 4845.3 5245.4 5324.6 5599.5 5782.8 4592.5 4681.4 4731.4 4732.7 4760.6 4326.3 4505.6 4616.4 4860.0 4888.6 4303.5 4485.5 4586.2 4920.4 5169.9 4735.0 5280.3 5489.3 5492.9 5751.9 1329.3 1480.9 1514.0 1533.8 1612.3 991.5 1005.1 1116.4 1211.5 1217.0 4762.5 4866.7 5341.4 5458.5 5486.3 5074.8 5147.9 5590.7 5750.0 5914.6 4730.5 4848.0 4886.4 5092.6 5265.9 3068.9 3083.2 3103.4 3108.3 3111.2 5176.8 5633.3 6102.9 6115.0 6269.7 4936.6 5540.7 5919.3 6014.9 6021.5 5695.8 5758.4 5890.5 6123.2 6176.6 5305.5 5486.5 5644.8 5975.8 6050.5 5857.7 5860.1 5891.4 5897.4 5924.4 5447.3 5602.6 5651.7 5668.9 5686.3 4072.8 4200.3 4641.9 4655.7 4658.6 5634.4 5675.0 5938.9 5943.1 5997.1 4724.9 5486.7 5546.1 5554.3 5722.4 5111.3 5115.2 5125.0 5149.0 5831.7 4680.9 5281.6 5619.0 5668.3 5676.3 4970.1 5461.9 5487.8 5688.3 5805.3 4695.4 5385.0 5631.9 5662.5 5676.1 18:29:32 INFO - PROCESS | 1645 | 18:29:32 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:21583.12 Median:16448.80 stddev:31186.66 (189.6%) stddev-sans-first:31234.65 18:29:32 INFO - PROCESS | 1645 | Values: 680.6 761.9 901.5 903.3 911.7 16743.2 17036.4 17079.9 17577.3 17580.2 16275.7 16301.8 16314.0 16388.3 16509.3 984.5 988.0 1008.9 1017.0 1023.0 1012.4 1021.1 1025.2 1025.8 1029.5 1055.6 1064.6 1072.6 1073.7 1076.8 1064.6 1066.3 1066.6 1067.8 1069.2 786.6 786.8 789.5 789.5 790.1 16715.3 16961.6 17760.0 18324.2 18645.6 14478.8 14801.3 14815.2 14906.1 15124.2 11738.7 12052.4 12099.3 12147.1 12337.7 3863.0 3880.5 3895.6 3940.2 3972.6 112514.0 117326.0 120615.0 120718.8 121705.4 11547.5 11649.5 11687.6 11757.4 12221.1 23811.6 24084.3 24478.9 24552.0 24583.5 8202.7 8204.7 8219.5 8398.9 8417.7 3935.6 4556.2 4702.5 4715.2 4793.0 3648.4 3728.4 3734.2 3761.8 3883.5 653.0 656.4 658.5 669.0 669.3 684.7 698.5 716.8 724.7 744.4 9075.7 10189.0 10811.3 10982.9 11107.1 705.9 724.6 733.3 737.9 747.2 4503.0 5171.2 5173.2 5275.7 5290.8 104691.0 107325.0 109485.9 112063.9 112521.4 76423.0 94481.1 96509.0 97937.0 98815.5 74139.0 85630.0 87589.1 87642.6 87934.0 10994.5 11149.1 11384.2 11555.4 11653.6 39001.0 47180.5 47869.0 48990.8 50663.5 60707.7 62348.0 62547.7 62581.4 63365.7 13145.3 13425.3 13474.8 13624.0 13733.9 14921.4 14954.9 15138.9 15349.3 15670.7 14123.4 14217.4 14262.0 14430.3 14454.9 14135.3 14163.4 14441.5 14567.2 15030.0 13858.4 14310.9 14343.6 14377.5 14536.2 10043.0 10107.2 10139.4 10319.4 10323.6 10133.9 11516.4 11655.1 11658.1 11756.6 18:29:32 INFO - PROCESS | 1645 | -------- Summary: end -------- 18:29:32 INFO - PROCESS | 1645 | 18:29:33 INFO - TEST-INFO | 1645: exit 0 18:29:33 INFO - TEST-OK | dromaeo_css | took 1115288ms 18:29:33 INFO - TEST-START | kraken 18:29:33 INFO - operating with platform_type : mac_ 18:29:33 INFO - Initialising browser for kraken test... 18:29:33 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/tmpe_aFoM/profile http://localhost:49235/getInfo.html) 18:29:35 INFO - PROCESS | 1656 | 2017-05-09 18:29:35.781 plugin-container[1658:10387] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 18:29:35 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:29:35 INFO - PROCESS | 1656 | 2017-05-09 18:29:35.781 plugin-container[1658:10387] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 18:29:35 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:29:35 INFO - PROCESS | 1656 | 2017-05-09 18:29:35.781 plugin-container[1658:10387] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:29:35 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 18:29:35 INFO - PROCESS | 1656 | colorDepth:24 18:29:35 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 18:29:35 INFO - PROCESS | 1656 | __metrics 18:29:35 ERROR - PROCESS | 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 18:29:36 INFO - TEST-INFO | 1656: exit 0 18:29:36 INFO - Browser initialized. 18:29:36 INFO - Running cycle 1/1 for kraken test... 18:29:36 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/tmpe_aFoM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:29:38 INFO - PROCESS | 1659 | 2017-05-09 18:29:38.889 plugin-container[1660:10516] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4247, name = 'com.apple.tsm.portname' 18:29:38 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:29:38 INFO - PROCESS | 1659 | 2017-05-09 18:29:38.890 plugin-container[1660:10516] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 18:29:38 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:29:38 INFO - PROCESS | 1659 | 2017-05-09 18:29:38.890 plugin-container[1660:10516] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:29:48 INFO - PROCESS | 1659 | RSS: Main: 174333952 18:29:48 INFO - PROCESS | 1659 | 18:29:51 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 18:29:52 INFO - PROCESS | 1659 | RSS: Main: 187985920 18:29:52 INFO - PROCESS | 1659 | 18:29:55 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 18:29:55 INFO - PROCESS | 1659 | RSS: Main: 195907584 18:29:55 INFO - PROCESS | 1659 | 18:29:59 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 18:29:59 INFO - PROCESS | 1659 | RSS: Main: 197365760 18:29:59 INFO - PROCESS | 1659 | 18:30:01 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 18:30:02 INFO - PROCESS | 1659 | RSS: Main: 199188480 18:30:02 INFO - PROCESS | 1659 | 18:30:04 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:30:04 INFO - PROCESS | 1659 | RSS: Main: 200876032 18:30:04 INFO - PROCESS | 1659 | 18:30:08 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 18:30:08 INFO - PROCESS | 1659 | RSS: Main: 204840960 18:30:08 INFO - PROCESS | 1659 | 18:30:11 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 18:30:12 INFO - PROCESS | 1659 | RSS: Main: 204615680 18:30:12 INFO - PROCESS | 1659 | 18:30:15 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 18:30:16 INFO - PROCESS | 1659 | RSS: Main: 204484608 18:30:16 INFO - PROCESS | 1659 | 18:30:18 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:30:18 INFO - PROCESS | 1659 | RSS: Main: 204144640 18:30:18 INFO - PROCESS | 1659 | 18:30:20 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:30:21 INFO - PROCESS | 1659 | RSS: Main: 204226560 18:30:21 INFO - PROCESS | 1659 | 18:30:23 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:30:24 INFO - PROCESS | 1659 | RSS: Main: 204533760 18:30:24 INFO - PROCESS | 1659 | 18:30:27 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:30:27 INFO - PROCESS | 1659 | RSS: Main: 204824576 18:30:27 INFO - PROCESS | 1659 | 18:30:30 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:30:31 INFO - PROCESS | 1659 | RSS: Main: 204574720 18:30:31 INFO - PROCESS | 1659 | 18:30:33 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 18:30:33 INFO - PROCESS | 1659 | RSS: Main: 206565376 18:30:33 INFO - PROCESS | 1659 | 18:30:33 INFO - PROCESS | 1659 | __start_tp_report 18:30:33 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 18:30:33 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 18:30:33 INFO - PROCESS | 1659 | |i|pagename|runs| 18:30:33 INFO - PROCESS | 1659 | |0;ai-astar;109;120;121;122;138;176;160;122;122;120 18:30:33 INFO - PROCESS | 1659 | |1;audio-beat-detection;140;112;109;142;110;112;112;112;173;100 18:30:33 INFO - PROCESS | 1659 | |2;audio-dft;205;185;245;193;283;285;202;201;197;187 18:30:33 INFO - PROCESS | 1659 | |3;audio-fft;86;79;85;114;61;61;60;60;75;61 18:30:33 INFO - PROCESS | 1659 | |4;audio-oscillator;87;70;83;73;72;70;81;71;72;82 18:30:33 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;90;122;82;137;136;104;90;131;128;89 18:30:33 INFO - PROCESS | 1659 | |6;imaging-darkroom;97;97;97;126;105;96;98;106;114;110 18:30:33 INFO - PROCESS | 1659 | |7;imaging-desaturate;130;86;140;93;142;137;96;143;146;91 18:30:33 INFO - PROCESS | 1659 | |8;json-parse-financial;65;64;63;68;68;69;73;68;64;65 18:30:33 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;57;62;58;64;65;59;59;59;59;61 18:30:33 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;86;87;83;82;85;89;104;93;99;101 18:30:33 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;134;151;138;142;140;144;133;147;209;179 18:30:33 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;164;168;163;172;147;179;155;212;192;222 18:30:33 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;67;64;64;66;62;66;58;62;64;66 18:30:33 INFO - PROCESS | 1659 | __end_tp_report 18:30:33 INFO - PROCESS | 1659 | __start_cc_report 18:30:33 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,977 18:30:33 INFO - PROCESS | 1659 | __end_cc_report 18:30:33 INFO - PROCESS | 1659 | __startTimestamp1494379833399__endTimestamp 18:30:33 INFO - PROCESS | 1659 | 18:30:33 INFO - PROCESS | 1659 | ------- Summary: start ------- 18:30:33 INFO - PROCESS | 1659 | Number of tests: 14 18:30:33 INFO - PROCESS | 1659 | 18:30:33 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:131.00 Median:122.00 stddev:21.04 (17.2%) stddev-sans-first:20.76 18:30:33 INFO - PROCESS | 1659 | Values: 109.0 120.0 121.0 122.0 138.0 176.0 160.0 122.0 122.0 120.0 18:30:33 INFO - PROCESS | 1659 | 18:30:33 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:122.20 Median:112.00 stddev:22.41 (20.0%) stddev-sans-first:22.83 18:30:33 INFO - PROCESS | 1659 | Values: 140.0 112.0 109.0 142.0 110.0 112.0 112.0 112.0 173.0 100.0 18:30:33 INFO - PROCESS | 1659 | 18:30:33 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:218.30 Median:203.50 stddev:38.40 (18.9%) stddev-sans-first:40.43 18:30:33 INFO - PROCESS | 1659 | Values: 205.0 185.0 245.0 193.0 283.0 285.0 202.0 201.0 197.0 187.0 18:30:33 INFO - PROCESS | 1659 | 18:30:33 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:74.20 Median:68.00 stddev:17.61 (25.9%) stddev-sans-first:18.15 18:30:33 INFO - PROCESS | 1659 | Values: 86.0 79.0 85.0 114.0 61.0 61.0 60.0 60.0 75.0 61.0 18:30:33 INFO - PROCESS | 1659 | 18:30:33 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:76.10 Median:77.00 stddev:6.40 (8.3%) stddev-sans-first:5.44 18:30:33 INFO - PROCESS | 1659 | Values: 87.0 70.0 83.0 73.0 72.0 70.0 81.0 71.0 72.0 82.0 18:30:33 INFO - PROCESS | 1659 | 18:30:33 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:110.90 Median:109.50 stddev:22.03 (20.1%) stddev-sans-first:22.03 18:30:33 INFO - PROCESS | 1659 | Values: 90.0 122.0 82.0 137.0 136.0 104.0 90.0 131.0 128.0 89.0 18:30:33 INFO - PROCESS | 1659 | 18:30:33 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:104.60 Median:96.50 stddev:9.82 (10.2%) stddev-sans-first:10.03 18:30:33 INFO - PROCESS | 1659 | Values: 97.0 97.0 97.0 126.0 105.0 96.0 98.0 106.0 114.0 110.0 18:30:33 INFO - PROCESS | 1659 | 18:30:33 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:120.40 Median:116.00 stddev:25.34 (21.8%) stddev-sans-first:26.64 18:30:33 INFO - PROCESS | 1659 | Values: 130.0 86.0 140.0 93.0 142.0 137.0 96.0 143.0 146.0 91.0 18:30:33 INFO - PROCESS | 1659 | 18:30:33 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:66.70 Median:68.00 stddev:3.06 (4.5%) stddev-sans-first:3.18 18:30:33 INFO - PROCESS | 1659 | Values: 65.0 64.0 63.0 68.0 68.0 69.0 73.0 68.0 64.0 65.0 18:30:33 INFO - PROCESS | 1659 | 18:30:33 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:2.63 (4.4%) stddev-sans-first:2.50 18:30:33 INFO - PROCESS | 1659 | Values: 57.0 62.0 58.0 64.0 65.0 59.0 59.0 59.0 59.0 61.0 18:30:33 INFO - PROCESS | 1659 | 18:30:33 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:86.50 stddev:7.91 (9.1%) stddev-sans-first:8.19 18:30:33 INFO - PROCESS | 1659 | Values: 86.0 87.0 83.0 82.0 85.0 89.0 104.0 93.0 99.0 101.0 18:30:33 INFO - PROCESS | 1659 | 18:30:33 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:151.70 Median:145.50 stddev:24.02 (16.5%) stddev-sans-first:24.61 18:30:33 INFO - PROCESS | 1659 | Values: 134.0 151.0 138.0 142.0 140.0 144.0 133.0 147.0 209.0 179.0 18:30:33 INFO - PROCESS | 1659 | 18:30:33 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.40 Median:175.50 stddev:24.34 (13.9%) stddev-sans-first:25.33 18:30:33 INFO - PROCESS | 1659 | Values: 164.0 168.0 163.0 172.0 147.0 179.0 155.0 212.0 192.0 222.0 18:30:33 INFO - PROCESS | 1659 | 18:30:33 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:65.00 stddev:2.69 (4.1%) stddev-sans-first:2.60 18:30:33 INFO - PROCESS | 1659 | Values: 67.0 64.0 64.0 66.0 62.0 66.0 58.0 62.0 64.0 66.0 18:30:33 INFO - PROCESS | 1659 | -------- Summary: end -------- 18:30:33 INFO - PROCESS | 1659 | 18:30:34 INFO - TEST-INFO | 1659: exit 0 18:30:34 INFO - TEST-OK | kraken | took 61066ms 18:30:34 INFO - SUITE-END | took 1176s 18:30:34 INFO - Completed test suite (00:19:36) 18:30:34 INFO - javascript benchmark 18:30:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7952.733688267647, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3586.4082426399646, 3590.9640903590957, 3608.2783443311346, 3637.8726744563946, 3654.086478380405, 4482.30524268738, 6185.319614842364, 6185.505159587234, 6221.751129954808, 6236.220472440945, 6090.269167699882, 6100.603460775046, 6101.633901965885, 6148.6618235997, 6149.477294429978, 5375.623706340568, 5433.483819037185, 5438.075527160392, 5447.536959358459, 5508.862278443051, 5497.697626630534, 5515.09001014832, 5525.723713814293, 5534.833954981357, 5570.248016517779, 5411.350637923455, 5439.129739241722, 5459.099248623992, 5513.9448605513835, 5523.475269849358, 5609.887802243932, 5619.381867994517, 5625.46558076982, 5645.096784514499, 5651.689157096358, 5557.138643510262, 5625.54995600351, 5643.6049476536655, 5655.8586035349035, 5682.971585142048, 5613.915791263134, 5981.820545383645, 6243.594166379171, 6286.402791734778, 6297.27581328144, 5400.378956419983, 6370.681465926685, 6469.51478639104, 6511.641859697715, 6528.347165283481, 6722.260551339349, 6725.327467253284, 6730.226024007253, 6731.798046058626, 6748.582797612507, 6285.182926219653, 6295.24457065146, 6315.147455093549, 6344.841378965517, 6356.8410789729705, 5870.882582348329, 6312.810615681537, 6506.056621789814, 6696.330366963265, 6815.659217039228, 6438.420542151229, 6476.740930362733, 6486.318936511692, 6489.415952564292, 6510.804675859732, 6596.307387724316, 6611.305812889577, 6641.402273795382, 6667.599944003376, 6683.398494135551, 6282.308946016026, 6303.149074874925, 6376.713047912763, 6537.313582073909, 6565.901511477332, 5346.97326513365, 6273.8745225095245, 6513.12072870166, 6608.900866487006, 6611.636360000246, 5191.974040129775, 5227.006868694936, 5228.6339956203465, 5231.450697676689, 5271.683698978073, 4150.958490415057, 4243.387512745137, 4635.490096089427, 4675.509071547506, 4676.859694209179, 5289.471052894757, 5869.559783016291, 6280.5603607747935, 6297.023961286008, 6305.274893387227, 6512.967435162888, 6513.316101809337, 6527.053577231275, 6576.5067619928695, 6601.33986601336, 6322.114903913363, 6322.462590679844, 6336.398042185985, 6349.9682501587195, 6370.458511026614, 5894.469497745224, 5913.0, 5923.437273459014, 5930.851728706817, 5948.940510594925, 6551.705173267214, 6559.278479367361, 6773.322667733188, 6825.419839313615, 6825.931740682529, 6614.140161778938, 6695.799126026227, 6698.598084114774, 6703.798886033427, 6736.225334086643, 6816.947717139591, 6904.861902761816, 6949.513534052568, 6950.930490695028, 6975.407090397373, 6290.339514350927, 6311.936880631135, 6483.902741458787, 6578.80263592093, 6582.243042050225, 6554.705038273384, 6660.533762636569, 6698.531102822755, 6705.2959439258175, 6738.66306684654, 6422.3577642235405, 6464.806055818145, 6481.319461456667, 6482.319356467503, 6488.578242414228, 5570.331560212639, 6237.781677641261, 6257.937420625735, 6381.904271436025, 6500.382463665944, 5639.689817060101, 5762.913556296743, 5827.6794776286015, 6303.275123360872, 6306.46395056407, 6474.4173024426145, 6479.028145778171, 6498.577592456475, 6498.870022599427, 6506.934930650633, 6183.628982261079, 6242.719077641608, 6279.183706118358, 6279.372062793684, 6330.3669633036325], "value": 6025.058589230745, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [788.0267869181563, 831.5758962928907, 851.5188918261184, 926.6061923682433, 984.0405604535574, 35342.64657353432, 39881.601183988154, 40774.796126019406, 42502.0, 42786.572134278606, 40653.390199147034, 40715.0, 40955.77132686024, 40961.566345177926, 40995.38506922399, 8327.375446841495, 8439.113893041234, 11052.613158539452, 11301.717457063556, 11706.122040846927, 11348.943255283712, 11413.0, 11491.080713542897, 11491.540338386454, 11492.425378731072, 11356.545738170464, 11467.139964502654, 11474.942625286862, 11477.368744719037, 11483.885161148406, 9037.909620903773, 11385.943070284637, 11419.257748246337, 11446.48490817911, 11459.427028648533, 10853.51159197838, 10871.565137394495, 10878.72803179919, 10917.344959302467, 10974.231803773739, 35021.0, 35082.473762893576, 35248.471272930925, 35381.64618353809, 35455.75904843318, 3937.4881265435597, 3946.8223929922933, 3978.980105099456, 4001.4397984282223, 4044.474218351625, 26063.478730425286, 26327.73672263272, 26514.73485265161, 27536.0, 27576.0, 3218.5815843940372, 3256.3975664501904, 3293.6212335581477, 3294.7364210863075, 3408.7784294021058, 357842.0, 360897.0, 376383.0, 379054.0, 394755.0, 44699.0, 44853.0, 44918.0, 44956.55043449589, 45635.0, 46650.367237146536, 46804.76597617058, 46909.53090469052, 47031.29453058207, 47230.291545626846, 11545.538178472934, 14344.784828227585, 14471.710565788626, 14506.709865802835, 14509.0, 12428.75142497145, 12641.620751377473, 12693.048021398432, 12710.745785084431, 12730.554430594884, 12143.0, 12150.513979440724, 12161.756764864653, 12206.291119243313, 12229.755404891852, 4752.477227504972, 5651.067573850269, 5689.089745640677, 5703.287089113861, 5707.686077265707, 1136.2671077155353, 1156.2888823373733, 1157.3345326437332, 1178.5933852820763, 1212.6968257935516, 26823.195304140907, 27367.92646169385, 27528.0, 27708.722912771016, 29209.707902921124, 996.277698668474, 1102.9779404412027, 1108.512254607986, 1119.5857532712785, 1150.2753265442718, 15573.987690800062, 16664.416745414095, 17193.0, 17201.1399430028, 17422.564435889206, 507784.0, 510449.0, 510517.0, 511296.0, 512209.0, 61689.691551542855, 61942.38057619366, 62043.0, 62264.0, 62305.0, 1532.2415404374906, 1576.0386164439683, 1580.5258422473212, 1584.3504163292994, 1592.2118551316942, 30107.69892301049, 31083.067507974796, 31571.21071973219, 31778.0, 32072.5189122168, 36020.0, 36517.45223821592, 50997.470075897785, 51667.483325166264, 52121.696957576365, 407276.0, 408682.9565852152, 411361.0, 411571.0, 413170.0, 27810.74851631641, 28375.858120709265, 33006.50490242696, 33352.33295334128, 34957.30085398329, 41075.97310067272, 41092.383614246406, 41144.0, 41456.75629731113, 42037.949051273965, 28297.0, 28537.28656783597, 28602.0, 29114.0, 30038.948636797606, 29568.0, 29818.31934194867, 30165.396692066475, 31465.21336966594, 31612.893548725686, 35539.82230088833, 36056.639433606375, 36278.0, 36354.27291454209, 36384.27231455409, 29596.852015739783, 30223.546646800754, 30271.9404820839, 30466.390672186877, 30828.612712428443, 21087.0, 21954.34136975893, 24202.15292464755, 24556.38609034717, 24688.50622987566], "value": 19114.5948267249, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.3933296719757, 431.2410158121705, 431.7802208760252, 442.38950248656846, 447.01433339486437, 18078.186481608325, 19944.202231910724, 20636.071376788044, 22108.447288817788, 22803.885980570114, 22818.31545053651, 23100.960456779445, 23656.645150322758, 23714.881425592892, 23969.5206095878, 6800.183977922631, 6879.8624027519545, 6981.965090174542, 7157.3916217121605, 7168.498205125643, 6880.483963702717, 7008.789736307919, 7012.579245245276, 7016.7544135954995, 7710.691572337099, 8106.432549721522, 8126.593670316461, 8185.508869467822, 8222.958885205595, 8231.83536329273, 7989.360851131924, 8081.959590202041, 8118.10700822909, 8158.877616835753, 8172.918270817275, 6839.418649414805, 7722.459427840054, 7991.880121798177, 8017.398695097891, 8026.077001144827, 27184.864075679692, 29604.70395296041, 30849.537256941163, 31037.689623103706, 31436.05691829249, 3090.1965488972805, 3359.1434184283094, 3379.662033796625, 3538.8230588470733, 3568.571771387424, 14179.220142892136, 17304.91347543267, 17475.737863932052, 17573.7363939541, 17766.91116544422, 2087.290321290753, 2127.5213077057538, 2128.3508529898377, 2144.1101942693917, 2214.878181700006, 160011.0, 161437.0, 164086.1795691026, 185054.99999999866, 187651.0617446904, 25546.872265638554, 26579.069732559266, 27552.724472755417, 27566.5865012025, 27572.586411203847, 35086.64913350885, 44509.55490445054, 44526.77366131745, 45903.0, 45939.310910336375, 12116.030717542575, 12417.75164496705, 12448.377581120907, 12493.50025998968, 12588.87411125877, 10065.647702330383, 10120.848187277197, 10124.139448146843, 10166.390016599027, 10264.230182736324, 9803.705888823346, 11725.0, 12025.699357516132, 12032.639020829389, 12076.0, 4488.798004089824, 4563.977180114078, 4819.783109760069, 4880.8779780505065, 4952.504749525018, 851.438050886412, 920.3787443475627, 932.7108596335022, 961.3703024518951, 974.5760594141572, 22765.430864228525, 22847.200347987742, 23153.813353430407, 23255.18606848786, 23312.950917208767, 952.4285428742699, 962.7063745557532, 963.6290028339, 971.2909576009412, 985.1970643925322, 9347.813043739086, 12379.69050773738, 12751.107422480338, 12950.287734174522, 13015.544455944186, 529360.0, 529705.0, 530966.0, 701886.0, 728407.0, 96336.51831740796, 110614.44692776646, 141621.0, 153969.4603053955, 155025.22487387492, 1197.0124647165949, 1302.9413676384586, 1337.739140867541, 1380.178793617816, 1384.1072508232135, 16917.238724257193, 18075.46358559537, 19672.311469098513, 20115.39653810388, 20234.79765202329, 60678.0, 61441.0, 62275.13174604769, 62316.37683623106, 62920.0, 81991.0, 83241.58379208065, 83840.58079709807, 84680.0, 85881.0, 8453.408261421642, 11607.30356178632, 11808.291502509877, 11842.993345565379, 12012.819807703067, 12949.870501295243, 13016.28410437435, 13053.02102342309, 13288.800667990181, 13370.465181392636, 10940.890591094305, 11206.943965280121, 11309.773804524028, 11443.485043173243, 11461.197716159788, 9984.251181161588, 10007.899921000697, 10114.898851011396, 10247.282690211614, 10282.485875706036, 9474.715758527254, 11078.889211107786, 11600.767984640092, 11728.061755059403, 11728.882711172779, 11704.180707350404, 11725.41372931367, 11925.224860384395, 12037.916587507167, 12057.336846473529, 11525.596604118815, 11532.308061516336, 11644.53421863116, 11761.705957351134, 11944.283342999448], "value": 12320.164026002498, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.3125846481387, 1598.0252046251778, 1621.4811260396677, 1625.699245639556, 1636.2963925512033, 9848.21214302854, 10119.69640910772, 11082.445877706112, 11779.23434976726, 11809.586664466746, 10988.450577471134, 11373.601923932663, 11398.145139114558, 11539.365334906577, 11540.019098376648, 1951.780137414116, 2277.521720438706, 2309.145616122029, 2312.9306120816404, 2316.2356422380576, 2407.723111842143, 2421.370443684637, 2426.696662917135, 2434.9269521914284, 2442.572549803786, 1864.9067546622682, 2242.9439264018365, 2257.548490301946, 2258.5369999150216, 2270.4550907782177, 2371.3360259127385, 2371.9525609487714, 2375.4536456615074, 2376.500934803676, 2403.8677872716994, 1847.8429333506667, 2404.771546703078, 2420.552197843387, 2422.697162854643, 2424.963625545618, 9873.0, 11224.943875280653, 11412.372319522423, 11483.13876459269, 11527.13546484017, 5252.634315078069, 5819.0, 5843.298804143487, 6001.609895356788, 6001.699915004232, 3411.283630437611, 3533.840977156034, 3709.8145092745253, 3734.906627334311, 3760.5897788329376, 1197.9580714674944, 1246.345668524023, 1264.2035517623838, 1310.678883673506, 1319.089828018664, 15824.446144385007, 15884.602884927854, 15893.364265429369, 15895.841041589667, 15912.761308580264, 4700.7179569225955, 4902.4362198346935, 4932.235503496964, 4946.08497427977, 4991.176455884811, 13279.269640169883, 13340.399682014333, 13354.332283385791, 13362.599122026355, 13383.263920484273, 5993.220881285405, 6029.186059881948, 6037.6679282639, 6040.063790112539, 6042.969785151134, 4363.629091527192, 5215.530602245816, 5354.330708661418, 5376.327959005124, 5387.892242155135, 4105.747746937153, 4155.937660935088, 4166.500019997619, 4187.602177793105, 4197.223513649985, 1123.3203911633343, 1125.909927205838, 1128.430142777892, 1134.1833879606836, 1135.6195674449152, 948.7011591348703, 949.6723630347519, 971.9611215551299, 978.5498670611598, 1011.418275213285, 6599.901001484982, 6663.500237482208, 6683.198016237985, 6849.828754281083, 6934.583924964519, 994.2592768387453, 1017.8752478511286, 1025.6358992557534, 1043.6138628707274, 1058.655936820521, 3953.8566839362775, 4099.344104943195, 4143.777585612252, 4307.396964424983, 4349.238883195429, 11585.362805045635, 13777.586672399844, 13787.172769633855, 13879.722405552035, 13891.235982020884, 13296.268705221113, 13716.314184290944, 13786.310684465736, 13920.025598208029, 13936.512222072179, 9457.91234008084, 9819.9018009819, 10237.23220758446, 10374.429406382722, 10561.524731387106, 6521.576097553644, 6567.704453299709, 6639.170103737033, 6691.665416729047, 6751.966240168767, 12233.3271670059, 12258.570950016707, 12308.876911230773, 12391.75216495683, 12438.689032774253, 12648.177868438523, 12776.0, 12817.679558011125, 12932.482700691868, 13043.282619455642, 9377.624895004396, 9395.483248421402, 9407.43555386679, 9442.008589098046, 9496.240300775784, 10386.844197336895, 10407.427591482541, 10502.737431564272, 10505.107065899485, 10513.106385956973, 7505.437092217996, 7517.661705223169, 7525.435592330487, 8889.911100889167, 8950.373473856767, 6484.578502397329, 7229.530080544748, 7255.56466612005, 7280.453965952681, 7349.338559529668, 6770.0, 7653.349465295512, 7838.372930165687, 7972.800679983046, 8055.395845311742, 5436.972815135899, 5513.5037846594, 5555.00009998188, 5701.087825947829, 5736.42635736423, 5768.134779783066, 5960.046392577166, 6006.87986240264, 6129.877402451837, 6144.907826382519], "value": 5161.6860971673095, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.5524901612161, 396.1937457274447, 396.8987908083439, 397.89058009047505, 399.65629558579633, 4626.866417727657, 5321.973390133054, 5346.326836581709, 5386.55260633195, 5430.56555475562, 4270.765107919063, 5042.495750424956, 5313.57491400688, 5319.143620874874, 5319.989202051607, 3391.96608033919, 4122.216778812031, 4153.840003198335, 4164.3961625564425, 4169.457300798708, 3430.382531144393, 3556.28874225156, 4169.457970463851, 4208.894777630569, 4241.597048280409, 3887.300285948528, 4004.5594984551676, 4163.521195062576, 4187.539370669239, 4202.474690663667, 3598.478220658016, 3637.544657356274, 4078.225137223918, 4117.300058989979, 4142.979285103585, 3152.7162555369896, 3568.678818906311, 3704.2776658551593, 3729.384651532494, 3736.9439458408146, 4481.887952801206, 4956.157453232959, 5221.6083793715625, 5225.477452254782, 5234.659747116425, 4423.51341352451, 4800.791635847514, 4846.5880400166025, 4900.534449227318, 5104.9744751276, 5211.609129315317, 5273.789048438096, 5526.894621075801, 5622.887542249173, 5711.228984087178, 4098.549159592442, 4136.338185890273, 4542.841000564964, 4546.590806827368, 4670.435404139617, 4845.297431872394, 5245.423003469616, 5324.627276090714, 5599.496045355938, 5782.848347650541, 4592.494825569184, 4681.438227412732, 4731.361266229083, 4732.716037037789, 4760.59534939534, 4326.286162783105, 4505.61702255312, 4616.399208617284, 4859.975700121548, 4888.60891128716, 4303.472267345048, 4485.46174459067, 4586.220342541776, 4920.434150072788, 5169.862630221345, 4734.976325118352, 5280.313559237351, 5489.282805011465, 5492.890142197213, 5751.85620359486, 1329.335332333833, 1480.9411270941114, 1514.0317587136678, 1533.8496127904073, 1612.2825342722376, 991.4844280973854, 1005.1054561440324, 1116.3636727065657, 1211.497228650118, 1217.0202986595875, 4762.547557982056, 4866.741601099038, 5341.370881881064, 5458.5087342139395, 5486.286782718301, 5074.797008119708, 5147.948520514822, 5590.748416321276, 5750.016244395677, 5914.556408269397, 4730.52306554682, 4848.03039392123, 4886.389201349832, 5092.6435149539175, 5265.894682106336, 3068.8925887593828, 3083.152133163353, 3103.4413805515223, 3108.3161704425443, 3111.191090316489, 5176.80933385316, 5633.267675202197, 6102.877942441126, 6114.969425152845, 6269.749210031548, 4936.6297527685565, 5540.7006092471975, 5919.348871624118, 6014.894786824577, 6021.548383871227, 5695.772169113189, 5758.366579676316, 5890.49930755882, 6123.203983482119, 6176.629402235881, 5305.487935938239, 5486.50621444056, 5644.8024319148635, 5975.790847320497, 6050.515958723379, 5857.736401861841, 5860.066178161282, 5891.440313170242, 5897.351291357862, 5924.437178468039, 5447.319085114361, 5602.551795856403, 5651.717414129195, 5668.858278542904, 5686.317641883001, 4072.837086516506, 4200.348945913388, 4641.907161856811, 4655.72065676047, 4658.627309815139, 5634.414975058163, 5674.971625141848, 5938.910916336345, 5943.138244954544, 5997.070454079625, 4724.881877953078, 5486.725663716878, 5546.112621980626, 5554.2779438672715, 5722.370539240764, 5111.2621708619245, 5115.18157094863, 5124.9743751281, 5149.021685879671, 5831.7375718091935, 4680.929786053144, 5281.603879709114, 5618.971905140448, 5668.348139963792, 5676.262085928803, 4970.130227210296, 5461.9453805461435, 5487.807926722546, 5688.288963879515, 5805.332386775406, 4695.436547614171, 5385.030694475032, 5631.8592035199445, 5662.5469962402085, 5676.148577713211], "value": 4273.72617338496, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [680.5644387591942, 761.93904487641, 901.5086777706149, 903.2954295649394, 911.7401540560942, 16743.162841857906, 17036.403725869583, 17079.91460042701, 17577.29690812366, 17580.208890599923, 16275.674486510263, 16301.83698163018, 16314.021158730455, 16388.26252818623, 16509.33962641493, 984.5372674842848, 987.965421210256, 1008.8890222075565, 1016.9694909152701, 1023.0434543701625, 1012.4128005756644, 1021.0606242257104, 1025.1952217509256, 1025.8461230815362, 1029.4543891737392, 1055.5883205549842, 1064.6486659402417, 1072.6460268111505, 1073.683263437284, 1076.8061748885198, 1064.5741703318656, 1066.306900514664, 1066.568039943824, 1067.7864427114569, 1069.2301542889106, 786.5949036246337, 786.8072322281078, 789.498668345599, 789.5026133535893, 790.1269097647074, 16715.331386744514, 16961.57596060096, 17760.023198724066, 18324.175412106488, 18645.627087458175, 14478.782818257734, 14801.259937003108, 14815.18516481593, 14906.105633662015, 15124.168170750605, 11738.706532336675, 12052.397380130958, 12099.334536600483, 12147.149699521036, 12337.69155771104, 3863.0, 3880.546482912459, 3895.61043895611, 3940.192260586573, 3972.6226008529143, 112514.0, 117325.99999999914, 120614.9846253842, 120718.79281207251, 121705.39147304295, 11547.538098475967, 11649.47577359021, 11687.590934317259, 11757.412129393497, 12221.144519883523, 23811.642825357634, 24084.27747167588, 24478.87760561186, 24552.0, 24583.508329833305, 8202.671893124327, 8204.712835050745, 8219.506829590244, 8398.882012377695, 8417.70538031166, 3935.586763389803, 4556.20266453376, 4702.506236845151, 4715.24556071027, 4793.01743142655, 3648.4162533994963, 3728.3848165052464, 3734.2344819311975, 3761.8307176177136, 3883.475730776309, 652.9869402611921, 656.4289068510426, 658.5291516565678, 668.9632070236087, 669.3072669786748, 684.7055766020659, 698.4935921456903, 716.77421612192, 724.6702750248625, 744.4354199781808, 9075.727728168165, 10188.9811018899, 10811.324244742078, 10982.945085274683, 11107.055900248408, 705.9047028651066, 724.6231959381198, 733.3216774483582, 737.9188289288174, 747.2042274977132, 4502.986827963682, 5171.224316352577, 5173.22401639757, 5275.657082289639, 5290.762832166976, 104691.0, 107325.0, 109485.90514094917, 112063.87936120697, 112521.43739281251, 76423.0, 94481.0551894486, 96509.03490965141, 97937.0, 98815.50592247136, 74139.0, 85630.0, 87589.12410875937, 87642.56178719066, 87934.0, 10994.450277485934, 11149.108071354434, 11384.203105782515, 11555.364454955059, 11653.59212427561, 39001.0, 47180.52819471761, 47869.0, 48990.75504622597, 50663.49336506588, 60707.69646151741, 62348.0, 62547.6872615634, 62581.374186259374, 63365.68317158385, 13145.310725457784, 13425.328733563478, 13474.79787803164, 13624.04631675773, 13733.931330343285, 14921.403143874557, 14954.925225373803, 15138.924305378403, 15349.309281082602, 15670.686586268439, 14123.364448600043, 14217.360218790385, 14262.001659884123, 14430.278486075444, 14454.855451445352, 14135.293235338399, 14163.362648680628, 14441.49454769078, 14567.198804065878, 15030.0, 13858.376373063034, 14310.928445357707, 14343.641408964859, 14377.496787612383, 14536.200508972108, 10043.0, 10107.241956853119, 10139.391636501834, 10319.432431216055, 10323.587056517656, 10133.899428423156, 11516.391001330236, 11655.125865560287, 11658.06735461178, 11756.588519402121], "value": 8081.939864204869, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1568.6000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 120.0, 121.0, 122.0, 138.0, 176.0, 160.0, 122.0, 122.0, 120.0], "value": 131.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 112.0, 109.0, 142.0, 110.0, 112.0, 112.0, 112.0, 173.0, 100.0], "value": 122.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 185.0, 245.0, 193.0, 283.0, 285.0, 202.0, 201.0, 197.0, 187.0], "value": 218.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 79.0, 85.0, 114.0, 61.0, 61.0, 60.0, 60.0, 75.0, 61.0], "value": 74.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 83.0, 73.0, 72.0, 70.0, 81.0, 71.0, 72.0, 82.0], "value": 76.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 122.0, 82.0, 137.0, 136.0, 104.0, 90.0, 131.0, 128.0, 89.0], "value": 110.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 97.0, 126.0, 105.0, 96.0, 98.0, 106.0, 114.0, 110.0], "value": 104.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 86.0, 140.0, 93.0, 142.0, 137.0, 96.0, 143.0, 146.0, 91.0], "value": 120.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 63.0, 68.0, 68.0, 69.0, 73.0, 68.0, 64.0, 65.0], "value": 66.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 62.0, 58.0, 64.0, 65.0, 59.0, 59.0, 59.0, 59.0, 61.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 83.0, 82.0, 85.0, 89.0, 104.0, 93.0, 99.0, 101.0], "value": 90.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 151.0, 138.0, 142.0, 140.0, 144.0, 133.0, 147.0, 209.0, 179.0], "value": 151.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 168.0, 163.0, 172.0, 147.0, 179.0, 155.0, 212.0, 192.0, 222.0], "value": 177.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 64.0, 66.0, 62.0, 66.0, 58.0, 62.0, 64.0, 66.0], "value": 63.9, "unit": "score"}]}]} 18:30:34 INFO - Return code: 0 18:30:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:30:34 ERROR - # TBPL SUCCESS # 18:30:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:30:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:30:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:30:34 INFO - 2017-05-09 18:30:34.762 screenresolution[1665:10915] starting screenresolution argv=screenresolution get 18:30:34 INFO - 2017-05-09 18:30:34.764 screenresolution[1665:10915] Display 0: 1600x1200x32@60 18:30:34 INFO - 2017-05-09 18:30:34.770 screenresolution[1666:10918] starting screenresolution argv=screenresolution list 18:30:34 INFO - Available Modes on Display 0 18:30:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:30:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:30:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:30:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:30:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:30:34 INFO - Intel Iris: 18:30:34 INFO - Chipset Model: Intel Iris 18:30:35 INFO - Type: GPU 18:30:35 INFO - Bus: Built-In 18:30:35 INFO - VRAM (Dynamic, Max): 1536 MB 18:30:35 INFO - Vendor: Intel (0x8086) 18:30:35 INFO - Device ID: 0x0a2e 18:30:35 INFO - Revision ID: 0x0009 18:30:35 INFO - Displays: 18:30:35 INFO - Display: 18:30:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:30:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:30:35 INFO - Display Serial Number: 1600x1200 60 18:30:35 INFO - Main Display: Yes 18:30:35 INFO - Mirror: Off 18:30:35 INFO - Online: Yes 18:30:35 INFO - Rotation: Supported 18:30:35 INFO - Return code: 0 18:30:35 INFO - Running post-action listener: _resource_record_post_action 18:30:35 INFO - [mozharness: 2017-05-10 01:30:35.005862Z] Finished run-tests step (success) 18:30:35 INFO - Running post-run listener: _resource_record_post_run 18:30:35 INFO - Total resource usage - Wall time: 1192s; CPU: 54.0%; Read bytes: 40482816; Write bytes: 427087872; Read time: 264; Write time: 1437 18:30:35 INFO - TinderboxPrint: CPU usage
54.4% 18:30:35 INFO - TinderboxPrint: I/O read bytes / time
40,482,816 / 264 18:30:35 INFO - TinderboxPrint: I/O write bytes / time
427,087,872 / 1,437 18:30:35 INFO - TinderboxPrint: CPU idle
2,177.2 (45.6%) 18:30:35 INFO - TinderboxPrint: CPU system
959.1 (20.1%) 18:30:35 INFO - TinderboxPrint: CPU user
1,633.4 (34.2%) 18:30:35 INFO - TinderboxPrint: Swap in / out
162,070,528 / 0 18:30:35 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 117506560; Write bytes: 116258816; Read time: 11123; Write time: 253 18:30:35 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 38451200; Write bytes: 300538368; Read time: 245; Write time: 1147 18:30:35 INFO - Running post-run listener: _upload_blobber_files 18:30:35 INFO - Blob upload gear active. 18:30:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:30:35 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 18:30:35 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'] 18:30:35 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 18:30:35 INFO - (blobuploader) - INFO - Open directory for files ... 18:30:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:30:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:30:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:37 INFO - (blobuploader) - INFO - Done attempting. 18:30:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:30:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:30:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:38 INFO - (blobuploader) - INFO - Done attempting. 18:30:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:30:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:30:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:39 INFO - (blobuploader) - INFO - Done attempting. 18:30:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:30:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:30:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:41 INFO - (blobuploader) - INFO - Done attempting. 18:30:41 INFO - (blobuploader) - INFO - Iteration through files over. 18:30:41 INFO - Return code: 0 18:30:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:30:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:30:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cebf83a83842b151933a7920740ff45cb387138163986a4c4fdbc4526070a9d3cd50e189a5eefd7fba78792a465e7ac9184d2722663674497040036d6a1a6b5f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/82db367723a571d3ccf19aa8ebbf4ebc0c05fc79acdac15676243e39490e24ffa586c26844094f7bd3632763d48a5a3d41700921fadfd0c460bab0a76db500e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2cd33508230c41b1103368ecec26f8fe3d7db457eefc671dabfbbfba83285223587a423ae1c28b19d1fa672a09181c955c7a75193d9cb908b17d94a1ccaba9ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf0739901702a3d1748c1cee13c199a96620e98fd4cc7345723e48473381a9a8e82e53e1e716ab66e40892fa4ed64dc8da5ce8b9bcf9a2bb8c7a20aa6e3e117b"} 18:30:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:30:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:30:41 INFO - Contents: 18:30:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cebf83a83842b151933a7920740ff45cb387138163986a4c4fdbc4526070a9d3cd50e189a5eefd7fba78792a465e7ac9184d2722663674497040036d6a1a6b5f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/82db367723a571d3ccf19aa8ebbf4ebc0c05fc79acdac15676243e39490e24ffa586c26844094f7bd3632763d48a5a3d41700921fadfd0c460bab0a76db500e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2cd33508230c41b1103368ecec26f8fe3d7db457eefc671dabfbbfba83285223587a423ae1c28b19d1fa672a09181c955c7a75193d9cb908b17d94a1ccaba9ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf0739901702a3d1748c1cee13c199a96620e98fd4cc7345723e48473381a9a8e82e53e1e716ab66e40892fa4ed64dc8da5ce8b9bcf9a2bb8c7a20aa6e3e117b"} 18:30:41 INFO - Running post-run listener: copy_logs_to_upload_dir 18:30:41 INFO - Copying logs to upload dir... 18:30:41 INFO - mkdir: /builds/slave/test/build/upload/logs 18:30:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.748016 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-05-09 18:30:41.350227) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-09 18:30:41.354426) ========= 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.U018OGi7eh/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.CWEybJlRmi/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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/cebf83a83842b151933a7920740ff45cb387138163986a4c4fdbc4526070a9d3cd50e189a5eefd7fba78792a465e7ac9184d2722663674497040036d6a1a6b5f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/82db367723a571d3ccf19aa8ebbf4ebc0c05fc79acdac15676243e39490e24ffa586c26844094f7bd3632763d48a5a3d41700921fadfd0c460bab0a76db500e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2cd33508230c41b1103368ecec26f8fe3d7db457eefc671dabfbbfba83285223587a423ae1c28b19d1fa672a09181c955c7a75193d9cb908b17d94a1ccaba9ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf0739901702a3d1748c1cee13c199a96620e98fd4cc7345723e48473381a9a8e82e53e1e716ab66e40892fa4ed64dc8da5ce8b9bcf9a2bb8c7a20aa6e3e117b"} build_url:https://queue.taskcluster.net/v1/task/R5LOVKxHQXmkX6fD0zF5qg/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011217 build_url: 'https://queue.taskcluster.net/v1/task/R5LOVKxHQXmkX6fD0zF5qg/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/cebf83a83842b151933a7920740ff45cb387138163986a4c4fdbc4526070a9d3cd50e189a5eefd7fba78792a465e7ac9184d2722663674497040036d6a1a6b5f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/82db367723a571d3ccf19aa8ebbf4ebc0c05fc79acdac15676243e39490e24ffa586c26844094f7bd3632763d48a5a3d41700921fadfd0c460bab0a76db500e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2cd33508230c41b1103368ecec26f8fe3d7db457eefc671dabfbbfba83285223587a423ae1c28b19d1fa672a09181c955c7a75193d9cb908b17d94a1ccaba9ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf0739901702a3d1748c1cee13c199a96620e98fd4cc7345723e48473381a9a8e82e53e1e716ab66e40892fa4ed64dc8da5ce8b9bcf9a2bb8c7a20aa6e3e117b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-09 18:30:41.388447) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 18:30:41.388849) ========= 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.U018OGi7eh/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.CWEybJlRmi/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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.005082 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 18:30:41.437967) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-09 18:30:41.438306) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-09 18:30:41.438662) ========= ========= Total master_lag: 0.17 =========