builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0350 starttime: 1494021498.35 results: success (0) buildid: 20170505135642 builduid: d136471e25854d8187882ce90d66d575 revision: 7868898154ed9e19d98d9aa4c53b7da57c2bd187 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 14:58:18.350956) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 14:58:18.351433) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 14:58:18.351720) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 14:58:18.377606) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 14:58:18.377997) ========= 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.nILFKlT48Q/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.gx88x5KtAS/Listeners TMPDIR=/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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-05 14:58:18-- 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% 151M=0s 2017-05-05 14:58:18 (151 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.140183 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 14:58:18.542502) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 14:58:18.542913) ========= 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.nILFKlT48Q/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.gx88x5KtAS/Listeners TMPDIR=/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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.024574 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 14:58:18.593034) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-05 14:58:18.593524) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 7868898154ed9e19d98d9aa4c53b7da57c2bd187 --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 7868898154ed9e19d98d9aa4c53b7da57c2bd187 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nILFKlT48Q/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.gx88x5KtAS/Listeners TMPDIR=/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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-05 14:58:18,870 truncating revision to first 12 chars 2017-05-05 14:58:18,870 Setting DEBUG logging. 2017-05-05 14:58:18,870 attempt 1/10 2017-05-05 14:58:18,870 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/7868898154ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-05 14:58:20,393 unpacking tar archive at: mozilla-beta-7868898154ed/testing/mozharness/ program finished with exit code 0 elapsedTime=1.797255 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-05 14:58:20.418213) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 14:58:20.418820) ========= script_repo_revision: 7868898154ed9e19d98d9aa4c53b7da57c2bd187 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 14:58:20.419478) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 14:58:20.419830) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 14:58:20.441398) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-05-05 14:58:20.441831) ========= /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.nILFKlT48Q/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.gx88x5KtAS/Listeners TMPDIR=/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 14:58:20 INFO - MultiFileLogger online at 20170505 14:58:20 in /builds/slave/test 14:58:20 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 14:58:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:58:20 INFO - {'append_to_log': False, 14:58:20 INFO - 'base_work_dir': '/builds/slave/test', 14:58:20 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:58:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:58:20 INFO - 'branch': 'Mozilla-Beta', 14:58:20 INFO - 'buildbot_json_path': 'buildprops.json', 14:58:20 INFO - 'config_files': ('talos/mac_config.py',), 14:58:20 INFO - 'default_actions': ('clobber', 14:58:20 INFO - 'read-buildbot-config', 14:58:20 INFO - 'download-and-extract', 14:58:20 INFO - 'populate-webroot', 14:58:20 INFO - 'create-virtualenv', 14:58:20 INFO - 'install', 14:58:20 INFO - 'run-tests'), 14:58:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:58:20 INFO - 'download_minidump_stackwalk': True, 14:58:20 INFO - 'download_symbols': 'ondemand', 14:58:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:58:20 INFO - 'tooltool.py': '/tools/tooltool.py', 14:58:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:58:20 INFO - '/tools/misc-python/virtualenv.py')}, 14:58:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:58:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:58:20 INFO - 'gecko_profile': False, 14:58:20 INFO - 'gecko_profile_interval': 0, 14:58:20 INFO - 'installer_path': 'installer.exe', 14:58:20 INFO - 'log_level': 'info', 14:58:20 INFO - 'log_name': 'talos', 14:58:20 INFO - 'log_to_console': True, 14:58:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:58:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:58:20 INFO - 'opt_config_files': (), 14:58:20 INFO - 'pip_index': False, 14:58:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:58:20 INFO - 'cmd': ('bash', 14:58:20 INFO - '-c', 14:58:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:58:20 INFO - 'enabled': True, 14:58:20 INFO - 'halt_on_failure': False, 14:58:20 INFO - 'name': 'check_screen_resolution'},), 14:58:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:58:20 INFO - 'cmd': ('bash', 14:58:20 INFO - '-c', 14:58:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:58:20 INFO - 'enabled': True, 14:58:20 INFO - 'halt_on_failure': False, 14:58:20 INFO - 'name': 'check_screen_resolution'},), 14:58:20 INFO - 'run_cmd_checks_enabled': True, 14:58:20 INFO - 'suite': 'dromaeojs-e10s', 14:58:20 INFO - 'system_bits': '32', 14:58:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:58:20 INFO - 'title': 't-yosemite-r7-0350', 14:58:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:58:20 INFO - 'use_talos_json': True, 14:58:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:58:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:58:20 INFO - 'work_dir': 'build'} 14:58:20 INFO - [mozharness: 2017-05-05 21:58:20.835713Z] Running clobber step. 14:58:20 INFO - Running pre-action listener: _resource_record_pre_action 14:58:20 INFO - Running main action method: clobber 14:58:20 INFO - rmtree: /builds/slave/test/build 14:58:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:58:22 INFO - Running post-action listener: _resource_record_post_action 14:58:22 INFO - [mozharness: 2017-05-05 21:58:22.855396Z] Finished clobber step (success) 14:58:22 INFO - [mozharness: 2017-05-05 21:58:22.855702Z] Running read-buildbot-config step. 14:58:22 INFO - Running pre-action listener: _resource_record_pre_action 14:58:22 INFO - Running main action method: read_buildbot_config 14:58:22 INFO - Using buildbot properties: 14:58:22 INFO - { 14:58:22 INFO - "project": "", 14:58:22 INFO - "product": "firefox", 14:58:22 INFO - "script_repo_revision": "production", 14:58:22 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 14:58:22 INFO - "repository": "", 14:58:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 14:58:22 INFO - "buildid": "20170505135642", 14:58:22 INFO - "pgo_build": "False", 14:58:22 INFO - "basedir": "/builds/slave/test", 14:58:22 INFO - "buildnumber": 2, 14:58:22 INFO - "slavename": "t-yosemite-r7-0350", 14:58:22 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 14:58:22 INFO - "platform": "yosemite_r7", 14:58:22 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:58:22 INFO - "branch": "mozilla-beta", 14:58:22 INFO - "repo_path": "releases/mozilla-beta", 14:58:22 INFO - "revision": "7868898154ed9e19d98d9aa4c53b7da57c2bd187", 14:58:22 INFO - "stage_platform": "macosx64", 14:58:22 INFO - "builduid": "d136471e25854d8187882ce90d66d575", 14:58:22 INFO - "slavebuilddir": "test" 14:58:22 INFO - } 14:58:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 14:58:22 INFO - Running post-action listener: _resource_record_post_action 14:58:22 INFO - [mozharness: 2017-05-05 21:58:22.861459Z] Finished read-buildbot-config step (success) 14:58:22 INFO - [mozharness: 2017-05-05 21:58:22.861657Z] Running download-and-extract step. 14:58:22 INFO - Running pre-action listener: _resource_record_pre_action 14:58:22 INFO - Running main action method: download_and_extract 14:58:22 INFO - mkdir: /builds/slave/test/build/tests 14:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:22 INFO - trying https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 14:58:22 INFO - Downloading https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/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 14:58:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/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 14:58:24 INFO - Downloaded 1287 bytes. 14:58:24 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 14:58:24 INFO - Using the following test package requirements: 14:58:24 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:58:24 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 14:58:24 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 14:58:24 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:58:24 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 14:58:24 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:58:24 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 14:58:24 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:58:24 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:58:24 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 14:58:24 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 14:58:24 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:58:24 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 14:58:24 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:58:24 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 14:58:24 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:58:24 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 14:58:24 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:58:24 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 14:58:24 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 14:58:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 14:58:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 14:58:24 INFO - Fetch https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 14:58:25 INFO - Expected file size: 51227137 14:58:25 INFO - Obtained file size: 51227137 14:58:42 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 14:58:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 14:58:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 14:58:42 INFO - Fetch https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 14:58:43 INFO - Expected file size: 51227137 14:58:43 INFO - Obtained file size: 51227137 14:58:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 14:58:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 14:58:58 INFO - Fetch https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 14:59:00 INFO - Expected file size: 14404449 14:59:00 INFO - Obtained file size: 14404449 14:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:00 INFO - trying https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 14:59:00 INFO - Downloading https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 14:59:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/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 14:59:02 INFO - Downloaded 59560474 bytes. 14:59:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 14:59:02 INFO - mkdir: /builds/slave/test/properties 14:59:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:59:02 INFO - Writing to file /builds/slave/test/properties/build_url 14:59:02 INFO - Contents: 14:59:02 INFO - build_url:https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 14:59:02 INFO - Running post-action listener: _resource_record_post_action 14:59:02 INFO - Running post-action listener: set_extra_try_arguments 14:59:02 INFO - [mozharness: 2017-05-05 21:59:02.862006Z] Finished download-and-extract step (success) 14:59:02 INFO - [mozharness: 2017-05-05 21:59:02.862139Z] Running populate-webroot step. 14:59:02 INFO - Running pre-action listener: _resource_record_pre_action 14:59:02 INFO - Running main action method: populate_webroot 14:59:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:59:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:59:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:59:02 INFO - '--tppagecycles', 14:59:02 INFO - '7'], 14:59:02 INFO - 'tests': ['tsvgm']}}, 14:59:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:59:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:59:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:59:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:59:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:59:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:59:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:59:02 INFO - 'talos_options': ['--disable-e10s'], 14:59:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:59:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:59:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:59:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:59:02 INFO - 'talos_options': ['--disable-e10s'], 14:59:02 INFO - 'tests': ['damp', 'tps']}, 14:59:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:59:02 INFO - 'tests': ['damp', 'tps']}, 14:59:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:59:02 INFO - 'tests': ['dromaeo_dom']}, 14:59:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:59:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:59:02 INFO - 'tests': ['basic_compositor_video']}, 14:59:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:59:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:59:02 INFO - 'tests': ['a11yr', 14:59:02 INFO - 'ts_paint', 14:59:02 INFO - 'tpaint', 14:59:02 INFO - 'sessionrestore', 14:59:02 INFO - 'sessionrestore_no_auto_restore', 14:59:02 INFO - 'tabpaint']}, 14:59:02 INFO - 'other-e10s': {'tests': ['a11yr', 14:59:02 INFO - 'ts_paint', 14:59:02 INFO - 'tpaint', 14:59:02 INFO - 'sessionrestore', 14:59:02 INFO - 'sessionrestore_no_auto_restore', 14:59:02 INFO - 'tabpaint']}, 14:59:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:59:02 INFO - 'ts_paint', 14:59:02 INFO - 'tpaint', 14:59:02 INFO - 'sessionrestore', 14:59:02 INFO - 'sessionrestore_no_auto_restore', 14:59:02 INFO - 'tabpaint']}, 14:59:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:59:02 INFO - 'ts_paint', 14:59:02 INFO - 'tpaint', 14:59:02 INFO - 'sessionrestore', 14:59:02 INFO - 'sessionrestore_no_auto_restore', 14:59:02 INFO - 'tabpaint']}, 14:59:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:59:02 INFO - 'tests': ['a11yr', 14:59:02 INFO - 'ts_paint', 14:59:02 INFO - 'tpaint', 14:59:02 INFO - 'sessionrestore', 14:59:02 INFO - 'sessionrestore_no_auto_restore', 14:59:02 INFO - 'tabpaint']}, 14:59:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:59:02 INFO - 'tests': ['a11yr', 14:59:02 INFO - 'ts_paint', 14:59:02 INFO - 'tpaint', 14:59:02 INFO - 'sessionrestore', 14:59:02 INFO - 'sessionrestore_no_auto_restore', 14:59:02 INFO - 'tabpaint']}, 14:59:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:59:02 INFO - 'tests': ['tsvgx', 14:59:02 INFO - 'tsvgr_opacity', 14:59:02 INFO - 'tart', 14:59:02 INFO - 'tscrollx', 14:59:02 INFO - 'cart', 14:59:02 INFO - 'tsvg_static']}, 14:59:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:59:02 INFO - 'tsvgr_opacity', 14:59:02 INFO - 'tart', 14:59:02 INFO - 'tscrollx', 14:59:02 INFO - 'cart', 14:59:02 INFO - 'tsvg_static']}, 14:59:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:59:02 INFO - 'talos_options': ['--disable-e10s'], 14:59:02 INFO - 'tests': ['tp5o']}, 14:59:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:59:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:59:02 INFO - 'talos_options': ['--disable-e10s', 14:59:02 INFO - '--xperf_path', 14:59:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:59:02 INFO - 'tests': ['tp5n']}, 14:59:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:59:02 INFO - 'talos_options': ['--xperf_path', 14:59:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:59:02 INFO - 'tests': ['tp5n']}}, 14:59:02 INFO - 'talos.zip': {'path': '', 14:59:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:59:02 INFO - Running post-action listener: _resource_record_post_action 14:59:02 INFO - [mozharness: 2017-05-05 21:59:02.880814Z] Finished populate-webroot step (success) 14:59:02 INFO - [mozharness: 2017-05-05 21:59:02.880930Z] Running create-virtualenv step. 14:59:02 INFO - Running pre-action listener: _resource_record_pre_action 14:59:02 INFO - Running main action method: create_virtualenv 14:59:02 INFO - Creating virtualenv /builds/slave/test/build/venv 14:59:02 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 14:59:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:59:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:59:03 INFO - Using real prefix '/tools/python27' 14:59:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:59:03 INFO - Installing distribute.............................................................................................................................................................................................done. 14:59:06 INFO - Installing pip.................done. 14:59:06 INFO - Return code: 0 14:59:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:59:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:59:06 INFO - Reading from file tmpfile_stdout 14:59:06 INFO - Output received: 14:59:06 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) 14:59:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:59:06 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')]} 14:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:06 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')]} 14:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:06 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 0x108821b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108824768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed73dac080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085ffd30>, '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 0x108526db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085f4be8>, '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.nILFKlT48Q/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.gx88x5KtAS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 14:59:06 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 14:59:06 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 14:59:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nILFKlT48Q/Render', 14:59:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:59:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:59:06 INFO - 'HOME': '/Users/cltbld', 14:59:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:59:06 INFO - 'LOGNAME': 'cltbld', 14:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:06 INFO - 'MOZ_NO_REMOTE': '1', 14:59:06 INFO - 'NO_EM_RESTART': '1', 14:59:06 INFO - 'PAGER': '/bin/cat', 14:59:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:06 INFO - 'PWD': '/builds/slave/test', 14:59:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:59:06 INFO - 'SHELL': '/bin/bash', 14:59:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gx88x5KtAS/Listeners', 14:59:06 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 14:59:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:59:06 INFO - 'USER': 'cltbld', 14:59:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:59:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:06 INFO - 'XPC_FLAGS': '0x0', 14:59:06 INFO - 'XPC_SERVICE_NAME': '0', 14:59:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:07 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 14:59:07 INFO - Cleaning up... 14:59:07 INFO - Return code: 0 14:59:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:07 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 0x108821b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108824768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed73dac080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085ffd30>, '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 0x108526db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085f4be8>, '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.nILFKlT48Q/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.gx88x5KtAS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 14:59:07 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 14:59:07 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 14:59:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nILFKlT48Q/Render', 14:59:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:59:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:59:07 INFO - 'HOME': '/Users/cltbld', 14:59:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:59:07 INFO - 'LOGNAME': 'cltbld', 14:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:07 INFO - 'MOZ_NO_REMOTE': '1', 14:59:07 INFO - 'NO_EM_RESTART': '1', 14:59:07 INFO - 'PAGER': '/bin/cat', 14:59:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:07 INFO - 'PWD': '/builds/slave/test', 14:59:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:59:07 INFO - 'SHELL': '/bin/bash', 14:59:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gx88x5KtAS/Listeners', 14:59:07 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 14:59:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:59:07 INFO - 'USER': 'cltbld', 14:59:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:59:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:07 INFO - 'XPC_FLAGS': '0x0', 14:59:07 INFO - 'XPC_SERVICE_NAME': '0', 14:59:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:07 INFO - Downloading/unpacking psutil>=3.1.1 14:59:07 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 14:59:07 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 14:59:07 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 14:59:07 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 14:59:07 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 14:59:07 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 14:59:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:59:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:59:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:59:09 INFO - Installing collected packages: psutil 14:59:09 INFO - Running setup.py install for psutil 14:59:09 INFO - building 'psutil._psutil_osx' extension 14:59:09 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 14:59:10 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 14:59:10 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 14:59:10 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 14:59:10 INFO - building 'psutil._psutil_posix' extension 14:59:10 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 14:59:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:59:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:59:10 INFO - ^ 14:59:10 INFO - 1 warning generated. 14:59:10 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 14:59:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:59:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:59:10 INFO - Successfully installed psutil 14:59:10 INFO - Cleaning up... 14:59:10 INFO - Return code: 0 14:59:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:59:10 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')]} 14:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:10 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')]} 14:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:10 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 0x108821b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108824768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed73dac080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085ffd30>, '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 0x108526db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085f4be8>, '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.nILFKlT48Q/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.gx88x5KtAS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 14:59:10 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 14:59:10 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 14:59:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nILFKlT48Q/Render', 14:59:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:59:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:59:10 INFO - 'HOME': '/Users/cltbld', 14:59:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:59:10 INFO - 'LOGNAME': 'cltbld', 14:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:10 INFO - 'MOZ_NO_REMOTE': '1', 14:59:10 INFO - 'NO_EM_RESTART': '1', 14:59:10 INFO - 'PAGER': '/bin/cat', 14:59:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:10 INFO - 'PWD': '/builds/slave/test', 14:59:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:59:10 INFO - 'SHELL': '/bin/bash', 14:59:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gx88x5KtAS/Listeners', 14:59:10 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 14:59:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:59:10 INFO - 'USER': 'cltbld', 14:59:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:59:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:10 INFO - 'XPC_FLAGS': '0x0', 14:59:10 INFO - 'XPC_SERVICE_NAME': '0', 14:59:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:59:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:59:12 INFO - Installing collected packages: mozsystemmonitor 14:59:12 INFO - Running setup.py install for mozsystemmonitor 14:59:12 INFO - Successfully installed mozsystemmonitor 14:59:12 INFO - Cleaning up... 14:59:12 INFO - Return code: 0 14:59:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:59: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')]} 14:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59: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')]} 14:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:12 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 0x108821b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108824768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed73dac080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085ffd30>, '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 0x108526db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085f4be8>, '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.nILFKlT48Q/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.gx88x5KtAS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 14:59:12 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 14:59:12 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 14:59:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nILFKlT48Q/Render', 14:59:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:59:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:59:12 INFO - 'HOME': '/Users/cltbld', 14:59:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:59:12 INFO - 'LOGNAME': 'cltbld', 14:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:12 INFO - 'MOZ_NO_REMOTE': '1', 14:59:12 INFO - 'NO_EM_RESTART': '1', 14:59:12 INFO - 'PAGER': '/bin/cat', 14:59:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:12 INFO - 'PWD': '/builds/slave/test', 14:59:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:59:12 INFO - 'SHELL': '/bin/bash', 14:59:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gx88x5KtAS/Listeners', 14:59:12 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 14:59:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:59:12 INFO - 'USER': 'cltbld', 14:59:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:59:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:12 INFO - 'XPC_FLAGS': '0x0', 14:59:12 INFO - 'XPC_SERVICE_NAME': '0', 14:59:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:12 INFO - Downloading/unpacking jsonschema==2.5.1 14:59:12 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 14:59:12 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 14:59:12 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 14:59:12 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 14:59:12 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 14:59:12 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 14:59:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:59:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:59:14 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 14:59:14 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 14:59:14 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 14:59:14 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 14:59:14 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 14:59:14 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 14:59:14 INFO - Downloading functools32-3.2.3-2.tar.gz 14:59:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:59:14 INFO - warning: no files found matching '*.txt' 14:59:14 INFO - no previously-included directories found matching 'build' 14:59:14 INFO - no previously-included directories found matching 'dist' 14:59:14 INFO - no previously-included directories found matching '.git*' 14:59:14 INFO - Installing collected packages: jsonschema, functools32 14:59:14 INFO - Running setup.py install for functools32 14:59:14 INFO - warning: no files found matching '*.txt' 14:59:14 INFO - no previously-included directories found matching 'build' 14:59:14 INFO - no previously-included directories found matching 'dist' 14:59:14 INFO - no previously-included directories found matching '.git*' 14:59:14 INFO - Successfully installed jsonschema functools32 14:59:14 INFO - Cleaning up... 14:59:14 INFO - Return code: 0 14:59:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:15 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')]} 14:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:15 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 0x108821b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108824768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed73dac080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085ffd30>, '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 0x108526db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085f4be8>, '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.nILFKlT48Q/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.gx88x5KtAS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 14:59:15 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 14:59:15 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 14:59:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nILFKlT48Q/Render', 14:59:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:59:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:59:15 INFO - 'HOME': '/Users/cltbld', 14:59:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:59:15 INFO - 'LOGNAME': 'cltbld', 14:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:15 INFO - 'MOZ_NO_REMOTE': '1', 14:59:15 INFO - 'NO_EM_RESTART': '1', 14:59:15 INFO - 'PAGER': '/bin/cat', 14:59:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:15 INFO - 'PWD': '/builds/slave/test', 14:59:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:59:15 INFO - 'SHELL': '/bin/bash', 14:59:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gx88x5KtAS/Listeners', 14:59:15 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 14:59:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:59:15 INFO - 'USER': 'cltbld', 14:59:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:59:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:15 INFO - 'XPC_FLAGS': '0x0', 14:59:15 INFO - 'XPC_SERVICE_NAME': '0', 14:59:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:59:15 INFO - Cleaning up... 14:59:15 INFO - Return code: 0 14:59:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:59:15 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')]} 14:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:15 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')]} 14:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:16 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 0x108821b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108824768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed73dac080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085ffd30>, '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 0x108526db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085f4be8>, '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.nILFKlT48Q/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.gx88x5KtAS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 14:59:16 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 14:59:16 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 14:59:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nILFKlT48Q/Render', 14:59:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:59:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:59:16 INFO - 'HOME': '/Users/cltbld', 14:59:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:59:16 INFO - 'LOGNAME': 'cltbld', 14:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:16 INFO - 'MOZ_NO_REMOTE': '1', 14:59:16 INFO - 'NO_EM_RESTART': '1', 14:59:16 INFO - 'PAGER': '/bin/cat', 14:59:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:16 INFO - 'PWD': '/builds/slave/test', 14:59:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:59:16 INFO - 'SHELL': '/bin/bash', 14:59:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gx88x5KtAS/Listeners', 14:59:16 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 14:59:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:59:16 INFO - 'USER': 'cltbld', 14:59:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:59:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:16 INFO - 'XPC_FLAGS': '0x0', 14:59:16 INFO - 'XPC_SERVICE_NAME': '0', 14:59:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:59:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:16 INFO - Downloading/unpacking blobuploader==1.2.4 14:59:16 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 14:59:16 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 14:59:16 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 14:59:16 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 14:59:16 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 14:59:16 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 14:59:17 INFO - Downloading blobuploader-1.2.4.tar.gz 14:59:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:59:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:59:17 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 14:59:17 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 14:59:17 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 14:59:17 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 14:59:17 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 14:59:17 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 14:59:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:59:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:59:18 INFO - Downloading docopt-0.6.1.tar.gz 14:59:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:59:18 INFO - Installing collected packages: blobuploader, requests, docopt 14:59:18 INFO - Running setup.py install for blobuploader 14:59:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:59:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:59:18 INFO - Running setup.py install for requests 14:59:19 INFO - Running setup.py install for docopt 14:59:19 INFO - Successfully installed blobuploader requests docopt 14:59:19 INFO - Cleaning up... 14:59:19 INFO - Return code: 0 14:59:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:59: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')]} 14:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59: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')]} 14:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:19 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 0x108821b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108824768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed73dac080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085ffd30>, '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 0x108526db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085f4be8>, '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.nILFKlT48Q/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.gx88x5KtAS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 14:59:19 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 14:59:19 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 14:59:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nILFKlT48Q/Render', 14:59:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:59:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:59:19 INFO - 'HOME': '/Users/cltbld', 14:59:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:59:19 INFO - 'LOGNAME': 'cltbld', 14:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:19 INFO - 'MOZ_NO_REMOTE': '1', 14:59:19 INFO - 'NO_EM_RESTART': '1', 14:59:19 INFO - 'PAGER': '/bin/cat', 14:59:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:19 INFO - 'PWD': '/builds/slave/test', 14:59:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:59:19 INFO - 'SHELL': '/bin/bash', 14:59:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gx88x5KtAS/Listeners', 14:59:19 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 14:59:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:59:19 INFO - 'USER': 'cltbld', 14:59:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:59:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:19 INFO - 'XPC_FLAGS': '0x0', 14:59:19 INFO - 'XPC_SERVICE_NAME': '0', 14:59:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:59:19 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-hnx4ha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:59:19 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-uUgBxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:59:20 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-DXcFyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:59:20 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-HI5kxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:59:20 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-rcgZpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:59:20 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-E_jWwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:59:20 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-UiTJc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:59:20 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-1mNBFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:59:20 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-sWP682-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:59:20 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-8ybBjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:59:20 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-4DCFL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:59:20 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-0p9lKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:59:21 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-151w_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:59:21 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-cOVbfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:21 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-C4fKXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:59:21 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-Wk32xI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:59:21 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-f3mVfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:59:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:59:21 INFO - Running setup.py install for manifestparser 14:59:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:59:21 INFO - Running setup.py install for mozcrash 14:59:21 INFO - Running setup.py install for mozdebug 14:59:22 INFO - Running setup.py install for mozdevice 14:59:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:59:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:59:22 INFO - Running setup.py install for mozfile 14:59:22 INFO - Running setup.py install for mozhttpd 14:59:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:59:22 INFO - Running setup.py install for mozinfo 14:59:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:59:22 INFO - Running setup.py install for mozInstall 14:59:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:59:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:59:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:59:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:59:22 INFO - Running setup.py install for mozleak 14:59:22 INFO - Running setup.py install for mozlog 14:59:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:59:23 INFO - Running setup.py install for moznetwork 14:59:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:59:23 INFO - Running setup.py install for mozprocess 14:59:23 INFO - Running setup.py install for mozprofile 14:59:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:59:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:59:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:59:23 INFO - Running setup.py install for mozrunner 14:59:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:59:23 INFO - Running setup.py install for mozscreenshot 14:59:23 INFO - Running setup.py install for moztest 14:59:24 INFO - Running setup.py install for mozversion 14:59:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:59:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:59:24 INFO - Cleaning up... 14:59:24 INFO - Return code: 0 14:59:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:59: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')]} 14:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59: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')]} 14:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:24 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 0x108821b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108824768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed73dac080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085ffd30>, '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 0x108526db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085f4be8>, '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.nILFKlT48Q/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.gx88x5KtAS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 14:59:24 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 14:59:24 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 14:59:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nILFKlT48Q/Render', 14:59:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:59:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:59:24 INFO - 'HOME': '/Users/cltbld', 14:59:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:59:24 INFO - 'LOGNAME': 'cltbld', 14:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:24 INFO - 'MOZ_NO_REMOTE': '1', 14:59:24 INFO - 'NO_EM_RESTART': '1', 14:59:24 INFO - 'PAGER': '/bin/cat', 14:59:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:24 INFO - 'PWD': '/builds/slave/test', 14:59:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:59:24 INFO - 'SHELL': '/bin/bash', 14:59:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gx88x5KtAS/Listeners', 14:59:24 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 14:59:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:59:24 INFO - 'USER': 'cltbld', 14:59:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:59:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:24 INFO - 'XPC_FLAGS': '0x0', 14:59:24 INFO - 'XPC_SERVICE_NAME': '0', 14:59:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:59:24 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-D6PDoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:59:24 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)) 14:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:59:24 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-drk9UH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:59:24 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)) 14:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:59:24 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-qnIb2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:59:24 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)) 14:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:59:24 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-CVPJMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:59:24 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)) 14:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:59:24 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-R4Y6qh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:59:25 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)) 14:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:59:25 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-x7_AFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:59:25 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)) 14:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:59:25 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-tA4Uu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:59:25 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)) 14:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:59:25 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-ix0r3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:59:25 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)) 14:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:59:25 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-zixsD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:59:25 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)) 14:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:59:25 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-6qYfSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:59:25 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)) 14:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:59:25 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-KEEXBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:59:25 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)) 14:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:59:25 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-RXr3ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:59:25 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)) 14:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:59:25 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-sgi_fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:59:25 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)) 14:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:59:25 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-DpCnZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:59:26 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)) 14:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:26 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-sVY1ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:26 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)) 14:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:59:26 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-oI1TYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:59:26 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)) 14:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:59:26 INFO - Running setup.py (path:/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/pip-6DrOPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:59:26 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)) 14:59:26 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)) 14:59:26 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)) 14:59:26 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)) 14:59:26 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)) 14:59:26 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)) 14:59:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:59: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 14:59: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 14:59: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 14:59: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 14:59: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 14:59: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 14:59:27 INFO - Downloading blessings-1.6.tar.gz 14:59:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:59:27 INFO - Installing collected packages: blessings 14:59:27 INFO - Running setup.py install for blessings 14:59:27 INFO - Successfully installed blessings 14:59:27 INFO - Cleaning up... 14:59:28 INFO - Return code: 0 14:59:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:59:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:59:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:59:28 INFO - Reading from file tmpfile_stdout 14:59:28 INFO - Current package versions: 14:59:28 INFO - blessings == 1.6 14:59:28 INFO - blobuploader == 1.2.4 14:59:28 INFO - docopt == 0.6.1 14:59:28 INFO - functools32 == 3.2.3-2 14:59:28 INFO - jsonschema == 2.5.1 14:59:28 INFO - manifestparser == 1.1 14:59:28 INFO - mozInstall == 1.12 14:59:28 INFO - mozcrash == 1.0 14:59:28 INFO - mozdebug == 0.1 14:59:28 INFO - mozdevice == 0.49 14:59:28 INFO - mozfile == 1.2 14:59:28 INFO - mozhttpd == 0.7 14:59:28 INFO - mozinfo == 0.9 14:59:28 INFO - mozleak == 0.1 14:59:28 INFO - mozlog == 3.4 14:59:28 INFO - moznetwork == 0.27 14:59:28 INFO - mozprocess == 0.25 14:59:28 INFO - mozprofile == 0.28 14:59:28 INFO - mozrunner == 6.13 14:59:28 INFO - mozscreenshot == 0.1 14:59:28 INFO - mozsystemmonitor == 0.3 14:59:28 INFO - moztest == 0.8 14:59:28 INFO - mozversion == 1.4 14:59:28 INFO - psutil == 3.1.1 14:59:28 INFO - requests == 1.2.3 14:59:28 INFO - wsgiref == 0.1.2 14:59:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:59:28 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')]} 14:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:28 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')]} 14:59:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:28 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 0x108821b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108824768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed73dac080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085ffd30>, '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 0x108526db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085f4be8>, '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.nILFKlT48Q/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.gx88x5KtAS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 14:59:28 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 14:59:28 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 14:59:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nILFKlT48Q/Render', 14:59:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:59:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:59:28 INFO - 'HOME': '/Users/cltbld', 14:59:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:59:28 INFO - 'LOGNAME': 'cltbld', 14:59:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:28 INFO - 'MOZ_NO_REMOTE': '1', 14:59:28 INFO - 'NO_EM_RESTART': '1', 14:59:28 INFO - 'PAGER': '/bin/cat', 14:59:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:59:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:28 INFO - 'PWD': '/builds/slave/test', 14:59:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:59:28 INFO - 'SHELL': '/bin/bash', 14:59:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gx88x5KtAS/Listeners', 14:59:28 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 14:59:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:59:28 INFO - 'USER': 'cltbld', 14:59:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:59:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:59:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:28 INFO - 'XPC_FLAGS': '0x0', 14:59:28 INFO - 'XPC_SERVICE_NAME': '0', 14:59:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:59:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:28 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)) 14:59:28 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)) 14:59:28 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)) 14:59:28 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)) 14:59:28 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)) 14:59:28 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)) 14:59:28 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)) 14:59:28 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)) 14:59:28 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)) 14:59:28 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)) 14:59:28 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)) 14:59:28 INFO - Cleaning up... 14:59:28 INFO - Return code: 0 14:59:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:59:28 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')]} 14:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:28 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')]} 14:59:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108821b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108824768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed73dac080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085ffd30>, '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 0x108526db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085f4be8>, '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.nILFKlT48Q/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.gx88x5KtAS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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 14:59: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', 'jsonschema'] in /builds/slave/test/build 14:59: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 jsonschema 14:59:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nILFKlT48Q/Render', 14:59:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:59:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:59:28 INFO - 'HOME': '/Users/cltbld', 14:59:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:59:28 INFO - 'LOGNAME': 'cltbld', 14:59:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:28 INFO - 'MOZ_NO_REMOTE': '1', 14:59:28 INFO - 'NO_EM_RESTART': '1', 14:59:28 INFO - 'PAGER': '/bin/cat', 14:59:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:59:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:28 INFO - 'PWD': '/builds/slave/test', 14:59:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:59:28 INFO - 'SHELL': '/bin/bash', 14:59:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gx88x5KtAS/Listeners', 14:59:28 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 14:59:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:59:28 INFO - 'USER': 'cltbld', 14:59:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:59:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:59:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:28 INFO - 'XPC_FLAGS': '0x0', 14:59:28 INFO - 'XPC_SERVICE_NAME': '0', 14:59:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:59:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:59:28 INFO - Cleaning up... 14:59:28 INFO - Return code: 0 14:59:28 INFO - Running post-action listener: _resource_record_post_action 14:59:28 INFO - Running post-action listener: _start_resource_monitoring 14:59:28 INFO - Starting resource monitoring. 14:59:28 INFO - [mozharness: 2017-05-05 21:59:28.950080Z] Finished create-virtualenv step (success) 14:59:28 INFO - [mozharness: 2017-05-05 21:59:28.951043Z] Running install step. 14:59:28 INFO - Running pre-action listener: _resource_record_pre_action 14:59:28 INFO - Running main action method: install 14:59:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:59:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:59:29 INFO - Reading from file tmpfile_stdout 14:59:29 INFO - Detecting whether we're running mozinstall >=1.0... 14:59:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:59:29 INFO - Reading from file tmpfile_stdout 14:59:29 INFO - Output received: 14:59:29 INFO - Usage: mozinstall [options] installer 14:59:29 INFO - Options: 14:59:29 INFO - -h, --help show this help message and exit 14:59:29 INFO - -d DEST, --destination=DEST 14:59:29 INFO - Directory to install application into. [default: 14:59:29 INFO - "/builds/slave/test"] 14:59:29 INFO - --app=APP Application being installed. [default: firefox] 14:59:29 INFO - mkdir: /builds/slave/test/build/application 14:59:29 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'] 14:59:29 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 14:59:43 INFO - Reading from file tmpfile_stdout 14:59:43 INFO - Output received: 14:59:43 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:59:43 INFO - Running post-action listener: _resource_record_post_action 14:59:43 INFO - [mozharness: 2017-05-05 21:59:43.999426Z] Finished install step (success) 14:59:43 INFO - [mozharness: 2017-05-05 21:59:43.999582Z] Running run-tests step. 14:59:43 INFO - Running pre-action listener: _resource_record_pre_action 14:59:43 INFO - Running main action method: run_tests 14:59:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:59:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:59:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:59:44 INFO - 2017-05-05 14:59:44.014 screenresolution[2609:79854] starting screenresolution argv=screenresolution get 14:59:44 INFO - 2017-05-05 14:59:44.017 screenresolution[2609:79854] Display 0: 1600x1200x32@60 14:59:44 INFO - 2017-05-05 14:59:44.023 screenresolution[2610:79856] starting screenresolution argv=screenresolution list 14:59:44 INFO - Available Modes on Display 0 14:59:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:59:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:59:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:59:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:59:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:59:44 INFO - Intel Iris: 14:59:44 INFO - Chipset Model: Intel Iris 14:59:44 INFO - Type: GPU 14:59:44 INFO - Bus: Built-In 14:59:44 INFO - VRAM (Dynamic, Max): 1536 MB 14:59:44 INFO - Vendor: Intel (0x8086) 14:59:44 INFO - Device ID: 0x0a2e 14:59:44 INFO - Revision ID: 0x0009 14:59:44 INFO - Displays: 14:59:44 INFO - Display: 14:59:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:59:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:59:44 INFO - Display Serial Number: 1600x1200 60 14:59:44 INFO - Main Display: Yes 14:59:44 INFO - Mirror: Off 14:59:44 INFO - Online: Yes 14:59:44 INFO - Rotation: Supported 14:59:44 INFO - Return code: 0 14:59:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:59:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:59:44 INFO - Python 2.7.3 14:59:44 INFO - Return code: 0 14:59:44 INFO - grabbing minidump binary from tooltool 14:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:44 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 0x1085ffd30>, '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 0x108526db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085f4be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:59:44 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 14:59:44 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 14:59:44 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 14:59:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:59:44 INFO - Return code: 0 14:59:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:59:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:59:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:59:44 INFO - ENV: RUST_BACKTRACE is now 1 14:59:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:59:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:59:44 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/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0350', '--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 14:59:44 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/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0350 --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 14:59:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nILFKlT48Q/Render', 14:59:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:59:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:59:44 INFO - 'HOME': '/Users/cltbld', 14:59:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:59:44 INFO - 'LOGNAME': 'cltbld', 14:59:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:59:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:44 INFO - 'MOZ_NO_REMOTE': '1', 14:59:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:59:44 INFO - 'NO_EM_RESTART': '1', 14:59:44 INFO - 'PAGER': '/bin/cat', 14:59:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:44 INFO - 'PWD': '/builds/slave/test', 14:59:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:59:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:59:44 INFO - 'RUST_BACKTRACE': '1', 14:59:44 INFO - 'SHELL': '/bin/bash', 14:59:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gx88x5KtAS/Listeners', 14:59:44 INFO - 'TMPDIR': '/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/', 14:59:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:59:44 INFO - 'USER': 'cltbld', 14:59:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:59:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:44 INFO - 'XPC_FLAGS': '0x0', 14:59:44 INFO - 'XPC_SERVICE_NAME': '0', 14:59:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:59:44 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/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0350', '--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 14:59:44 INFO - mozversion application_buildid: 20170505135642 14:59:44 INFO - mozversion application_changeset: 7868898154ed9e19d98d9aa4c53b7da57c2bd187 14:59:44 INFO - mozversion application_display_name: Firefox 14:59:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:59:44 INFO - mozversion application_name: Firefox 14:59:44 INFO - mozversion application_remotingname: firefox 14:59:44 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:59:44 INFO - mozversion application_vendor: Mozilla 14:59:44 INFO - mozversion application_version: 54.0 14:59:44 INFO - mozversion platform_buildid: 20170505135642 14:59:44 INFO - mozversion platform_changeset: 7868898154ed9e19d98d9aa4c53b7da57c2bd187 14:59:44 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:59:44 INFO - mozversion platform_version: 54.0 14:59:44 INFO - using testdate: 1494021584 14:59:44 INFO - actual date: 1494021584 14:59:44 INFO - starting webserver on 'localhost:55361' 14:59:44 INFO - SUITE-START | Running 2 tests 14:59:44 INFO - TEST-START | dromaeo_css 14:59:44 INFO - operating with platform_type : mac_ 14:59:44 INFO - Initialising browser for dromaeo_css test... 14:59:44 INFO - TEST-INFO | started process 2620 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/tmp16NrNn/profile http://localhost:55361/getInfo.html) 14:59:47 INFO - PROCESS | 2620 | 2017-05-05 14:59:47.311 plugin-container[2623:80017] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b3f, name = 'com.apple.tsm.portname' 14:59:47 INFO - PROCESS | 2620 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:59:47 INFO - PROCESS | 2620 | 2017-05-05 14:59:47.312 plugin-container[2623:80017] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a2b, name = 'com.apple.CFPasteboardClient' 14:59:47 INFO - PROCESS | 2620 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:59:47 INFO - PROCESS | 2620 | 2017-05-05 14:59:47.312 plugin-container[2623:80017] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:59:47 INFO - PROCESS | 2620 | __metrics Screen width/height:1600/1200 14:59:47 INFO - PROCESS | 2620 | colorDepth:24 14:59:47 INFO - PROCESS | 2620 | Browser inner width/height: 1024/689 14:59:47 INFO - PROCESS | 2620 | __metrics 14:59:47 ERROR - PROCESS | 2620 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 14:59:48 INFO - TEST-INFO | 2620: exit 0 14:59:48 INFO - Browser initialized. 14:59:48 INFO - Running cycle 1/1 for dromaeo_css test... 14:59:48 INFO - TEST-INFO | started process 2624 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/tmp16NrNn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:59:50 INFO - PROCESS | 2624 | 2017-05-05 14:59:50.339 plugin-container[2625:80147] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4537, name = 'com.apple.tsm.portname' 14:59:50 INFO - PROCESS | 2624 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:59:50 INFO - PROCESS | 2624 | 2017-05-05 14:59:50.340 plugin-container[2625:80147] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x460b, name = 'com.apple.CFPasteboardClient' 14:59:50 INFO - PROCESS | 2624 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:59:50 INFO - PROCESS | 2624 | 2017-05-05 14:59:50.340 plugin-container[2625:80147] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:00:00 INFO - PROCESS | 2624 | RSS: Main: 174329856 15:00:00 INFO - PROCESS | 2624 | 15:03:03 INFO - PROCESS | 2624 | Cycle 1(1): loaded http://localhost:55361/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55361/tests/dromaeo/cssquery-ext.html) 15:03:05 INFO - PROCESS | 2624 | RSS: Main: 194560000 15:03:05 INFO - PROCESS | 2624 | 15:06:07 INFO - PROCESS | 2624 | Cycle 1(1): loaded http://localhost:55361/tests/dromaeo/cssquery-ext.html (next: http://localhost:55361/tests/dromaeo/cssquery-jquery.html) 15:06:08 INFO - PROCESS | 2624 | RSS: Main: 206651392 15:06:08 INFO - PROCESS | 2624 | 15:09:10 INFO - PROCESS | 2624 | Cycle 1(1): loaded http://localhost:55361/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55361/tests/dromaeo/cssquery-mootools.html) 15:09:10 INFO - PROCESS | 2624 | RSS: Main: 208224256 15:09:10 INFO - PROCESS | 2624 | 15:12:12 INFO - PROCESS | 2624 | Cycle 1(1): loaded http://localhost:55361/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55361/tests/dromaeo/cssquery-prototype.html) 15:12:13 INFO - PROCESS | 2624 | RSS: Main: 211320832 15:12:13 INFO - PROCESS | 2624 | 15:15:16 INFO - PROCESS | 2624 | Cycle 1(1): loaded http://localhost:55361/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55361/tests/dromaeo/cssquery-yui.html) 15:15:16 INFO - PROCESS | 2624 | RSS: Main: 213815296 15:15:16 INFO - PROCESS | 2624 | 15:18:19 INFO - PROCESS | 2624 | Cycle 1(1): loaded http://localhost:55361/tests/dromaeo/cssquery-yui.html (next: http://localhost:55361/tests/dromaeo/cssquery-dojo.html) 15:18:19 INFO - PROCESS | 2624 | RSS: Main: 211742720 15:18:19 INFO - PROCESS | 2624 | 15:18:19 INFO - PROCESS | 2624 | __start_tp_report 15:18:19 INFO - PROCESS | 2624 | _x_x_mozilla_page_load 15:18:19 INFO - PROCESS | 2624 | _x_x_mozilla_page_load_details 15:18:19 INFO - PROCESS | 2624 | |i|pagename|runs| 15:18:19 INFO - PROCESS | 2624 | |0;dojo.html;3583.8924832255034;3587.013571267901;3606.0624237698225;3612.674859262667;3669.266146770645;4755.9286610700865;6144;6198.628082315058;6206.937930620692;6226.190595222614;6164.815055548341;6215.720292586833;6235.469985051276;6241.282252540959;6246.812595622138;5538.252335934648;5560.138178582306;5582.581306402036;5640.858978525549;5675.404082571333;5694.117411801157;5698.715064246771;5701.914471282934;5719.28508936383;5744.6840423776885;5431.891362172754;5453.045716999529;5675.233843431146;5678.318601767794;5698.971505142468;4464.46426428829;5018.749062546858;5146.5110814472755;5532.502074813246;5559.582306511814;5458.235846981426;5557.861053473655;5581.832545023656;5596;5647.209390685307;6201.751929922798;6229.906551401733;6246.968765156191;6256.843578910518;6301.810945671591;6302.086197501337;6359.300476947578;6555.04951781989;6580.276169621337;6604.471642268607;6484.319146489598;6561.179852518435;6575.243846957565;6613.801585952429;6669.399754022162;6249.375062493714;6250.656213908279;6289.9999999999545;6292.937070629281;6296.748130074838;6821.829454263584;6853;6890.965545172242;6894.724211031503;6907.412869906014;6236.750529978841;6293;6351.237851457762;6411.775587854496;6417.871642567123;6656.900146497806;6707.027481015225;6719.966400167968;6731.932680673229;6734.6632668367365;6536.705848236841;6553.508486863504;6564.376384243489;6590.340965903371;6613.801585952429;6297.149884765498;6335.714892829834;6452.9677351612945;6589.341065893373;6644.8671026579195;5183.922241166386;5210.244514545369;5281.709505977131;5303.4696530346655;5348.946510534923;4617.930731039037;4627.490975992638;4664.090502352076;4680.08738296029;4694.131585656664;6260.843478913063;6273.37266273369;6308.243010838637;6310.400511951358;6316.30520642729;6397.584157029778;6444.613323200623;6536.607803531803;6620.0069989501;6734.595924244561;6322.873542529123;6326.051092336094;6343.9682801585695;6348.619082855043;6350.396712312323;5950.821475355746;5962.821115366546;5966.552508561876;5967.492763115184;5972.910406343908;6613.371729685672;6708.899366509604;6799.422049125682;6916.6541672916155;6971.5468494547695;6692.464602831665;6716.932830671631;6736.831579210363;6737.393634572912;6744.932550674431;6839.93160068393;6902.447804175755;6939.444844412334;6986.16166060076;6993.790186294419;6279.995200767855;6351.333110023381;6584.259457948884;6587.901181482377;6629.105070815378;6553.836154096186;6574.704138313692;6697.665116744241;6709.7651582194385;6719.328067193242;6482.995135753966;6488.578242414228;6503.902441463477;6506.121673574196;6510.153680021567;6236.18929539157;6426.775062872777;6434.806955791334;6483.481321494175;6509.511786615928;6131.5295901671125;6145.907811382922;6194.256689197145;6224.1597384352535;6268.1851359323;5729.140628905698;6158.753649854135;6490.058941453557;6491.156149700509;6506.479481641362;5540.889182216414;6167.629942203482;6177.598456100339;6220.129181914626;6292.8426789328805 15:18:19 INFO - PROCESS | 2624 | |1;ext.html;774.8527779721852;819.6721311475409;841.0664162779314;979.2753362511744;982.5480279071627;37685.81157094214;38468.42297365542;38650;40421.98945026376;40486.392704109465;33194.00417987464;39714.40428393569;39777.60222397775;39965.00087497814;40082.59917400825;8242.381821363377;8376.41365104443;8389.32885369169;11076.446177691083;11385.658430247064;9761.902380976171;11049.060829829474;11207.159463040263;11305.039071678875;11316.830247546293;11289.435528223597;11302.434878256096;11319.547218111265;11345.26255793375;11351.772964540703;11269.323840569552;11294.20940534163;11299.03958163553;11300.547978080867;11308.491117899714;10954.671359859218;10962.835557466644;11010.284331518425;11034.337939723562;11052.557897684082;32866.83566582152;34954.65045349539;35073.82463087694;35156.47265290997;35191;3745.3632882410056;3923.862664806718;3929.9978505480917;3941.2511622791576;4004.199160167978;25980.610290845652;26016.479670406487;26058.869705651352;27544.17367478979;27578.172654820388;3110.766692498049;3270.640229574745;3380.6281309055985;3394.6775056369606;3403.0981789825714;313773;315467;359696.20151899336;366330;378100.1094994535;37272;44821.775891120335;45194;45237.77381113073;45362.77318613386;46245.76877115593;46428.83927901829;46551;46705.53294467012;47625.76187119042;13330.133541319783;13355.799663005062;13401.262930538915;13409.061365704501;13431.731365372638;12538.247705137539;12548.121631485708;12568.434420451102;12617.116801823968;12640.05199610033;12108.273503589637;12134.575289864812;12146.696332591579;12171.695707607381;12223.69440763988;5683.687397193194;5729.914051289151;5730.799422020293;5740.942590574125;5747.885042299131;909.1317791509093;1138.8747237803834;1162.2968104296779;1168.7837750016104;1214.6963259185204;23210.65184022241;27171;27630.3092422687;27957.860210698815;28389.43221135607;1293.7283170534106;1303.1529505821293;1308.6924572725402;1313.1267706974945;1319.769040417923;12621.053420993463;12703.872961270454;14263;14551.199684017269;14555.563333100024;426505;428115;430534;430621;433135;56444.43555564474;57012.71493642505;57030.71484642633;57038.714806425705;57173.71413142991;1477.1875468492287;1484.6140003599141;1516.6435887566413;1519.620094976256;1526.1682383101236;24349;25630.487390252463;26606;27157.72842271552;27181.456370872867;46397.76801115973;46750.53249467598;46782.064358713316;46845.53154468548;46958;377147;379070;380041;380379;383368;27816.304592385353;28486.43027139404;31419.900303490183;32361.867334643175;32513.674863251064;44545;44559.777201113786;45261.54738452705;46102.847428814544;46385;30095.69904300929;30126.397472050874;30521.93173238926;31353.68646313599;31700.04899853008;29300.413991720474;29426.705732942395;31840.203994900312;31897.521537177425;32269.031929042165;34940.65059349374;35516.644833551334;35556.82221588979;35608.10979725424;35798;25611.231663050137;28879.85560072186;29017.854910725313;29528.852355738083;30202;19987.500312491724;23495.647565286192;23984.28047158588;24385;24387.512249755262 15:18:19 INFO - PROCESS | 2624 | |2;jquery.html;430.393145664613;439.59996403273016;442.0738552732025;448.5671327169281;451.6951058035825;16981.320747170128;19875.50311242218;20761.688574671392;22065.00707468164;22122.557548849014;17819.663525235595;23220.65169022466;23887.761122388816;23929.40176495584;24131.7934103295;6337.1761670982705;6738.35985581369;7110.751123710671;7128.215896251434;7146.78559643209;6836.897446538306;6994.6152961587095;7046.295370462938;7046.577205367695;7046.85906281874;6653.4677225821815;6933.583984960893;6993.930060699404;7038.6128762918015;7054.541454805447;6935.72257109715;6953.930460695379;6985;6985.336393042653;7002.964985175067;6480.351964803482;6840.555363901331;6853.383195512428;6872.553284036521;6877.690503927335;23734.64398034031;27641.032563860368;27660.861695691394;27924.58113128305;28109;2670.7996900232365;3077.584526088972;3152.2277042124824;3152.4325621388143;3153.7003984621424;12131.757364852741;17388.91305543477;17424.12879356027;17578.648427031516;17651;2059.073416962373;2105.473631592102;2109.6519074352714;2110.2825039486493;2114.587655407196;110580;141685.29157354147;142962;144111.27944360315;148803.25598372048;21145.471363216042;21678.34964951054;21820.563588728455;21829.890850545646;21908.45228869291;33889.32221355559;34108.65891341105;34567;34653.65346346555;34875.825620871736;10899.182561307774;11167.05080068187;11477.426128693533;11541.480633371519;11683;9301.581428835718;9306.395084319498;9320.813583728423;9431.528423578793;9472.242220622335;9532.568275420843;9786.217102631772;10476.161907047417;10668.30656007357;10779.598652175167;4167.333226683716;4173.7478756373575;4309.405519957636;4344.000879797664;4509.88725281864;1016.3190662256306;1094.0700404656138;1113.7080986056135;1150.7986102432208;1180.7756526260155;21957.67063494049;23447.827608619842;23617.645735313985;24093.397665058514;24270.878645607012;1154.105568184647;1166.3002198680724;1183.4970137691446;1208.474313673555;1211.8121691137887;11769.293842369485;12608.243505389706;12634.747305053848;12726.045546584044;12928.806067908989;739098;762108;766798.1660091664;778896;785721;133460;134946.6505334934;137091.6290837079;146149.26925365304;148201;1244.589285535789;1342.134323361446;1420.850810664886;1454.6363409147714;1463.7950686903841;19279.554033447268;20460.59078818445;20625.69061464109;20643.864587447835;20686.482837929172;59994.70002649959;60249.69875150596;66124.67750645056;66746.99879501908;68254;98858;99443;99864;101988;102245;11808.527658893549;11850.525978960744;11868.703282418008;11931.940340298243;12130.7869213078;6509.479241660751;11725.706857328634;13335.66660833487;13415.32923353848;13911.582652520441;11555.711107222387;11607.76784464289;11903.583374581847;11930;12063.75872482563;10817.350958942488;10906.018458338787;10910.945445272722;11139.673526618557;11155.888441115485;11793.52825886955;11866.881331186578;11986.76026479483;12000.819987700017;12112.75774484523;10443.425611591436;11695.181337306307;11762.235454695418;11945.820812687643;12115.636530904087;8882.333824963025;11403.144764142888;11525.366104864313;11636.243644163102;11850.822237666614 15:18:19 INFO - PROCESS | 2624 | |3;mootools.html;1480.4892312152308;1567.5454118305693;1625.6667383186448;1633.8121116071652;1641.0973964319621;11111.666650000503;11386.544538218483;11708.531658733651;11747.647570572886;11890.821637675443;11548.249363791349;11775.823362649568;11788.587399441021;11808.822867656992;11840.407979601028;2286.1998300594823;2458.151937581536;2463.8398504097268;2509.04656230633;2515.195137555983;2464.9260522184363;2483.255023492954;2520.6723125993685;2521.848689078652;2524.091327122244;2456.8771561421945;2473.3940184654693;2480.367506285904;2483.4784695213934;2497.1884137655243;2432.8175386846056;2449.0571130115036;2463.0763463701114;2467;2494.3888747256856;2083.760367557735;2452.3746444656676;2463.507298540281;2474.2948259745885;2480.875956202183;11181.776364472666;11498.827517587159;11505.712357191054;11510.964013238849;11527.19309648325;5912.467877890967;6074.848128796772;6128.540359473012;6147.385261473817;6156.507479401637;3498.755087143901;3639.7452178347526;3656.744027918047;3732.458793474931;3784.413415920537;1063.5639387851022;1216.7627312674033;1220.7924652809045;1247.8253044573767;1281.507044293397;14308.856911430961;14640.853591464056;15221.923890380587;15779.605509862231;16037.198140092949;4231.2383770920915;4821.011692603008;4902.940764878759;5009.77456014473;5021;12268.141230113984;12292.139550231577;12348.814767778491;12350.011999040054;12382.947449466896;5502.339719233638;5849.683821140295;6115.1744514490865;6134.110553969649;6138.693065346804;5354.277172581729;5456.7544460499375;5577.944220557823;5602.327720673464;5672.092465205547;4045.3700836171665;4111.5477297497255;4113.753174809521;4146.564610715892;4166.104287578125;1081.5944020992129;1090.0516550601028;1095.2552264460085;1099.8405231241425;1110.6667999600088;864.8962124544969;959.2517836087862;977.8484334928097;978.5889926231;992.717075633441;6803.795886123424;6833.5216534843075;6867.759628412981;6993.076903851482;7007.964960175166;971.3977334052933;986.659602437158;1004.4475538453821;1016.2835201183149;1016.6492560066765;3693.4275187346007;4078.7173467859225;4371.912561748747;4427.933580996288;4475.149721552894;13541.322933853267;13946.442142314396;14123.505677301246;14146.29268536569;14177.716445671029;12153;13474.124181928144;13787.310634468236;13927.860721392657;13930.860691392956;8988.820223595621;10322.43226622528;10418.270721049454;10475.423851688078;10489.947550262199;6052.969735151296;6544.509161812978;7067.363937245673;7147.606881621561;7148.249433809375;11891.702707432038;11952.043836492885;11995.460204291003;12149.331786751813;12207.816882746589;12116.394180291127;12236.204646697935;12278;12315.44580493862;12418.875811241773;8615.439996400213;8644.82710345777;8683;8767.386282960386;8771.517566533901;10436.425996569958;10597.841032384365;10670.19973502006;10686.625968091079;10694.304870183412;9043;9119.224865886474;9134.451932884049;9198.67804626835;9284.118008789153;8669.479831210148;8876;8917.019127895797;9042.367034307536;9088;7105.0408194893025;8022.478538894953;8149.429539932385;8157.75526734199;8251.463654862655;5994.940050599613;6045.516358691382;6150;6207.068939659087;6240.594361366497;6038.124471951454;6038.12447195163;6124.755009799558;6173.876522469615;6269.749210031548 15:18:19 INFO - PROCESS | 2624 | |4;prototype.html;395.6221808173195;398.84046381447433;401.7846015802199;403.8283729414999;404.6984996177848;4898.91795986706;5189.948100518994;5228.967199024566;5587.692676902769;5644.943550564503;4307.768924302789;5233.749487720279;5398.595105367093;5420.181505617077;5467.371252305986;3673.412254039354;3916.373380259159;4216.936745948813;4236.961944323645;4541.977290113545;4320.740755554661;4539.7957091930775;4566.520515345891;4578.862634120982;4621.653375996797;4093.713440059197;4261.936070958923;4339.7396156230725;4390.629060307446;4466.173757854791;3994.760314381132;4457.398251236074;4457.509673935864;4468.486124095705;4480.820767169309;3843.673287770543;4099.85650502234;4145.6683465323;4159.604837540429;4165.271077561445;4355.760433176174;4819.638527110481;4966.826161084345;5444.727763611803;5560.332760068818;4487.551244875519;4516.887077823048;4696.577308042292;5214.60890433219;5219.791208351661;5545.528630066449;5821.8356328734;5881.147233651097;5950.434708702666;6004.949133901549;3880.3791393376923;4225.9577404226175;4229.039672229421;4706.870351115742;4724.881877953045;5114.718690472023;5308.8141915033175;5756.395578464285;5889.558283128783;6205.5345849061505;4702.811887524529;4908.01839632075;4987.401511818605;5081.568066714371;5312.379724184161;4755.857324280277;4791.736454494967;5168.8966220675375;5399.379071406838;5427.96451330751;4860.586850117779;4934.407871055425;4950.034743225036;5425.972870135703;5480.7533660985355;5808.94191058084;5840.853978650568;5859.707014649336;5864.120381942743;5873.4126587340925;1571.6463795646116;1612.4840051183744;1838.4281439369413;1870.419495526278;1877.7558917340932;1320.6434262749003;1342.8321459817523;1451.2380999974887;1453.7092581483746;1494.6562290673205;4860.027994401134;5217;5314.73426328682;5479.698616576126;5638.915416268759;5100.897982040338;5225.712585807741;5841.41585841421;5875.265591801025;5909.852253693692;4633.606143477842;5446.455354464521;5532.585056120807;5650.576206784508;5700.978481404862;2792.6648802143873;2872.238856702975;3046.562749800151;3173.4922412413903;3187.4103290891258;5417.377001644862;5569.569669572134;5925.555583331267;6218.906716399258;6283.43449089575;6018.608790428696;6216.658083805434;6228.719707613168;6268.843278918063;6301.19596779438;5583.553315734732;5703.800366987136;5779.653220806765;5830.62100963436;6430.7460045291655;5264.289320941777;5954.821355359346;6034.517238620988;6043.45608895184;6063.575549711654;4871.634627402888;5800.071988481823;5855;5965.463108320272;5972.402759723993;5528.557715382679;5870.383609721089;6127.8468038297615;6309.621422714652;6375.218586060455;4162.896832339372;4499.302608095751;4699.271612900006;4784.258439941815;4799.952000480091;4773.427188737235;5532.90972305488;5799.652020878761;6121.571489995836;6124.14262003311;5130.56344223618;5507;5597.44025597437;5850;5894.351621321565;5095.082885080721;5112.437631860566;5375.650582712111;5833.562482813891;5890.705464726832;4413.49244836835;5674.715589729728;5721.256236689203;5730.850930900912;5780.566457515787;5168.224766285088;5539.390667026704;5753.1945527627;5909.025010873158;5933.584649074523;5146.6911985281;5507.697076660822;5548.889022219452;5692.800751973661;5796.579837939732 15:18:19 INFO - PROCESS | 2624 | |5;yui.html;705.2460143141035;727.2836256287555;765.5865832450477;804.5775967617001;903.4488961733343;16217.594560136002;17268.481945541622;17285.135743212835;17286.654266914655;17300.307987680495;13065.477380904753;14923.179225142612;15871.206439678028;15952.601184970381;15981.440649577267;849.2441726863066;988.3081842710096;1011.4993078426153;1016.1210552871787;1017.1811691588268;972.7033254857266;1005.7938122684868;1008.2790804574728;1012.7215015870621;1013.8124446977333;1058.1957712138792;1058.7829494953555;1059.0838924330476;1060.8886066962973;1060.9257351985325;1045.7176562328166;1049.5486940615533;1054.1882750282239;1054.2725519391595;1055.7941201465717;771.8610650082983;780.9336206422461;781.945263831532;782.6830133795822;783.4124406694979;16585.668286634198;16844.24200910962;17056.744148837777;18037.27850885963;18268.451946441626;14523.564293071226;14598.562043138723;14690.26548672562;14716.190609516472;14822.70354592913;11325.980661740401;11657.70855728605;11818.527258909633;11990;12052.939735301356;3423.246885685145;3524.2951409718157;3710.6474884885893;3851.6340947609933;3905.49228600283;96661.51669241679;115743.42128289389;120334;121576.39211803884;127357;9745.610175592898;10919.563217471372;11044.337339759479;11416.828747568794;11464.31214127155;21356.038978246015;23319.650205246933;23502;23775.524489510113;23797.762022379902;7446.590437525988;7704.345130663956;8004.479708818908;8099.06860711014;8181.140980197112;4191.979040104841;4557.886052848706;4619.006913513611;4637.582617564435;4645.837395691202;3571.571411430593;3628.9818550907603;3630.8910732678064;3674.154944362758;3677.191017976041;528.2050513976518;619.6313193649861;625.0436831647586;626.7712285015937;629.2763322179438;700.2752151523149;704.7413041202932;718.964051797408;726.1141407482862;747.7495039161832;10378.182973821176;10402.843957340647;10761.192910531741;10858.185636077325;11099.056580190774;697.2957313113792;710.573655806512;734;738.3982054625463;748.7005197920766;5055.241713742895;5261.447548007481;5269.1569348903995;5284.180951952453;5290.9735451322495;110347;111373.44313278382;111936;112917;114779.27831082541;80273.59863200763;93180.53409733044;94301.52849235847;97142;98050.52924206143;86045.569772152;86489;86808.5659571698;87412.5629371849;88761.55619221863;8822.911770882209;9846.803063938825;9909.405435673594;10041.74895627586;10165.237607179342;54237.45762542324;55031.17453238284;55140.44859551353;56593.71703141458;57658.423415765305;70887.64556177186;71107;72380.19049523804;72824.6358768224;73420;11693.88306116962;11754.88245117538;11919.940400297943;12078.577249796215;12226.816597750863;13396;13457.730845382841;13586.93206533961;13713.725725485236;14430;12316.692082697646;12391.442385092872;12714.809277860655;13087.476500939856;13303.201807891557;11709.765804683688;11758.82361764557;12056.51773929068;12070.456829442872;12552.937235313764;12035.75928481408;12224.914594422917;12237.20458170216;12438.19151755133;12586.307753073668;9369.741433655785;9383.90507868744;9524.95237523808;9686.07982241686;10001.099901008944;7305.525140865827;9432.858507122535;9687.079424516234;10731.624393146514;10832.945835270773 15:18:19 INFO - PROCESS | 2624 | __end_tp_report 15:18:19 INFO - PROCESS | 2624 | __start_cc_report 15:18:19 INFO - PROCESS | 2624 | _x_x_mozilla_cycle_collect,394 15:18:19 INFO - PROCESS | 2624 | __end_cc_report 15:18:19 INFO - PROCESS | 2624 | __startTimestamp1494022699785__endTimestamp 15:18:19 INFO - PROCESS | 2624 | 15:18:19 INFO - PROCESS | 2624 | ------- Summary: start ------- 15:18:19 INFO - PROCESS | 2624 | Number of tests: 6 15:18:19 INFO - PROCESS | 2624 | 15:18:19 INFO - PROCESS | 2624 | [#0] dojo.html Cycles:165 Average:6121.92 Median:6297.15 stddev:701.19 (11.1%) stddev-sans-first:674.49 15:18:19 INFO - PROCESS | 2624 | Values: 3583.9 3587.0 3606.1 3612.7 3669.3 4755.9 6144.0 6198.6 6206.9 6226.2 6164.8 6215.7 6235.5 6241.3 6246.8 5538.3 5560.1 5582.6 5640.9 5675.4 5694.1 5698.7 5701.9 5719.3 5744.7 5431.9 5453.0 5675.2 5678.3 5699.0 4464.5 5018.7 5146.5 5532.5 5559.6 5458.2 5557.9 5581.8 5596.0 5647.2 6201.8 6229.9 6247.0 6256.8 6301.8 6302.1 6359.3 6555.0 6580.3 6604.5 6484.3 6561.2 6575.2 6613.8 6669.4 6249.4 6250.7 6290.0 6292.9 6296.7 6821.8 6853.0 6891.0 6894.7 6907.4 6236.8 6293.0 6351.2 6411.8 6417.9 6656.9 6707.0 6720.0 6731.9 6734.7 6536.7 6553.5 6564.4 6590.3 6613.8 6297.1 6335.7 6453.0 6589.3 6644.9 5183.9 5210.2 5281.7 5303.5 5348.9 4617.9 4627.5 4664.1 4680.1 4694.1 6260.8 6273.4 6308.2 6310.4 6316.3 6397.6 6444.6 6536.6 6620.0 6734.6 6322.9 6326.1 6344.0 6348.6 6350.4 5950.8 5962.8 5966.6 5967.5 5972.9 6613.4 6708.9 6799.4 6916.7 6971.5 6692.5 6716.9 6736.8 6737.4 6744.9 6839.9 6902.4 6939.4 6986.2 6993.8 6280.0 6351.3 6584.3 6587.9 6629.1 6553.8 6574.7 6697.7 6709.8 6719.3 6483.0 6488.6 6503.9 6506.1 6510.2 6236.2 6426.8 6434.8 6483.5 6509.5 6131.5 6145.9 6194.3 6224.2 6268.2 5729.1 6158.8 6490.1 6491.2 6506.5 5540.9 6167.6 6177.6 6220.1 6292.8 15:18:19 INFO - PROCESS | 2624 | 15:18:19 INFO - PROCESS | 2624 | [#1] ext.html Cycles:180 Average:52530.62 Median:173443.45 stddev:102402.40 (59.0%) stddev-sans-first:102615.94 15:18:19 INFO - PROCESS | 2624 | Values: 774.9 819.7 841.1 979.3 982.5 37685.8 38468.4 38650.0 40422.0 40486.4 33194.0 39714.4 39777.6 39965.0 40082.6 8242.4 8376.4 8389.3 11076.4 11385.7 9761.9 11049.1 11207.2 11305.0 11316.8 11289.4 11302.4 11319.5 11345.3 11351.8 11269.3 11294.2 11299.0 11300.5 11308.5 10954.7 10962.8 11010.3 11034.3 11052.6 32866.8 34954.7 35073.8 35156.5 35191.0 3745.4 3923.9 3930.0 3941.3 4004.2 25980.6 26016.5 26058.9 27544.2 27578.2 3110.8 3270.6 3380.6 3394.7 3403.1 313773.0 315467.0 359696.2 366330.0 378100.1 37272.0 44821.8 45194.0 45237.8 45362.8 46245.8 46428.8 46551.0 46705.5 47625.8 13330.1 13355.8 13401.3 13409.1 13431.7 12538.2 12548.1 12568.4 12617.1 12640.1 12108.3 12134.6 12146.7 12171.7 12223.7 5683.7 5729.9 5730.8 5740.9 5747.9 909.1 1138.9 1162.3 1168.8 1214.7 23210.7 27171.0 27630.3 27957.9 28389.4 1293.7 1303.2 1308.7 1313.1 1319.8 12621.1 12703.9 14263.0 14551.2 14555.6 426505.0 428115.0 430534.0 430621.0 433135.0 56444.4 57012.7 57030.7 57038.7 57173.7 1477.2 1484.6 1516.6 1519.6 1526.2 24349.0 25630.5 26606.0 27157.7 27181.5 46397.8 46750.5 46782.1 46845.5 46958.0 377147.0 379070.0 380041.0 380379.0 383368.0 27816.3 28486.4 31419.9 32361.9 32513.7 44545.0 44559.8 45261.5 46102.8 46385.0 30095.7 30126.4 30521.9 31353.7 31700.0 29300.4 29426.7 31840.2 31897.5 32269.0 34940.7 35516.6 35556.8 35608.1 35798.0 25611.2 28879.9 29017.9 29528.9 30202.0 19987.5 23495.6 23984.3 24385.0 24387.5 15:18:19 INFO - PROCESS | 2624 | 15:18:19 INFO - PROCESS | 2624 | [#2] jquery.html Cycles:180 Average:43553.96 Median:2112.44 stddev:127151.31 (6019.2%) stddev-sans-first:127466.77 15:18:19 INFO - PROCESS | 2624 | Values: 430.4 439.6 442.1 448.6 451.7 16981.3 19875.5 20761.7 22065.0 22122.6 17819.7 23220.7 23887.8 23929.4 24131.8 6337.2 6738.4 7110.8 7128.2 7146.8 6836.9 6994.6 7046.3 7046.6 7046.9 6653.5 6933.6 6993.9 7038.6 7054.5 6935.7 6953.9 6985.0 6985.3 7003.0 6480.4 6840.6 6853.4 6872.6 6877.7 23734.6 27641.0 27660.9 27924.6 28109.0 2670.8 3077.6 3152.2 3152.4 3153.7 12131.8 17388.9 17424.1 17578.6 17651.0 2059.1 2105.5 2109.7 2110.3 2114.6 110580.0 141685.3 142962.0 144111.3 148803.3 21145.5 21678.3 21820.6 21829.9 21908.5 33889.3 34108.7 34567.0 34653.7 34875.8 10899.2 11167.1 11477.4 11541.5 11683.0 9301.6 9306.4 9320.8 9431.5 9472.2 9532.6 9786.2 10476.2 10668.3 10779.6 4167.3 4173.7 4309.4 4344.0 4509.9 1016.3 1094.1 1113.7 1150.8 1180.8 21957.7 23447.8 23617.6 24093.4 24270.9 1154.1 1166.3 1183.5 1208.5 1211.8 11769.3 12608.2 12634.7 12726.0 12928.8 739098.0 762108.0 766798.2 778896.0 785721.0 133460.0 134946.7 137091.6 146149.3 148201.0 1244.6 1342.1 1420.9 1454.6 1463.8 19279.6 20460.6 20625.7 20643.9 20686.5 59994.7 60249.7 66124.7 66747.0 68254.0 98858.0 99443.0 99864.0 101988.0 102245.0 11808.5 11850.5 11868.7 11931.9 12130.8 6509.5 11725.7 13335.7 13415.3 13911.6 11555.7 11607.8 11903.6 11930.0 12063.8 10817.4 10906.0 10910.9 11139.7 11155.9 11793.5 11866.9 11986.8 12000.8 12112.8 10443.4 11695.2 11762.2 11945.8 12115.6 8882.3 11403.1 11525.4 11636.2 11850.8 15:18:19 INFO - PROCESS | 2624 | 15:18:19 INFO - PROCESS | 2624 | [#3] mootools.html Cycles:180 Average:6887.11 Median:2495.79 stddev:4262.58 (170.8%) stddev-sans-first:4255.17 15:18:19 INFO - PROCESS | 2624 | Values: 1480.5 1567.5 1625.7 1633.8 1641.1 11111.7 11386.5 11708.5 11747.6 11890.8 11548.2 11775.8 11788.6 11808.8 11840.4 2286.2 2458.2 2463.8 2509.0 2515.2 2464.9 2483.3 2520.7 2521.8 2524.1 2456.9 2473.4 2480.4 2483.5 2497.2 2432.8 2449.1 2463.1 2467.0 2494.4 2083.8 2452.4 2463.5 2474.3 2480.9 11181.8 11498.8 11505.7 11511.0 11527.2 5912.5 6074.8 6128.5 6147.4 6156.5 3498.8 3639.7 3656.7 3732.5 3784.4 1063.6 1216.8 1220.8 1247.8 1281.5 14308.9 14640.9 15221.9 15779.6 16037.2 4231.2 4821.0 4902.9 5009.8 5021.0 12268.1 12292.1 12348.8 12350.0 12382.9 5502.3 5849.7 6115.2 6134.1 6138.7 5354.3 5456.8 5577.9 5602.3 5672.1 4045.4 4111.5 4113.8 4146.6 4166.1 1081.6 1090.1 1095.3 1099.8 1110.7 864.9 959.3 977.8 978.6 992.7 6803.8 6833.5 6867.8 6993.1 7008.0 971.4 986.7 1004.4 1016.3 1016.6 3693.4 4078.7 4371.9 4427.9 4475.1 13541.3 13946.4 14123.5 14146.3 14177.7 12153.0 13474.1 13787.3 13927.9 13930.9 8988.8 10322.4 10418.3 10475.4 10489.9 6053.0 6544.5 7067.4 7147.6 7148.2 11891.7 11952.0 11995.5 12149.3 12207.8 12116.4 12236.2 12278.0 12315.4 12418.9 8615.4 8644.8 8683.0 8767.4 8771.5 10436.4 10597.8 10670.2 10686.6 10694.3 9043.0 9119.2 9134.5 9198.7 9284.1 8669.5 8876.0 8917.0 9042.4 9088.0 7105.0 8022.5 8149.4 8157.8 8251.5 5994.9 6045.5 6150.0 6207.1 6240.6 6038.1 6038.1 6124.8 6173.9 6269.7 15:18:19 INFO - PROCESS | 2624 | 15:18:19 INFO - PROCESS | 2624 | [#4] prototype.html Cycles:180 Average:4863.52 Median:5231.36 stddev:1338.35 (25.6%) stddev-sans-first:1299.41 15:18:19 INFO - PROCESS | 2624 | Values: 395.6 398.8 401.8 403.8 404.7 4898.9 5189.9 5229.0 5587.7 5644.9 4307.8 5233.7 5398.6 5420.2 5467.4 3673.4 3916.4 4216.9 4237.0 4542.0 4320.7 4539.8 4566.5 4578.9 4621.7 4093.7 4261.9 4339.7 4390.6 4466.2 3994.8 4457.4 4457.5 4468.5 4480.8 3843.7 4099.9 4145.7 4159.6 4165.3 4355.8 4819.6 4966.8 5444.7 5560.3 4487.6 4516.9 4696.6 5214.6 5219.8 5545.5 5821.8 5881.1 5950.4 6004.9 3880.4 4226.0 4229.0 4706.9 4724.9 5114.7 5308.8 5756.4 5889.6 6205.5 4702.8 4908.0 4987.4 5081.6 5312.4 4755.9 4791.7 5168.9 5399.4 5428.0 4860.6 4934.4 4950.0 5426.0 5480.8 5808.9 5840.9 5859.7 5864.1 5873.4 1571.6 1612.5 1838.4 1870.4 1877.8 1320.6 1342.8 1451.2 1453.7 1494.7 4860.0 5217.0 5314.7 5479.7 5638.9 5100.9 5225.7 5841.4 5875.3 5909.9 4633.6 5446.5 5532.6 5650.6 5701.0 2792.7 2872.2 3046.6 3173.5 3187.4 5417.4 5569.6 5925.6 6218.9 6283.4 6018.6 6216.7 6228.7 6268.8 6301.2 5583.6 5703.8 5779.7 5830.6 6430.7 5264.3 5954.8 6034.5 6043.5 6063.6 4871.6 5800.1 5855.0 5965.5 5972.4 5528.6 5870.4 6127.8 6309.6 6375.2 4162.9 4499.3 4699.3 4784.3 4800.0 4773.4 5532.9 5799.7 6121.6 6124.1 5130.6 5507.0 5597.4 5850.0 5894.4 5095.1 5112.4 5375.7 5833.6 5890.7 4413.5 5674.7 5721.3 5730.9 5780.6 5168.2 5539.4 5753.2 5909.0 5933.6 5146.7 5507.7 5548.9 5692.8 5796.6 15:18:19 INFO - PROCESS | 2624 | 15:18:19 INFO - PROCESS | 2624 | [#5] yui.html Cycles:180 Average:21703.34 Median:22337.84 stddev:32135.56 (143.9%) stddev-sans-first:32187.03 15:18:19 INFO - PROCESS | 2624 | Values: 705.2 727.3 765.6 804.6 903.4 16217.6 17268.5 17285.1 17286.7 17300.3 13065.5 14923.2 15871.2 15952.6 15981.4 849.2 988.3 1011.5 1016.1 1017.2 972.7 1005.8 1008.3 1012.7 1013.8 1058.2 1058.8 1059.1 1060.9 1060.9 1045.7 1049.5 1054.2 1054.3 1055.8 771.9 780.9 781.9 782.7 783.4 16585.7 16844.2 17056.7 18037.3 18268.5 14523.6 14598.6 14690.3 14716.2 14822.7 11326.0 11657.7 11818.5 11990.0 12052.9 3423.2 3524.3 3710.6 3851.6 3905.5 96661.5 115743.4 120334.0 121576.4 127357.0 9745.6 10919.6 11044.3 11416.8 11464.3 21356.0 23319.7 23502.0 23775.5 23797.8 7446.6 7704.3 8004.5 8099.1 8181.1 4192.0 4557.9 4619.0 4637.6 4645.8 3571.6 3629.0 3630.9 3674.2 3677.2 528.2 619.6 625.0 626.8 629.3 700.3 704.7 719.0 726.1 747.7 10378.2 10402.8 10761.2 10858.2 11099.1 697.3 710.6 734.0 738.4 748.7 5055.2 5261.4 5269.2 5284.2 5291.0 110347.0 111373.4 111936.0 112917.0 114779.3 80273.6 93180.5 94301.5 97142.0 98050.5 86045.6 86489.0 86808.6 87412.6 88761.6 8822.9 9846.8 9909.4 10041.7 10165.2 54237.5 55031.2 55140.4 56593.7 57658.4 70887.6 71107.0 72380.2 72824.6 73420.0 11693.9 11754.9 11919.9 12078.6 12226.8 13396.0 13457.7 13586.9 13713.7 14430.0 12316.7 12391.4 12714.8 13087.5 13303.2 11709.8 11758.8 12056.5 12070.5 12552.9 12035.8 12224.9 12237.2 12438.2 12586.3 9369.7 9383.9 9525.0 9686.1 10001.1 7305.5 9432.9 9687.1 10731.6 10832.9 15:18:19 INFO - PROCESS | 2624 | -------- Summary: end -------- 15:18:19 INFO - PROCESS | 2624 | 15:18:20 INFO - TEST-INFO | 2624: exit 0 15:18:20 INFO - TEST-OK | dromaeo_css | took 1115793ms 15:18:20 INFO - TEST-START | kraken 15:18:20 INFO - operating with platform_type : mac_ 15:18:20 INFO - Initialising browser for kraken test... 15:18:20 INFO - TEST-INFO | started process 2628 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/tmpLvNDpa/profile http://localhost:55361/getInfo.html) 15:18:23 INFO - PROCESS | 2628 | 2017-05-05 15:18:23.055 plugin-container[2630:82201] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x833f, name = 'com.apple.tsm.portname' 15:18:23 INFO - PROCESS | 2628 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:18:23 INFO - PROCESS | 2628 | 2017-05-05 15:18:23.056 plugin-container[2630:82201] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x890b, name = 'com.apple.CFPasteboardClient' 15:18:23 INFO - PROCESS | 2628 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:18:23 INFO - PROCESS | 2628 | 2017-05-05 15:18:23.056 plugin-container[2630:82201] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:18:23 INFO - PROCESS | 2628 | __metrics Screen width/height:1600/1200 15:18:23 INFO - PROCESS | 2628 | colorDepth:24 15:18:23 INFO - PROCESS | 2628 | Browser inner width/height: 1024/689 15:18:23 INFO - PROCESS | 2628 | __metrics 15:18:23 ERROR - PROCESS | 2628 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 15:18:24 INFO - TEST-INFO | 2628: exit 0 15:18:24 INFO - Browser initialized. 15:18:24 INFO - Running cycle 1/1 for kraken test... 15:18:24 INFO - TEST-INFO | started process 2631 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/T/tmpLvNDpa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:18:26 INFO - PROCESS | 2631 | 2017-05-05 15:18:26.553 plugin-container[2632:82326] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4443, name = 'com.apple.tsm.portname' 15:18:26 INFO - PROCESS | 2631 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:18:26 INFO - PROCESS | 2631 | 2017-05-05 15:18:26.553 plugin-container[2632:82326] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 15:18:26 INFO - PROCESS | 2631 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:18:26 INFO - PROCESS | 2631 | 2017-05-05 15:18:26.553 plugin-container[2632:82326] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:18:36 INFO - PROCESS | 2631 | RSS: Main: 174288896 15:18:36 INFO - PROCESS | 2631 | 15:18:39 INFO - PROCESS | 2631 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55361/tests/kraken/driver.html?testName=audio-beat-detection) 15:18:40 INFO - PROCESS | 2631 | RSS: Main: 187760640 15:18:40 INFO - PROCESS | 2631 | 15:18:42 INFO - PROCESS | 2631 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55361/tests/kraken/driver.html?testName=audio-dft) 15:18:43 INFO - PROCESS | 2631 | RSS: Main: 195706880 15:18:43 INFO - PROCESS | 2631 | 15:18:46 INFO - PROCESS | 2631 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55361/tests/kraken/driver.html?testName=audio-fft) 15:18:47 INFO - PROCESS | 2631 | RSS: Main: 199438336 15:18:47 INFO - PROCESS | 2631 | 15:18:49 INFO - PROCESS | 2631 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55361/tests/kraken/driver.html?testName=audio-oscillator) 15:18:50 INFO - PROCESS | 2631 | RSS: Main: 200806400 15:18:50 INFO - PROCESS | 2631 | 15:18:52 INFO - PROCESS | 2631 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55361/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:18:52 INFO - PROCESS | 2631 | RSS: Main: 201150464 15:18:52 INFO - PROCESS | 2631 | 15:18:55 INFO - PROCESS | 2631 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55361/tests/kraken/driver.html?testName=imaging-darkroom) 15:18:56 INFO - PROCESS | 2631 | RSS: Main: 204894208 15:18:56 INFO - PROCESS | 2631 | 15:18:59 INFO - PROCESS | 2631 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55361/tests/kraken/driver.html?testName=imaging-desaturate) 15:18:59 INFO - PROCESS | 2631 | RSS: Main: 204529664 15:18:59 INFO - PROCESS | 2631 | 15:19:02 INFO - PROCESS | 2631 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55361/tests/kraken/driver.html?testName=json-parse-financial) 15:19:03 INFO - PROCESS | 2631 | RSS: Main: 204685312 15:19:03 INFO - PROCESS | 2631 | 15:19:05 INFO - PROCESS | 2631 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55361/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:19:05 INFO - PROCESS | 2631 | RSS: Main: 204349440 15:19:05 INFO - PROCESS | 2631 | 15:19:07 INFO - PROCESS | 2631 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55361/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:19:08 INFO - PROCESS | 2631 | RSS: Main: 204406784 15:19:08 INFO - PROCESS | 2631 | 15:19:10 INFO - PROCESS | 2631 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55361/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:19:11 INFO - PROCESS | 2631 | RSS: Main: 204419072 15:19:11 INFO - PROCESS | 2631 | 15:19:14 INFO - PROCESS | 2631 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55361/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:19:15 INFO - PROCESS | 2631 | RSS: Main: 204795904 15:19:15 INFO - PROCESS | 2631 | 15:19:17 INFO - PROCESS | 2631 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55361/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:19:18 INFO - PROCESS | 2631 | RSS: Main: 204857344 15:19:18 INFO - PROCESS | 2631 | 15:19:20 INFO - PROCESS | 2631 | Cycle 1(1): loaded http://localhost:55361/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55361/tests/kraken/driver.html?testName=ai-astar) 15:19:20 INFO - PROCESS | 2631 | RSS: Main: 206524416 15:19:20 INFO - PROCESS | 2631 | 15:19:20 INFO - PROCESS | 2631 | __start_tp_report 15:19:20 INFO - PROCESS | 2631 | _x_x_mozilla_page_load 15:19:20 INFO - PROCESS | 2631 | _x_x_mozilla_page_load_details 15:19:20 INFO - PROCESS | 2631 | |i|pagename|runs| 15:19:20 INFO - PROCESS | 2631 | |0;ai-astar;109;119;120;120;119;120;122;119;121;149 15:19:20 INFO - PROCESS | 2631 | |1;audio-beat-detection;136;111;110;143;141;140;139;101;161;104 15:19:20 INFO - PROCESS | 2631 | |2;audio-dft;201;198;202;204;200;242;251;199;199;199 15:19:20 INFO - PROCESS | 2631 | |3;audio-fft;101;81;83;105;61;60;74;84;99;69 15:19:20 INFO - PROCESS | 2631 | |4;audio-oscillator;92;69;86;84;100;75;81;70;69;82 15:19:20 INFO - PROCESS | 2631 | |5;imaging-gaussian-blur;90;90;90;90;90;90;90;90;93;89 15:19:20 INFO - PROCESS | 2631 | |6;imaging-darkroom;96;97;95;96;96;97;97;96;96;96 15:19:20 INFO - PROCESS | 2631 | |7;imaging-desaturate;92;101;93;91;92;90;91;112;100;98 15:19:20 INFO - PROCESS | 2631 | |8;json-parse-financial;65;66;66;67;67;67;67;69;68;68 15:19:20 INFO - PROCESS | 2631 | |9;json-stringify-tinderbox;58;50;83;96;90;84;60;61;63;60 15:19:20 INFO - PROCESS | 2631 | |10;stanford-crypto-aes;82;84;87;102;100;72;100;105;104;81 15:19:20 INFO - PROCESS | 2631 | |11;stanford-crypto-ccm;136;135;135;135;145;147;181;142;192;177 15:19:20 INFO - PROCESS | 2631 | |12;stanford-crypto-pbkdf2;176;164;168;178;219;178;166;168;186;165 15:19:20 INFO - PROCESS | 2631 | |13;stanford-crypto-sha256-iterative;63;67;66;65;66;65;64;64;65;63 15:19:20 INFO - PROCESS | 2631 | __end_tp_report 15:19:20 INFO - PROCESS | 2631 | __start_cc_report 15:19:20 INFO - PROCESS | 2631 | _x_x_mozilla_cycle_collect,997 15:19:20 INFO - PROCESS | 2631 | __end_cc_report 15:19:20 INFO - PROCESS | 2631 | __startTimestamp1494022760475__endTimestamp 15:19:20 INFO - PROCESS | 2631 | 15:19:20 INFO - PROCESS | 2631 | ------- Summary: start ------- 15:19:20 INFO - PROCESS | 2631 | Number of tests: 14 15:19:20 INFO - PROCESS | 2631 | 15:19:20 INFO - PROCESS | 2631 | [#0] ai-astar Cycles:10 Average:121.80 Median:120.00 stddev:10.21 (8.5%) stddev-sans-first:9.72 15:19:20 INFO - PROCESS | 2631 | Values: 109.0 119.0 120.0 120.0 119.0 120.0 122.0 119.0 121.0 149.0 15:19:20 INFO - PROCESS | 2631 | 15:19:20 INFO - PROCESS | 2631 | [#1] audio-beat-detection Cycles:10 Average:128.60 Median:139.50 stddev:20.35 (14.6%) stddev-sans-first:21.41 15:19:20 INFO - PROCESS | 2631 | Values: 136.0 111.0 110.0 143.0 141.0 140.0 139.0 101.0 161.0 104.0 15:19:20 INFO - PROCESS | 2631 | 15:19:20 INFO - PROCESS | 2631 | [#2] audio-dft Cycles:10 Average:209.50 Median:201.50 stddev:19.69 (9.8%) stddev-sans-first:20.65 15:19:20 INFO - PROCESS | 2631 | Values: 201.0 198.0 202.0 204.0 200.0 242.0 251.0 199.0 199.0 199.0 15:19:20 INFO - PROCESS | 2631 | 15:19:20 INFO - PROCESS | 2631 | [#3] audio-fft Cycles:10 Average:81.70 Median:77.50 stddev:16.13 (20.8%) stddev-sans-first:15.53 15:19:20 INFO - PROCESS | 2631 | Values: 101.0 81.0 83.0 105.0 61.0 60.0 74.0 84.0 99.0 69.0 15:19:20 INFO - PROCESS | 2631 | 15:19:20 INFO - PROCESS | 2631 | [#4] audio-oscillator Cycles:10 Average:80.80 Median:81.50 stddev:10.34 (12.7%) stddev-sans-first:10.14 15:19:20 INFO - PROCESS | 2631 | Values: 92.0 69.0 86.0 84.0 100.0 75.0 81.0 70.0 69.0 82.0 15:19:20 INFO - PROCESS | 2631 | 15:19:20 INFO - PROCESS | 2631 | [#5] imaging-gaussian-blur Cycles:10 Average:90.20 Median:90.00 stddev:1.03 (1.1%) stddev-sans-first:1.09 15:19:20 INFO - PROCESS | 2631 | Values: 90.0 90.0 90.0 90.0 90.0 90.0 90.0 90.0 93.0 89.0 15:19:20 INFO - PROCESS | 2631 | 15:19:20 INFO - PROCESS | 2631 | [#6] imaging-darkroom Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 15:19:20 INFO - PROCESS | 2631 | Values: 96.0 97.0 95.0 96.0 96.0 97.0 97.0 96.0 96.0 96.0 15:19:20 INFO - PROCESS | 2631 | 15:19:20 INFO - PROCESS | 2631 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:91.50 stddev:6.90 (7.5%) stddev-sans-first:7.16 15:19:20 INFO - PROCESS | 2631 | Values: 92.0 101.0 93.0 91.0 92.0 90.0 91.0 112.0 100.0 98.0 15:19:20 INFO - PROCESS | 2631 | 15:19:20 INFO - PROCESS | 2631 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:67.00 stddev:1.15 (1.7%) stddev-sans-first:0.97 15:19:20 INFO - PROCESS | 2631 | Values: 65.0 66.0 66.0 67.0 67.0 67.0 67.0 69.0 68.0 68.0 15:19:20 INFO - PROCESS | 2631 | 15:19:20 INFO - PROCESS | 2631 | [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:73.00 stddev:16.03 (22.0%) stddev-sans-first:16.35 15:19:20 INFO - PROCESS | 2631 | Values: 58.0 50.0 83.0 96.0 90.0 84.0 60.0 61.0 63.0 60.0 15:19:20 INFO - PROCESS | 2631 | 15:19:20 INFO - PROCESS | 2631 | [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:76.50 stddev:11.79 (15.4%) stddev-sans-first:11.97 15:19:20 INFO - PROCESS | 2631 | Values: 82.0 84.0 87.0 102.0 100.0 72.0 100.0 105.0 104.0 81.0 15:19:20 INFO - PROCESS | 2631 | 15:19:20 INFO - PROCESS | 2631 | [#11] stanford-crypto-ccm Cycles:10 Average:152.50 Median:146.00 stddev:22.01 (15.1%) stddev-sans-first:22.52 15:19:20 INFO - PROCESS | 2631 | Values: 136.0 135.0 135.0 135.0 145.0 147.0 181.0 142.0 192.0 177.0 15:19:20 INFO - PROCESS | 2631 | 15:19:20 INFO - PROCESS | 2631 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.80 Median:177.00 stddev:16.48 (9.3%) stddev-sans-first:17.47 15:19:20 INFO - PROCESS | 2631 | Values: 176.0 164.0 168.0 178.0 219.0 178.0 166.0 168.0 186.0 165.0 15:19:20 INFO - PROCESS | 2631 | 15:19:20 INFO - PROCESS | 2631 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:1.32 (2.0%) stddev-sans-first:1.22 15:19:20 INFO - PROCESS | 2631 | Values: 63.0 67.0 66.0 65.0 66.0 65.0 64.0 64.0 65.0 63.0 15:19:20 INFO - PROCESS | 2631 | -------- Summary: end -------- 15:19:20 INFO - PROCESS | 2631 | 15:19:21 INFO - TEST-INFO | 2631: exit 0 15:19:21 INFO - TEST-OK | kraken | took 60962ms 15:19:21 INFO - SUITE-END | took 1176s 15:19:21 INFO - Completed test suite (00:19:37) 15:19:21 INFO - javascript benchmark 15:19:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7951.288354240183, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3583.8924832255034, 3587.013571267901, 3606.0624237698225, 3612.674859262667, 3669.266146770645, 4755.9286610700865, 6144.0, 6198.628082315058, 6206.937930620692, 6226.190595222614, 6164.815055548341, 6215.720292586833, 6235.469985051276, 6241.282252540959, 6246.812595622138, 5538.252335934648, 5560.138178582306, 5582.581306402036, 5640.858978525549, 5675.404082571333, 5694.117411801157, 5698.715064246771, 5701.914471282934, 5719.28508936383, 5744.6840423776885, 5431.891362172754, 5453.045716999529, 5675.233843431146, 5678.318601767794, 5698.971505142468, 4464.46426428829, 5018.749062546858, 5146.5110814472755, 5532.502074813246, 5559.582306511814, 5458.235846981426, 5557.861053473655, 5581.832545023656, 5596.0, 5647.209390685307, 6201.751929922798, 6229.906551401733, 6246.968765156191, 6256.843578910518, 6301.810945671591, 6302.086197501337, 6359.300476947578, 6555.04951781989, 6580.276169621337, 6604.471642268607, 6484.319146489598, 6561.179852518435, 6575.243846957565, 6613.801585952429, 6669.399754022162, 6249.375062493714, 6250.656213908279, 6289.9999999999545, 6292.937070629281, 6296.748130074838, 6821.829454263584, 6853.0, 6890.965545172242, 6894.724211031503, 6907.412869906014, 6236.750529978841, 6293.0, 6351.237851457762, 6411.775587854496, 6417.871642567123, 6656.900146497806, 6707.027481015225, 6719.966400167968, 6731.932680673229, 6734.6632668367365, 6536.705848236841, 6553.508486863504, 6564.376384243489, 6590.340965903371, 6613.801585952429, 6297.149884765498, 6335.714892829834, 6452.9677351612945, 6589.341065893373, 6644.8671026579195, 5183.922241166386, 5210.244514545369, 5281.709505977131, 5303.4696530346655, 5348.946510534923, 4617.930731039037, 4627.490975992638, 4664.090502352076, 4680.08738296029, 4694.131585656664, 6260.843478913063, 6273.37266273369, 6308.243010838637, 6310.400511951358, 6316.30520642729, 6397.584157029778, 6444.613323200623, 6536.607803531803, 6620.0069989501, 6734.595924244561, 6322.873542529123, 6326.051092336094, 6343.9682801585695, 6348.619082855043, 6350.396712312323, 5950.821475355746, 5962.821115366546, 5966.552508561876, 5967.492763115184, 5972.910406343908, 6613.371729685672, 6708.899366509604, 6799.422049125682, 6916.6541672916155, 6971.5468494547695, 6692.464602831665, 6716.932830671631, 6736.831579210363, 6737.393634572912, 6744.932550674431, 6839.93160068393, 6902.447804175755, 6939.444844412334, 6986.16166060076, 6993.790186294419, 6279.995200767855, 6351.333110023381, 6584.259457948884, 6587.901181482377, 6629.105070815378, 6553.836154096186, 6574.704138313692, 6697.665116744241, 6709.7651582194385, 6719.328067193242, 6482.995135753966, 6488.578242414228, 6503.902441463477, 6506.121673574196, 6510.153680021567, 6236.18929539157, 6426.775062872777, 6434.806955791334, 6483.481321494175, 6509.511786615928, 6131.5295901671125, 6145.907811382922, 6194.256689197145, 6224.1597384352535, 6268.1851359323, 5729.140628905698, 6158.753649854135, 6490.058941453557, 6491.156149700509, 6506.479481641362, 5540.889182216414, 6167.629942203482, 6177.598456100339, 6220.129181914626, 6292.8426789328805], "value": 6076.868798097245, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [774.8527779721852, 819.6721311475409, 841.0664162779314, 979.2753362511744, 982.5480279071627, 37685.81157094214, 38468.42297365542, 38650.0, 40421.98945026376, 40486.392704109465, 33194.00417987464, 39714.40428393569, 39777.60222397775, 39965.00087497814, 40082.59917400825, 8242.381821363377, 8376.41365104443, 8389.32885369169, 11076.446177691083, 11385.658430247064, 9761.902380976171, 11049.060829829474, 11207.159463040263, 11305.039071678875, 11316.830247546293, 11289.435528223597, 11302.434878256096, 11319.547218111265, 11345.26255793375, 11351.772964540703, 11269.323840569552, 11294.20940534163, 11299.03958163553, 11300.547978080867, 11308.491117899714, 10954.671359859218, 10962.835557466644, 11010.284331518425, 11034.337939723562, 11052.557897684082, 32866.83566582152, 34954.65045349539, 35073.82463087694, 35156.47265290997, 35191.0, 3745.3632882410056, 3923.862664806718, 3929.9978505480917, 3941.2511622791576, 4004.199160167978, 25980.610290845652, 26016.479670406487, 26058.869705651352, 27544.17367478979, 27578.172654820388, 3110.766692498049, 3270.640229574745, 3380.6281309055985, 3394.6775056369606, 3403.0981789825714, 313773.0, 315467.0, 359696.20151899336, 366330.0, 378100.1094994535, 37272.0, 44821.775891120335, 45194.0, 45237.77381113073, 45362.77318613386, 46245.76877115593, 46428.83927901829, 46551.0, 46705.53294467012, 47625.76187119042, 13330.133541319783, 13355.799663005062, 13401.262930538915, 13409.061365704501, 13431.731365372638, 12538.247705137539, 12548.121631485708, 12568.434420451102, 12617.116801823968, 12640.05199610033, 12108.273503589637, 12134.575289864812, 12146.696332591579, 12171.695707607381, 12223.69440763988, 5683.687397193194, 5729.914051289151, 5730.799422020293, 5740.942590574125, 5747.885042299131, 909.1317791509093, 1138.8747237803834, 1162.2968104296779, 1168.7837750016104, 1214.6963259185204, 23210.65184022241, 27171.0, 27630.3092422687, 27957.860210698815, 28389.43221135607, 1293.7283170534106, 1303.1529505821293, 1308.6924572725402, 1313.1267706974945, 1319.769040417923, 12621.053420993463, 12703.872961270454, 14263.0, 14551.199684017269, 14555.563333100024, 426505.0, 428115.0, 430534.0, 430621.0, 433135.0, 56444.43555564474, 57012.71493642505, 57030.71484642633, 57038.714806425705, 57173.71413142991, 1477.1875468492287, 1484.6140003599141, 1516.6435887566413, 1519.620094976256, 1526.1682383101236, 24349.0, 25630.487390252463, 26606.0, 27157.72842271552, 27181.456370872867, 46397.76801115973, 46750.53249467598, 46782.064358713316, 46845.53154468548, 46958.0, 377147.0, 379070.0, 380041.0, 380379.0, 383368.0, 27816.304592385353, 28486.43027139404, 31419.900303490183, 32361.867334643175, 32513.674863251064, 44545.0, 44559.777201113786, 45261.54738452705, 46102.847428814544, 46385.0, 30095.69904300929, 30126.397472050874, 30521.93173238926, 31353.68646313599, 31700.04899853008, 29300.413991720474, 29426.705732942395, 31840.203994900312, 31897.521537177425, 32269.031929042165, 34940.65059349374, 35516.644833551334, 35556.82221588979, 35608.10979725424, 35798.0, 25611.231663050137, 28879.85560072186, 29017.854910725313, 29528.852355738083, 30202.0, 19987.500312491724, 23495.647565286192, 23984.28047158588, 24385.0, 24387.512249755262], "value": 18648.766904744105, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.393145664613, 439.59996403273016, 442.0738552732025, 448.5671327169281, 451.6951058035825, 16981.320747170128, 19875.50311242218, 20761.688574671392, 22065.00707468164, 22122.557548849014, 17819.663525235595, 23220.65169022466, 23887.761122388816, 23929.40176495584, 24131.7934103295, 6337.1761670982705, 6738.35985581369, 7110.751123710671, 7128.215896251434, 7146.78559643209, 6836.897446538306, 6994.6152961587095, 7046.295370462938, 7046.577205367695, 7046.85906281874, 6653.4677225821815, 6933.583984960893, 6993.930060699404, 7038.6128762918015, 7054.541454805447, 6935.72257109715, 6953.930460695379, 6985.0, 6985.336393042653, 7002.964985175067, 6480.351964803482, 6840.555363901331, 6853.383195512428, 6872.553284036521, 6877.690503927335, 23734.64398034031, 27641.032563860368, 27660.861695691394, 27924.58113128305, 28109.0, 2670.7996900232365, 3077.584526088972, 3152.2277042124824, 3152.4325621388143, 3153.7003984621424, 12131.757364852741, 17388.91305543477, 17424.12879356027, 17578.648427031516, 17651.0, 2059.073416962373, 2105.473631592102, 2109.6519074352714, 2110.2825039486493, 2114.587655407196, 110580.0, 141685.29157354147, 142962.0, 144111.27944360315, 148803.25598372048, 21145.471363216042, 21678.34964951054, 21820.563588728455, 21829.890850545646, 21908.45228869291, 33889.32221355559, 34108.65891341105, 34567.0, 34653.65346346555, 34875.825620871736, 10899.182561307774, 11167.05080068187, 11477.426128693533, 11541.480633371519, 11683.0, 9301.581428835718, 9306.395084319498, 9320.813583728423, 9431.528423578793, 9472.242220622335, 9532.568275420843, 9786.217102631772, 10476.161907047417, 10668.30656007357, 10779.598652175167, 4167.333226683716, 4173.7478756373575, 4309.405519957636, 4344.000879797664, 4509.88725281864, 1016.3190662256306, 1094.0700404656138, 1113.7080986056135, 1150.7986102432208, 1180.7756526260155, 21957.67063494049, 23447.827608619842, 23617.645735313985, 24093.397665058514, 24270.878645607012, 1154.105568184647, 1166.3002198680724, 1183.4970137691446, 1208.474313673555, 1211.8121691137887, 11769.293842369485, 12608.243505389706, 12634.747305053848, 12726.045546584044, 12928.806067908989, 739098.0, 762108.0, 766798.1660091664, 778896.0, 785721.0, 133460.0, 134946.6505334934, 137091.6290837079, 146149.26925365304, 148201.0, 1244.589285535789, 1342.134323361446, 1420.850810664886, 1454.6363409147714, 1463.7950686903841, 19279.554033447268, 20460.59078818445, 20625.69061464109, 20643.864587447835, 20686.482837929172, 59994.70002649959, 60249.69875150596, 66124.67750645056, 66746.99879501908, 68254.0, 98858.0, 99443.0, 99864.0, 101988.0, 102245.0, 11808.527658893549, 11850.525978960744, 11868.703282418008, 11931.940340298243, 12130.7869213078, 6509.479241660751, 11725.706857328634, 13335.66660833487, 13415.32923353848, 13911.582652520441, 11555.711107222387, 11607.76784464289, 11903.583374581847, 11930.0, 12063.75872482563, 10817.350958942488, 10906.018458338787, 10910.945445272722, 11139.673526618557, 11155.888441115485, 11793.52825886955, 11866.881331186578, 11986.76026479483, 12000.819987700017, 12112.75774484523, 10443.425611591436, 11695.181337306307, 11762.235454695418, 11945.820812687643, 12115.636530904087, 8882.333824963025, 11403.144764142888, 11525.366104864313, 11636.243644163102, 11850.822237666614], "value": 12091.672617385813, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1480.4892312152308, 1567.5454118305693, 1625.6667383186448, 1633.8121116071652, 1641.0973964319621, 11111.666650000503, 11386.544538218483, 11708.531658733651, 11747.647570572886, 11890.821637675443, 11548.249363791349, 11775.823362649568, 11788.587399441021, 11808.822867656992, 11840.407979601028, 2286.1998300594823, 2458.151937581536, 2463.8398504097268, 2509.04656230633, 2515.195137555983, 2464.9260522184363, 2483.255023492954, 2520.6723125993685, 2521.848689078652, 2524.091327122244, 2456.8771561421945, 2473.3940184654693, 2480.367506285904, 2483.4784695213934, 2497.1884137655243, 2432.8175386846056, 2449.0571130115036, 2463.0763463701114, 2467.0, 2494.3888747256856, 2083.760367557735, 2452.3746444656676, 2463.507298540281, 2474.2948259745885, 2480.875956202183, 11181.776364472666, 11498.827517587159, 11505.712357191054, 11510.964013238849, 11527.19309648325, 5912.467877890967, 6074.848128796772, 6128.540359473012, 6147.385261473817, 6156.507479401637, 3498.755087143901, 3639.7452178347526, 3656.744027918047, 3732.458793474931, 3784.413415920537, 1063.5639387851022, 1216.7627312674033, 1220.7924652809045, 1247.8253044573767, 1281.507044293397, 14308.856911430961, 14640.853591464056, 15221.923890380587, 15779.605509862231, 16037.198140092949, 4231.2383770920915, 4821.011692603008, 4902.940764878759, 5009.77456014473, 5021.0, 12268.141230113984, 12292.139550231577, 12348.814767778491, 12350.011999040054, 12382.947449466896, 5502.339719233638, 5849.683821140295, 6115.1744514490865, 6134.110553969649, 6138.693065346804, 5354.277172581729, 5456.7544460499375, 5577.944220557823, 5602.327720673464, 5672.092465205547, 4045.3700836171665, 4111.5477297497255, 4113.753174809521, 4146.564610715892, 4166.104287578125, 1081.5944020992129, 1090.0516550601028, 1095.2552264460085, 1099.8405231241425, 1110.6667999600088, 864.8962124544969, 959.2517836087862, 977.8484334928097, 978.5889926231, 992.717075633441, 6803.795886123424, 6833.5216534843075, 6867.759628412981, 6993.076903851482, 7007.964960175166, 971.3977334052933, 986.659602437158, 1004.4475538453821, 1016.2835201183149, 1016.6492560066765, 3693.4275187346007, 4078.7173467859225, 4371.912561748747, 4427.933580996288, 4475.149721552894, 13541.322933853267, 13946.442142314396, 14123.505677301246, 14146.29268536569, 14177.716445671029, 12153.0, 13474.124181928144, 13787.310634468236, 13927.860721392657, 13930.860691392956, 8988.820223595621, 10322.43226622528, 10418.270721049454, 10475.423851688078, 10489.947550262199, 6052.969735151296, 6544.509161812978, 7067.363937245673, 7147.606881621561, 7148.249433809375, 11891.702707432038, 11952.043836492885, 11995.460204291003, 12149.331786751813, 12207.816882746589, 12116.394180291127, 12236.204646697935, 12278.0, 12315.44580493862, 12418.875811241773, 8615.439996400213, 8644.82710345777, 8683.0, 8767.386282960386, 8771.517566533901, 10436.425996569958, 10597.841032384365, 10670.19973502006, 10686.625968091079, 10694.304870183412, 9043.0, 9119.224865886474, 9134.451932884049, 9198.67804626835, 9284.118008789153, 8669.479831210148, 8876.0, 8917.019127895797, 9042.367034307536, 9088.0, 7105.0408194893025, 8022.478538894953, 8149.429539932385, 8157.75526734199, 8251.463654862655, 5994.940050599613, 6045.516358691382, 6150.0, 6207.068939659087, 6240.594361366497, 6038.124471951454, 6038.12447195163, 6124.755009799558, 6173.876522469615, 6269.749210031548], "value": 5267.065238328609, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.6221808173195, 398.84046381447433, 401.7846015802199, 403.8283729414999, 404.6984996177848, 4898.91795986706, 5189.948100518994, 5228.967199024566, 5587.692676902769, 5644.943550564503, 4307.768924302789, 5233.749487720279, 5398.595105367093, 5420.181505617077, 5467.371252305986, 3673.412254039354, 3916.373380259159, 4216.936745948813, 4236.961944323645, 4541.977290113545, 4320.740755554661, 4539.7957091930775, 4566.520515345891, 4578.862634120982, 4621.653375996797, 4093.713440059197, 4261.936070958923, 4339.7396156230725, 4390.629060307446, 4466.173757854791, 3994.760314381132, 4457.398251236074, 4457.509673935864, 4468.486124095705, 4480.820767169309, 3843.673287770543, 4099.85650502234, 4145.6683465323, 4159.604837540429, 4165.271077561445, 4355.760433176174, 4819.638527110481, 4966.826161084345, 5444.727763611803, 5560.332760068818, 4487.551244875519, 4516.887077823048, 4696.577308042292, 5214.60890433219, 5219.791208351661, 5545.528630066449, 5821.8356328734, 5881.147233651097, 5950.434708702666, 6004.949133901549, 3880.3791393376923, 4225.9577404226175, 4229.039672229421, 4706.870351115742, 4724.881877953045, 5114.718690472023, 5308.8141915033175, 5756.395578464285, 5889.558283128783, 6205.5345849061505, 4702.811887524529, 4908.01839632075, 4987.401511818605, 5081.568066714371, 5312.379724184161, 4755.857324280277, 4791.736454494967, 5168.8966220675375, 5399.379071406838, 5427.96451330751, 4860.586850117779, 4934.407871055425, 4950.034743225036, 5425.972870135703, 5480.7533660985355, 5808.94191058084, 5840.853978650568, 5859.707014649336, 5864.120381942743, 5873.4126587340925, 1571.6463795646116, 1612.4840051183744, 1838.4281439369413, 1870.419495526278, 1877.7558917340932, 1320.6434262749003, 1342.8321459817523, 1451.2380999974887, 1453.7092581483746, 1494.6562290673205, 4860.027994401134, 5217.0, 5314.73426328682, 5479.698616576126, 5638.915416268759, 5100.897982040338, 5225.712585807741, 5841.41585841421, 5875.265591801025, 5909.852253693692, 4633.606143477842, 5446.455354464521, 5532.585056120807, 5650.576206784508, 5700.978481404862, 2792.6648802143873, 2872.238856702975, 3046.562749800151, 3173.4922412413903, 3187.4103290891258, 5417.377001644862, 5569.569669572134, 5925.555583331267, 6218.906716399258, 6283.43449089575, 6018.608790428696, 6216.658083805434, 6228.719707613168, 6268.843278918063, 6301.19596779438, 5583.553315734732, 5703.800366987136, 5779.653220806765, 5830.62100963436, 6430.7460045291655, 5264.289320941777, 5954.821355359346, 6034.517238620988, 6043.45608895184, 6063.575549711654, 4871.634627402888, 5800.071988481823, 5855.0, 5965.463108320272, 5972.402759723993, 5528.557715382679, 5870.383609721089, 6127.8468038297615, 6309.621422714652, 6375.218586060455, 4162.896832339372, 4499.302608095751, 4699.271612900006, 4784.258439941815, 4799.952000480091, 4773.427188737235, 5532.90972305488, 5799.652020878761, 6121.571489995836, 6124.14262003311, 5130.56344223618, 5507.0, 5597.44025597437, 5850.0, 5894.351621321565, 5095.082885080721, 5112.437631860566, 5375.650582712111, 5833.562482813891, 5890.705464726832, 4413.49244836835, 5674.715589729728, 5721.256236689203, 5730.850930900912, 5780.566457515787, 5168.224766285088, 5539.390667026704, 5753.1945527627, 5909.025010873158, 5933.584649074523, 5146.6911985281, 5507.697076660822, 5548.889022219452, 5692.800751973661, 5796.579837939732], "value": 4487.8810669924815, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.2460143141035, 727.2836256287555, 765.5865832450477, 804.5775967617001, 903.4488961733343, 16217.594560136002, 17268.481945541622, 17285.135743212835, 17286.654266914655, 17300.307987680495, 13065.477380904753, 14923.179225142612, 15871.206439678028, 15952.601184970381, 15981.440649577267, 849.2441726863066, 988.3081842710096, 1011.4993078426153, 1016.1210552871787, 1017.1811691588268, 972.7033254857266, 1005.7938122684868, 1008.2790804574728, 1012.7215015870621, 1013.8124446977333, 1058.1957712138792, 1058.7829494953555, 1059.0838924330476, 1060.8886066962973, 1060.9257351985325, 1045.7176562328166, 1049.5486940615533, 1054.1882750282239, 1054.2725519391595, 1055.7941201465717, 771.8610650082983, 780.9336206422461, 781.945263831532, 782.6830133795822, 783.4124406694979, 16585.668286634198, 16844.24200910962, 17056.744148837777, 18037.27850885963, 18268.451946441626, 14523.564293071226, 14598.562043138723, 14690.26548672562, 14716.190609516472, 14822.70354592913, 11325.980661740401, 11657.70855728605, 11818.527258909633, 11990.0, 12052.939735301356, 3423.246885685145, 3524.2951409718157, 3710.6474884885893, 3851.6340947609933, 3905.49228600283, 96661.51669241679, 115743.42128289389, 120334.0, 121576.39211803884, 127357.0, 9745.610175592898, 10919.563217471372, 11044.337339759479, 11416.828747568794, 11464.31214127155, 21356.038978246015, 23319.650205246933, 23502.0, 23775.524489510113, 23797.762022379902, 7446.590437525988, 7704.345130663956, 8004.479708818908, 8099.06860711014, 8181.140980197112, 4191.979040104841, 4557.886052848706, 4619.006913513611, 4637.582617564435, 4645.837395691202, 3571.571411430593, 3628.9818550907603, 3630.8910732678064, 3674.154944362758, 3677.191017976041, 528.2050513976518, 619.6313193649861, 625.0436831647586, 626.7712285015937, 629.2763322179438, 700.2752151523149, 704.7413041202932, 718.964051797408, 726.1141407482862, 747.7495039161832, 10378.182973821176, 10402.843957340647, 10761.192910531741, 10858.185636077325, 11099.056580190774, 697.2957313113792, 710.573655806512, 734.0, 738.3982054625463, 748.7005197920766, 5055.241713742895, 5261.447548007481, 5269.1569348903995, 5284.180951952453, 5290.9735451322495, 110347.0, 111373.44313278382, 111936.0, 112917.0, 114779.27831082541, 80273.59863200763, 93180.53409733044, 94301.52849235847, 97142.0, 98050.52924206143, 86045.569772152, 86489.0, 86808.5659571698, 87412.5629371849, 88761.55619221863, 8822.911770882209, 9846.803063938825, 9909.405435673594, 10041.74895627586, 10165.237607179342, 54237.45762542324, 55031.17453238284, 55140.44859551353, 56593.71703141458, 57658.423415765305, 70887.64556177186, 71107.0, 72380.19049523804, 72824.6358768224, 73420.0, 11693.88306116962, 11754.88245117538, 11919.940400297943, 12078.577249796215, 12226.816597750863, 13396.0, 13457.730845382841, 13586.93206533961, 13713.725725485236, 14430.0, 12316.692082697646, 12391.442385092872, 12714.809277860655, 13087.476500939856, 13303.201807891557, 11709.765804683688, 11758.82361764557, 12056.51773929068, 12070.456829442872, 12552.937235313764, 12035.75928481408, 12224.914594422917, 12237.20458170216, 12438.19151755133, 12586.307753073668, 9369.741433655785, 9383.90507868744, 9524.95237523808, 9686.07982241686, 10001.099901008944, 7305.525140865827, 9432.858507122535, 9687.079424516234, 10731.624393146514, 10832.945835270773], "value": 7801.188682058739, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 119.0, 120.0, 120.0, 119.0, 120.0, 122.0, 119.0, 121.0, 149.0], "value": 121.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 111.0, 110.0, 143.0, 141.0, 140.0, 139.0, 101.0, 161.0, 104.0], "value": 128.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 198.0, 202.0, 204.0, 200.0, 242.0, 251.0, 199.0, 199.0, 199.0], "value": 209.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 81.0, 83.0, 105.0, 61.0, 60.0, 74.0, 84.0, 99.0, 69.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 69.0, 86.0, 84.0, 100.0, 75.0, 81.0, 70.0, 69.0, 82.0], "value": 80.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 90.0, 90.0, 90.0, 90.0, 90.0, 90.0, 93.0, 89.0], "value": 90.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 96.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 101.0, 93.0, 91.0, 92.0, 90.0, 91.0, 112.0, 100.0, 98.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 67.0, 67.0, 67.0, 67.0, 69.0, 68.0, 68.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 50.0, 83.0, 96.0, 90.0, 84.0, 60.0, 61.0, 63.0, 60.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 87.0, 102.0, 100.0, 72.0, 100.0, 105.0, 104.0, 81.0], "value": 91.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 135.0, 135.0, 135.0, 145.0, 147.0, 181.0, 142.0, 192.0, 177.0], "value": 152.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 164.0, 168.0, 178.0, 219.0, 178.0, 166.0, 168.0, 186.0, 165.0], "value": 176.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 66.0, 65.0, 66.0, 65.0, 64.0, 64.0, 65.0, 63.0], "value": 64.8, "unit": "score"}]}]} 15:19:21 INFO - Return code: 0 15:19:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:19:21 ERROR - # TBPL SUCCESS # 15:19:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:19:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:19:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:19:21 INFO - 2017-05-05 15:19:21.815 screenresolution[2636:82698] starting screenresolution argv=screenresolution get 15:19:21 INFO - 2017-05-05 15:19:21.818 screenresolution[2636:82698] Display 0: 1600x1200x32@60 15:19:21 INFO - 2017-05-05 15:19:21.824 screenresolution[2637:82701] starting screenresolution argv=screenresolution list 15:19:21 INFO - Available Modes on Display 0 15:19:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:19:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:19:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:19:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:19:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:19:22 INFO - Intel Iris: 15:19:22 INFO - Chipset Model: Intel Iris 15:19:22 INFO - Type: GPU 15:19:22 INFO - Bus: Built-In 15:19:22 INFO - VRAM (Dynamic, Max): 1536 MB 15:19:22 INFO - Vendor: Intel (0x8086) 15:19:22 INFO - Device ID: 0x0a2e 15:19:22 INFO - Revision ID: 0x0009 15:19:22 INFO - Displays: 15:19:22 INFO - Display: 15:19:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:19:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:19:22 INFO - Display Serial Number: 1600x1200 60 15:19:22 INFO - Main Display: Yes 15:19:22 INFO - Mirror: Off 15:19:22 INFO - Online: Yes 15:19:22 INFO - Rotation: Supported 15:19:22 INFO - Return code: 0 15:19:22 INFO - Running post-action listener: _resource_record_post_action 15:19:22 INFO - [mozharness: 2017-05-05 22:19:22.060772Z] Finished run-tests step (success) 15:19:22 INFO - Running post-run listener: _resource_record_post_run 15:19:22 INFO - Total resource usage - Wall time: 1192s; CPU: 55.0%; Read bytes: 602112; Write bytes: 426335232; Read time: 5; Write time: 1438 15:19:22 INFO - TinderboxPrint: CPU usage
54.6% 15:19:22 INFO - TinderboxPrint: I/O read bytes / time
602,112 / 5 15:19:22 INFO - TinderboxPrint: I/O write bytes / time
426,335,232 / 1,438 15:19:22 INFO - TinderboxPrint: CPU idle
2,166.5 (45.4%) 15:19:22 INFO - TinderboxPrint: CPU system
961.2 (20.2%) 15:19:22 INFO - TinderboxPrint: CPU user
1,641.9 (34.4%) 15:19:22 INFO - TinderboxPrint: Swap in / out
121,946,112 / 0 15:19:22 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122831360; Write bytes: 122810368; Read time: 11083; Write time: 277 15:19:22 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 475136; Write bytes: 302074880; Read time: 3; Write time: 1149 15:19:22 INFO - Running post-run listener: _upload_blobber_files 15:19:22 INFO - Blob upload gear active. 15:19:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:19:22 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 15:19:22 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'] 15:19:22 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 15:19:22 INFO - (blobuploader) - INFO - Open directory for files ... 15:19:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:19:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:19:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:19:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:19:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:19:24 INFO - (blobuploader) - INFO - Done attempting. 15:19:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:19:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:19:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:19:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:19:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:19:25 INFO - (blobuploader) - INFO - Done attempting. 15:19:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:19:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:19:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:19:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:19:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:19:26 INFO - (blobuploader) - INFO - Done attempting. 15:19:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:19:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:19:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:19:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:19:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:19:28 INFO - (blobuploader) - INFO - Done attempting. 15:19:28 INFO - (blobuploader) - INFO - Iteration through files over. 15:19:28 INFO - Return code: 0 15:19:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:19:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:19:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/74ad0e32a90d9b274386a38141dc690a3d46c6476ac3a0664995c7f707cafa49e14fab21a86b5375f9731cdd6c9d5952806d52b5d2b556f11421224c6c830209", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/edbbef9e5b5948dcce255c97283d18620e9e284cb7b46c5bb7260edb04e5d364cf1c81560ed4fea62141a0e823fd3e41700b7e6019dd6fb18ddad740552fb877", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a66876e3ff425038aa30becf9ffeaf1966323f412f04e040075883fdf9b1425d948a5e4f2b2a8b7af6105742bf779d7e6ac7dff550ead667ab315029af589aa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d8a702661763720e98a81be37fcdc01223b3342bf7a7fd032d1904d7e12483045d4e81d549504f5f5df2ba0769e62d74a72154351bee42c8ec2d859960043a73"} 15:19:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:19:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:19:28 INFO - Contents: 15:19:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/74ad0e32a90d9b274386a38141dc690a3d46c6476ac3a0664995c7f707cafa49e14fab21a86b5375f9731cdd6c9d5952806d52b5d2b556f11421224c6c830209", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/edbbef9e5b5948dcce255c97283d18620e9e284cb7b46c5bb7260edb04e5d364cf1c81560ed4fea62141a0e823fd3e41700b7e6019dd6fb18ddad740552fb877", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a66876e3ff425038aa30becf9ffeaf1966323f412f04e040075883fdf9b1425d948a5e4f2b2a8b7af6105742bf779d7e6ac7dff550ead667ab315029af589aa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d8a702661763720e98a81be37fcdc01223b3342bf7a7fd032d1904d7e12483045d4e81d549504f5f5df2ba0769e62d74a72154351bee42c8ec2d859960043a73"} 15:19:28 INFO - Running post-run listener: copy_logs_to_upload_dir 15:19:28 INFO - Copying logs to upload dir... 15:19:28 INFO - mkdir: /builds/slave/test/build/upload/logs 15:19:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.641531 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-05-05 15:19:28.126566) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 15:19:28.130896) ========= 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.nILFKlT48Q/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.gx88x5KtAS/Listeners TMPDIR=/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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/74ad0e32a90d9b274386a38141dc690a3d46c6476ac3a0664995c7f707cafa49e14fab21a86b5375f9731cdd6c9d5952806d52b5d2b556f11421224c6c830209", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/edbbef9e5b5948dcce255c97283d18620e9e284cb7b46c5bb7260edb04e5d364cf1c81560ed4fea62141a0e823fd3e41700b7e6019dd6fb18ddad740552fb877", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a66876e3ff425038aa30becf9ffeaf1966323f412f04e040075883fdf9b1425d948a5e4f2b2a8b7af6105742bf779d7e6ac7dff550ead667ab315029af589aa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d8a702661763720e98a81be37fcdc01223b3342bf7a7fd032d1904d7e12483045d4e81d549504f5f5df2ba0769e62d74a72154351bee42c8ec2d859960043a73"} build_url:https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011378 build_url: 'https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/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/74ad0e32a90d9b274386a38141dc690a3d46c6476ac3a0664995c7f707cafa49e14fab21a86b5375f9731cdd6c9d5952806d52b5d2b556f11421224c6c830209", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/edbbef9e5b5948dcce255c97283d18620e9e284cb7b46c5bb7260edb04e5d364cf1c81560ed4fea62141a0e823fd3e41700b7e6019dd6fb18ddad740552fb877", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a66876e3ff425038aa30becf9ffeaf1966323f412f04e040075883fdf9b1425d948a5e4f2b2a8b7af6105742bf779d7e6ac7dff550ead667ab315029af589aa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d8a702661763720e98a81be37fcdc01223b3342bf7a7fd032d1904d7e12483045d4e81d549504f5f5df2ba0769e62d74a72154351bee42c8ec2d859960043a73"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 15:19:28.172600) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 15:19:28.173235) ========= 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.nILFKlT48Q/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.gx88x5KtAS/Listeners TMPDIR=/var/folders/tm/bb1xmxh10h32jsf94bs0tnvh00000w/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.005328 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 15:19:28.223412) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 15:19:28.224060) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 15:19:28.224545) ========= ========= Total master_lag: 0.20 =========