builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0231 starttime: 1492601906.4 results: success (0) buildid: 20170419025621 builduid: 52ce47367f124c1b838d9ad7e8ae9339 revision: c0ea5ed7f91a6be996a4a3c5ab25e2cdf6b4377e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-19 04:38:26.401878) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-19 04:38:26.402305) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-19 04:38:26.402576) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-19 04:38:26.429297) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 04:38:26.429970) ========= 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.pNATGBdyHy/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.PkMvJcgzm0/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-19 04:38:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 147M=0s 2017-04-19 04:38:26 (147 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.142446 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 04:38:26.596801) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 04:38:26.597509) ========= 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.pNATGBdyHy/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.PkMvJcgzm0/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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.027522 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 04:38:26.647821) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-19 04:38:26.648165) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c0ea5ed7f91a6be996a4a3c5ab25e2cdf6b4377e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c0ea5ed7f91a6be996a4a3c5ab25e2cdf6b4377e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pNATGBdyHy/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.PkMvJcgzm0/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-19 04:38:26,748 truncating revision to first 12 chars 2017-04-19 04:38:26,749 Setting DEBUG logging. 2017-04-19 04:38:26,749 attempt 1/10 2017-04-19 04:38:26,749 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c0ea5ed7f91a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-19 04:38:27,896 unpacking tar archive at: mozilla-central-c0ea5ed7f91a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.436401 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-19 04:38:28.109322) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-19 04:38:28.109780) ========= script_repo_revision: c0ea5ed7f91a6be996a4a3c5ab25e2cdf6b4377e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-19 04:38:28.110331) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-19 04:38:28.110735) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-19 04:38:28.132020) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-19 04:38:28.132582) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pNATGBdyHy/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.PkMvJcgzm0/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 04:38:28 INFO - MultiFileLogger online at 20170419 04:38:28 in /builds/slave/test 04:38:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:38:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:38:28 INFO - {'append_to_log': False, 04:38:28 INFO - 'base_work_dir': '/builds/slave/test', 04:38:28 INFO - 'blob_upload_branch': 'Firefox', 04:38:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:38:28 INFO - 'branch': 'Firefox', 04:38:28 INFO - 'buildbot_json_path': 'buildprops.json', 04:38:28 INFO - 'config_files': ('talos/mac_config.py',), 04:38:28 INFO - 'default_actions': ('clobber', 04:38:28 INFO - 'read-buildbot-config', 04:38:28 INFO - 'download-and-extract', 04:38:28 INFO - 'populate-webroot', 04:38:28 INFO - 'create-virtualenv', 04:38:28 INFO - 'install', 04:38:28 INFO - 'run-tests'), 04:38:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:38:28 INFO - 'download_minidump_stackwalk': True, 04:38:28 INFO - 'download_symbols': 'ondemand', 04:38:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:38:28 INFO - 'tooltool.py': '/tools/tooltool.py', 04:38:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:38:28 INFO - '/tools/misc-python/virtualenv.py')}, 04:38:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:38:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:38:28 INFO - 'gecko_profile': False, 04:38:28 INFO - 'gecko_profile_interval': 0, 04:38:28 INFO - 'installer_path': 'installer.exe', 04:38:28 INFO - 'log_level': 'info', 04:38:28 INFO - 'log_name': 'talos', 04:38:28 INFO - 'log_to_console': True, 04:38:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:38:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:38:28 INFO - 'opt_config_files': (), 04:38:28 INFO - 'pip_index': False, 04:38:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:38:28 INFO - 'cmd': ('bash', 04:38:28 INFO - '-c', 04:38:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:38:28 INFO - 'enabled': True, 04:38:28 INFO - 'halt_on_failure': False, 04:38:28 INFO - 'name': 'check_screen_resolution'},), 04:38:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:38:28 INFO - 'cmd': ('bash', 04:38:28 INFO - '-c', 04:38:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:38:28 INFO - 'enabled': True, 04:38:28 INFO - 'halt_on_failure': False, 04:38:28 INFO - 'name': 'check_screen_resolution'},), 04:38:28 INFO - 'run_cmd_checks_enabled': True, 04:38:28 INFO - 'suite': 'dromaeojs-e10s', 04:38:28 INFO - 'system_bits': '32', 04:38:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:38:28 INFO - 'title': 't-yosemite-r7-0231', 04:38:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:38:28 INFO - 'use_talos_json': True, 04:38:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:38:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:38:28 INFO - 'work_dir': 'build'} 04:38:28 INFO - [mozharness: 2017-04-19 11:38:28.341835Z] Running clobber step. 04:38:28 INFO - Running pre-action listener: _resource_record_pre_action 04:38:28 INFO - Running main action method: clobber 04:38:28 INFO - rmtree: /builds/slave/test/build 04:38:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:38:30 INFO - Running post-action listener: _resource_record_post_action 04:38:30 INFO - [mozharness: 2017-04-19 11:38:30.838955Z] Finished clobber step (success) 04:38:30 INFO - [mozharness: 2017-04-19 11:38:30.839117Z] Running read-buildbot-config step. 04:38:30 INFO - Running pre-action listener: _resource_record_pre_action 04:38:30 INFO - Running main action method: read_buildbot_config 04:38:30 INFO - Using buildbot properties: 04:38:30 INFO - { 04:38:30 INFO - "project": "", 04:38:30 INFO - "product": "firefox", 04:38:30 INFO - "script_repo_revision": "production", 04:38:30 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:38:30 INFO - "repository": "", 04:38:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:38:30 INFO - "buildid": "20170419025621", 04:38:30 INFO - "pgo_build": "False", 04:38:30 INFO - "basedir": "/builds/slave/test", 04:38:30 INFO - "buildnumber": 127, 04:38:30 INFO - "slavename": "t-yosemite-r7-0231", 04:38:30 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:38:30 INFO - "platform": "yosemite_r7", 04:38:30 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:38:30 INFO - "branch": "mozilla-central", 04:38:30 INFO - "repo_path": "mozilla-central", 04:38:30 INFO - "revision": "c0ea5ed7f91a6be996a4a3c5ab25e2cdf6b4377e", 04:38:30 INFO - "stage_platform": "macosx64", 04:38:30 INFO - "builduid": "52ce47367f124c1b838d9ad7e8ae9339", 04:38:30 INFO - "slavebuilddir": "test" 04:38:30 INFO - } 04:38:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/VdEa7XrZRIOj-2F5cQwT0A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:38:30 INFO - Running post-action listener: _resource_record_post_action 04:38:30 INFO - [mozharness: 2017-04-19 11:38:30.842419Z] Finished read-buildbot-config step (success) 04:38:30 INFO - [mozharness: 2017-04-19 11:38:30.842566Z] Running download-and-extract step. 04:38:30 INFO - Running pre-action listener: _resource_record_pre_action 04:38:30 INFO - Running main action method: download_and_extract 04:38:30 INFO - mkdir: /builds/slave/test/build/tests 04:38:30 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')]} 04:38:30 INFO - trying https://queue.taskcluster.net/v1/task/VdEa7XrZRIOj-2F5cQwT0A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:38:30 INFO - Downloading https://queue.taskcluster.net/v1/task/VdEa7XrZRIOj-2F5cQwT0A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:38:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VdEa7XrZRIOj-2F5cQwT0A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:38:31 INFO - Downloaded 1325 bytes. 04:38:31 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:38:31 INFO - Using the following test package requirements: 04:38:31 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:38:31 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:38:31 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:38:31 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:38:31 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:38:31 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:38:31 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:38:31 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:38:31 INFO - u'jsshell-mac.zip'], 04:38:31 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:38:31 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:38:31 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:38:31 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:38:31 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:38:31 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:38:31 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:38:31 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:38:31 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:38:31 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:38:31 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:38:31 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:38:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VdEa7XrZRIOj-2F5cQwT0A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:38:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VdEa7XrZRIOj-2F5cQwT0A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:38:31 INFO - Fetch https://queue.taskcluster.net/v1/task/VdEa7XrZRIOj-2F5cQwT0A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:38:33 INFO - Expected file size: 52615972 04:38:33 INFO - Obtained file size: 52615972 04:38:49 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:38:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VdEa7XrZRIOj-2F5cQwT0A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:38:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VdEa7XrZRIOj-2F5cQwT0A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:38:49 INFO - Fetch https://queue.taskcluster.net/v1/task/VdEa7XrZRIOj-2F5cQwT0A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:38:51 INFO - Expected file size: 52615972 04:38:51 INFO - Obtained file size: 52615972 04:39:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VdEa7XrZRIOj-2F5cQwT0A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:39:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VdEa7XrZRIOj-2F5cQwT0A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:39:07 INFO - Fetch https://queue.taskcluster.net/v1/task/VdEa7XrZRIOj-2F5cQwT0A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:39:08 INFO - Expected file size: 14408802 04:39:08 INFO - Obtained file size: 14408802 04:39:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:08 INFO - trying https://queue.taskcluster.net/v1/task/VdEa7XrZRIOj-2F5cQwT0A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:39:08 INFO - Downloading https://queue.taskcluster.net/v1/task/VdEa7XrZRIOj-2F5cQwT0A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:39:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VdEa7XrZRIOj-2F5cQwT0A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:39:10 INFO - Downloaded 71004550 bytes. 04:39:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VdEa7XrZRIOj-2F5cQwT0A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:39:10 INFO - mkdir: /builds/slave/test/properties 04:39:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:39:10 INFO - Writing to file /builds/slave/test/properties/build_url 04:39:10 INFO - Contents: 04:39:10 INFO - build_url:https://queue.taskcluster.net/v1/task/VdEa7XrZRIOj-2F5cQwT0A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:39:11 INFO - Running post-action listener: _resource_record_post_action 04:39:11 INFO - Running post-action listener: set_extra_try_arguments 04:39:11 INFO - [mozharness: 2017-04-19 11:39:11.736797Z] Finished download-and-extract step (success) 04:39:11 INFO - [mozharness: 2017-04-19 11:39:11.736925Z] Running populate-webroot step. 04:39:11 INFO - Running pre-action listener: _resource_record_pre_action 04:39:11 INFO - Running main action method: populate_webroot 04:39:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:39:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:39:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:39:11 INFO - '--tppagecycles', 04:39:11 INFO - '7'], 04:39:11 INFO - 'tests': ['tsvgm']}}, 04:39:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:39:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:39:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:39:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:39:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:39:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:39:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:39:11 INFO - 'talos_options': ['--disable-e10s'], 04:39:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:39:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:39:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:39:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:39:11 INFO - 'talos_options': ['--disable-e10s'], 04:39:11 INFO - 'tests': ['damp', 'tps']}, 04:39:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:39:11 INFO - 'tests': ['damp', 'tps']}, 04:39:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:39:11 INFO - 'tests': ['dromaeo_dom']}, 04:39:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:39:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:39:11 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:39:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:39:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:39:11 INFO - 'tests': ['a11yr', 04:39:11 INFO - 'ts_paint', 04:39:11 INFO - 'tpaint', 04:39:11 INFO - 'sessionrestore', 04:39:11 INFO - 'sessionrestore_no_auto_restore', 04:39:11 INFO - 'tabpaint']}, 04:39:11 INFO - 'other-e10s': {'tests': ['a11yr', 04:39:11 INFO - 'ts_paint', 04:39:11 INFO - 'tpaint', 04:39:11 INFO - 'sessionrestore', 04:39:11 INFO - 'sessionrestore_no_auto_restore', 04:39:11 INFO - 'tabpaint']}, 04:39:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:39:11 INFO - 'ts_paint', 04:39:11 INFO - 'tpaint', 04:39:11 INFO - 'sessionrestore', 04:39:11 INFO - 'sessionrestore_no_auto_restore', 04:39:11 INFO - 'tabpaint']}, 04:39:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:39:11 INFO - 'ts_paint', 04:39:11 INFO - 'tpaint', 04:39:11 INFO - 'sessionrestore', 04:39:11 INFO - 'sessionrestore_no_auto_restore', 04:39:11 INFO - 'tabpaint']}, 04:39:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:39:11 INFO - 'tests': ['a11yr', 04:39:11 INFO - 'ts_paint', 04:39:11 INFO - 'tpaint', 04:39:11 INFO - 'sessionrestore', 04:39:11 INFO - 'sessionrestore_no_auto_restore', 04:39:11 INFO - 'tabpaint']}, 04:39:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:39:11 INFO - 'tests': ['a11yr', 04:39:11 INFO - 'ts_paint', 04:39:11 INFO - 'tpaint', 04:39:11 INFO - 'sessionrestore', 04:39:11 INFO - 'sessionrestore_no_auto_restore', 04:39:11 INFO - 'tabpaint']}, 04:39:11 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:39:11 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:39:11 INFO - 'bloom_basic_ref']}, 04:39:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:39:11 INFO - 'tests': ['tsvgx', 04:39:11 INFO - 'tsvgr_opacity', 04:39:11 INFO - 'tart', 04:39:11 INFO - 'tscrollx', 04:39:11 INFO - 'cart', 04:39:11 INFO - 'tsvg_static']}, 04:39:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:39:11 INFO - 'tsvgr_opacity', 04:39:11 INFO - 'tart', 04:39:11 INFO - 'tscrollx', 04:39:11 INFO - 'cart', 04:39:11 INFO - 'tsvg_static']}, 04:39:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:39:11 INFO - 'talos_options': ['--disable-e10s'], 04:39:11 INFO - 'tests': ['tp5o']}, 04:39:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:39:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:39:11 INFO - 'talos_options': ['--disable-e10s', 04:39:11 INFO - '--xperf_path', 04:39:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:39:11 INFO - 'tests': ['tp5n']}, 04:39:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:39:11 INFO - 'talos_options': ['--xperf_path', 04:39:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:39:11 INFO - 'tests': ['tp5n']}}, 04:39:11 INFO - 'talos.zip': {'path': '', 04:39:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:39:11 INFO - Running post-action listener: _resource_record_post_action 04:39:11 INFO - [mozharness: 2017-04-19 11:39:11.756385Z] Finished populate-webroot step (success) 04:39:11 INFO - [mozharness: 2017-04-19 11:39:11.756500Z] Running create-virtualenv step. 04:39:11 INFO - Running pre-action listener: _resource_record_pre_action 04:39:11 INFO - Running main action method: create_virtualenv 04:39:11 INFO - Creating virtualenv /builds/slave/test/build/venv 04:39:11 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 04:39:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:39:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:39:11 INFO - Using real prefix '/tools/python27' 04:39:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:39:12 INFO - Installing distribute.............................................................................................................................................................................................done. 04:39:15 INFO - Installing pip.................done. 04:39:15 INFO - Return code: 0 04:39:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:39:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:39:15 INFO - Reading from file tmpfile_stdout 04:39:15 INFO - Output received: 04:39:15 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) 04:39:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:39: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')]} 04:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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')]} 04:39:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcaa856eb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017b5d30>, '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 0x1016dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017aabe8>, '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.pNATGBdyHy/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.PkMvJcgzm0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 04:39: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', 'pip>=1.5'] in /builds/slave/test/build 04:39: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 pip>=1.5 04:39:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pNATGBdyHy/Render', 04:39:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:15 INFO - 'HOME': '/Users/cltbld', 04:39:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:15 INFO - 'LOGNAME': 'cltbld', 04:39:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:15 INFO - 'MOZ_NO_REMOTE': '1', 04:39:15 INFO - 'NO_EM_RESTART': '1', 04:39:15 INFO - 'PAGER': '/bin/cat', 04:39:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:15 INFO - 'PWD': '/builds/slave/test', 04:39:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:15 INFO - 'SHELL': '/bin/bash', 04:39:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PkMvJcgzm0/Listeners', 04:39:15 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 04:39:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:15 INFO - 'USER': 'cltbld', 04:39:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:15 INFO - 'XPC_FLAGS': '0x0', 04:39:15 INFO - 'XPC_SERVICE_NAME': '0', 04:39:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:16 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 04:39:16 INFO - Cleaning up... 04:39:16 INFO - Return code: 0 04:39:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:39:16 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')]} 04:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:16 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')]} 04:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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', '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 0x1019d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcaa856eb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017b5d30>, '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 0x1016dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017aabe8>, '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.pNATGBdyHy/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.PkMvJcgzm0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 04:39: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:39: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 psutil>=3.1.1 04:39:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pNATGBdyHy/Render', 04:39:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:16 INFO - 'HOME': '/Users/cltbld', 04:39:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:16 INFO - 'LOGNAME': 'cltbld', 04:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:16 INFO - 'MOZ_NO_REMOTE': '1', 04:39:16 INFO - 'NO_EM_RESTART': '1', 04:39:16 INFO - 'PAGER': '/bin/cat', 04:39:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:16 INFO - 'PWD': '/builds/slave/test', 04:39:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:16 INFO - 'SHELL': '/bin/bash', 04:39:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PkMvJcgzm0/Listeners', 04:39:16 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 04:39:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:16 INFO - 'USER': 'cltbld', 04:39:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:16 INFO - 'XPC_FLAGS': '0x0', 04:39:16 INFO - 'XPC_SERVICE_NAME': '0', 04:39:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:16 INFO - Downloading/unpacking psutil>=3.1.1 04:39: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 04:39: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 04:39: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 04:39: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 04:39: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 04:39: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 04:39:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:39:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:19 INFO - Installing collected packages: psutil 04:39:19 INFO - Running setup.py install for psutil 04:39:19 INFO - building 'psutil._psutil_osx' extension 04:39:19 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 04:39:20 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 04:39:20 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 04:39:20 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 04:39:20 INFO - building 'psutil._psutil_posix' extension 04:39:20 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 04:39:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:39:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:39:20 INFO - ^ 04:39:20 INFO - 1 warning generated. 04:39:20 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 04:39:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:20 INFO - Successfully installed psutil 04:39:20 INFO - Cleaning up... 04:39:21 INFO - Return code: 0 04:39:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:39:21 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')]} 04:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:21 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')]} 04:39:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:21 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 0x1019d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcaa856eb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017b5d30>, '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 0x1016dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017aabe8>, '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.pNATGBdyHy/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.PkMvJcgzm0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 04:39:21 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 04:39:21 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 04:39:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pNATGBdyHy/Render', 04:39:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:21 INFO - 'HOME': '/Users/cltbld', 04:39:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:21 INFO - 'LOGNAME': 'cltbld', 04:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:21 INFO - 'MOZ_NO_REMOTE': '1', 04:39:21 INFO - 'NO_EM_RESTART': '1', 04:39:21 INFO - 'PAGER': '/bin/cat', 04:39:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:21 INFO - 'PWD': '/builds/slave/test', 04:39:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:21 INFO - 'SHELL': '/bin/bash', 04:39:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PkMvJcgzm0/Listeners', 04:39:21 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 04:39:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:21 INFO - 'USER': 'cltbld', 04:39:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:21 INFO - 'XPC_FLAGS': '0x0', 04:39:21 INFO - 'XPC_SERVICE_NAME': '0', 04:39:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:39:21 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 04:39:21 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 04:39:21 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 04:39:21 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 04:39:21 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 04:39:21 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 04:39:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:39:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:39:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:39:23 INFO - Installing collected packages: mozsystemmonitor 04:39:23 INFO - Running setup.py install for mozsystemmonitor 04:39:24 INFO - Successfully installed mozsystemmonitor 04:39:24 INFO - Cleaning up... 04:39:24 INFO - Return code: 0 04:39:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:39: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')]} 04:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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')]} 04:39:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcaa856eb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017b5d30>, '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 0x1016dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017aabe8>, '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.pNATGBdyHy/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.PkMvJcgzm0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 04:39:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:39:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:39:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pNATGBdyHy/Render', 04:39:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:24 INFO - 'HOME': '/Users/cltbld', 04:39:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:24 INFO - 'LOGNAME': 'cltbld', 04:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:24 INFO - 'MOZ_NO_REMOTE': '1', 04:39:24 INFO - 'NO_EM_RESTART': '1', 04:39:24 INFO - 'PAGER': '/bin/cat', 04:39:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:24 INFO - 'PWD': '/builds/slave/test', 04:39:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:24 INFO - 'SHELL': '/bin/bash', 04:39:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PkMvJcgzm0/Listeners', 04:39:24 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 04:39:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:24 INFO - 'USER': 'cltbld', 04:39:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:24 INFO - 'XPC_FLAGS': '0x0', 04:39:24 INFO - 'XPC_SERVICE_NAME': '0', 04:39:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:25 INFO - Downloading/unpacking jsonschema==2.5.1 04:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:39:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:28 INFO - Downloading functools32-3.2.3-2.tar.gz 04:39:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:39:28 INFO - warning: no files found matching '*.txt' 04:39:28 INFO - no previously-included directories found matching 'build' 04:39:28 INFO - no previously-included directories found matching 'dist' 04:39:28 INFO - no previously-included directories found matching '.git*' 04:39:28 INFO - Installing collected packages: jsonschema, functools32 04:39:28 INFO - Running setup.py install for functools32 04:39:28 INFO - warning: no files found matching '*.txt' 04:39:28 INFO - no previously-included directories found matching 'build' 04:39:28 INFO - no previously-included directories found matching 'dist' 04:39:28 INFO - no previously-included directories found matching '.git*' 04:39:28 INFO - Successfully installed jsonschema functools32 04:39:28 INFO - Cleaning up... 04:39:29 INFO - Return code: 0 04:39:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:29 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 0x1019d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcaa856eb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017b5d30>, '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 0x1016dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017aabe8>, '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.pNATGBdyHy/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.PkMvJcgzm0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 04:39:29 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 04:39:29 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 04:39:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pNATGBdyHy/Render', 04:39:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:29 INFO - 'HOME': '/Users/cltbld', 04:39:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:29 INFO - 'LOGNAME': 'cltbld', 04:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:29 INFO - 'MOZ_NO_REMOTE': '1', 04:39:29 INFO - 'NO_EM_RESTART': '1', 04:39:29 INFO - 'PAGER': '/bin/cat', 04:39:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:29 INFO - 'PWD': '/builds/slave/test', 04:39:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:29 INFO - 'SHELL': '/bin/bash', 04:39:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PkMvJcgzm0/Listeners', 04:39:29 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 04:39:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:29 INFO - 'USER': 'cltbld', 04:39:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:29 INFO - 'XPC_FLAGS': '0x0', 04:39:29 INFO - 'XPC_SERVICE_NAME': '0', 04:39:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:39:29 INFO - Cleaning up... 04:39:29 INFO - Return code: 0 04:39:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:29 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 0x1019d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcaa856eb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017b5d30>, '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 0x1016dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017aabe8>, '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.pNATGBdyHy/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.PkMvJcgzm0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 04:39:29 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 04:39:29 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 04:39:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pNATGBdyHy/Render', 04:39:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:29 INFO - 'HOME': '/Users/cltbld', 04:39:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:29 INFO - 'LOGNAME': 'cltbld', 04:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:29 INFO - 'MOZ_NO_REMOTE': '1', 04:39:29 INFO - 'NO_EM_RESTART': '1', 04:39:29 INFO - 'PAGER': '/bin/cat', 04:39:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:29 INFO - 'PWD': '/builds/slave/test', 04:39:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:29 INFO - 'SHELL': '/bin/bash', 04:39:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PkMvJcgzm0/Listeners', 04:39:29 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 04:39:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:29 INFO - 'USER': 'cltbld', 04:39:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:29 INFO - 'XPC_FLAGS': '0x0', 04:39:29 INFO - 'XPC_SERVICE_NAME': '0', 04:39:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:29 INFO - Downloading/unpacking blobuploader==1.2.4 04:39:29 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 04:39:29 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 04:39:29 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 04:39:29 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 04:39:29 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 04:39:29 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 04:39:32 INFO - Downloading blobuploader-1.2.4.tar.gz 04:39:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:39:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:39:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:33 INFO - Downloading docopt-0.6.1.tar.gz 04:39:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:39:33 INFO - Installing collected packages: blobuploader, requests, docopt 04:39:33 INFO - Running setup.py install for blobuploader 04:39:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:39:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:39:33 INFO - Running setup.py install for requests 04:39:34 INFO - Running setup.py install for docopt 04:39:34 INFO - Successfully installed blobuploader requests docopt 04:39:34 INFO - Cleaning up... 04:39:34 INFO - Return code: 0 04:39:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:34 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')]} 04:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:34 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')]} 04:39:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:34 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 0x1019d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcaa856eb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017b5d30>, '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 0x1016dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017aabe8>, '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.pNATGBdyHy/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.PkMvJcgzm0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 04:39:34 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 04:39:34 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 04:39:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pNATGBdyHy/Render', 04:39:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:34 INFO - 'HOME': '/Users/cltbld', 04:39:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:34 INFO - 'LOGNAME': 'cltbld', 04:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:34 INFO - 'MOZ_NO_REMOTE': '1', 04:39:34 INFO - 'NO_EM_RESTART': '1', 04:39:34 INFO - 'PAGER': '/bin/cat', 04:39:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:34 INFO - 'PWD': '/builds/slave/test', 04:39:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:34 INFO - 'SHELL': '/bin/bash', 04:39:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PkMvJcgzm0/Listeners', 04:39:34 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 04:39:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:34 INFO - 'USER': 'cltbld', 04:39:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:34 INFO - 'XPC_FLAGS': '0x0', 04:39:34 INFO - 'XPC_SERVICE_NAME': '0', 04:39:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:34 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-yJJZAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:34 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-kyfxzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:34 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-qhHaDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:35 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-SY7PRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:35 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-e_lTY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:35 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-1sKrYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:35 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-jT8nUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:35 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-QZxTmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:35 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-IFMOKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:35 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-bVHFYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:35 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-QhAav1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:35 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-WJ5vFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:35 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-DWHGDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:36 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-hu_r_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:36 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-s_qE04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:36 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-tV2Ker-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:36 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-yJgY_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:39:36 INFO - Running setup.py install for manifestparser 04:39:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:39:36 INFO - Running setup.py install for mozcrash 04:39:36 INFO - Running setup.py install for mozdebug 04:39:36 INFO - Running setup.py install for mozdevice 04:39:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:39:37 INFO - Running setup.py install for mozfile 04:39:37 INFO - Running setup.py install for mozhttpd 04:39:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:39:37 INFO - Running setup.py install for mozinfo 04:39:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:39:37 INFO - Running setup.py install for mozInstall 04:39:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:39:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:39:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:39:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:39:37 INFO - Running setup.py install for mozleak 04:39:37 INFO - Running setup.py install for mozlog 04:39:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:39:37 INFO - Running setup.py install for moznetwork 04:39:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:39:38 INFO - Running setup.py install for mozprocess 04:39:38 INFO - Running setup.py install for mozprofile 04:39:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:39:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:39:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:39:38 INFO - Running setup.py install for mozrunner 04:39:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:39:38 INFO - Running setup.py install for mozscreenshot 04:39:38 INFO - Running setup.py install for moztest 04:39:38 INFO - Running setup.py install for mozversion 04:39:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:39:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:39:39 INFO - Cleaning up... 04:39:39 INFO - Return code: 0 04:39:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:39 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 0x1019d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcaa856eb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017b5d30>, '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 0x1016dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017aabe8>, '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.pNATGBdyHy/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.PkMvJcgzm0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 04:39:39 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 04:39:39 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 04:39:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pNATGBdyHy/Render', 04:39:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:39 INFO - 'HOME': '/Users/cltbld', 04:39:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:39 INFO - 'LOGNAME': 'cltbld', 04:39:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:39 INFO - 'MOZ_NO_REMOTE': '1', 04:39:39 INFO - 'NO_EM_RESTART': '1', 04:39:39 INFO - 'PAGER': '/bin/cat', 04:39:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:39 INFO - 'PWD': '/builds/slave/test', 04:39:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:39 INFO - 'SHELL': '/bin/bash', 04:39:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PkMvJcgzm0/Listeners', 04:39:39 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 04:39:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:39 INFO - 'USER': 'cltbld', 04:39:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:39 INFO - 'XPC_FLAGS': '0x0', 04:39:39 INFO - 'XPC_SERVICE_NAME': '0', 04:39:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:39 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-mW47oR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:39 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)) 04:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:39 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-05sDFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:39 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)) 04:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:39 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-6WMuyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:39 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)) 04:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:39 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-iRc4UB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 04:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:39 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-WM4KIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:39 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)) 04:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:39 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-7vCesD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:39 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)) 04:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:39 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-ycamjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:40 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)) 04:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:40 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-Z410jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:40 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)) 04:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:40 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-TM0UTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:40 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)) 04:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:40 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-4wcbfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:40 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)) 04:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:40 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-p7RbCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:40 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)) 04:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:40 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-__4OCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:40 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)) 04:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:40 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-DcIocw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:40 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)) 04:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:40 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-7TdgSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:40 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)) 04:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:40 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-4hzArn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:40 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)) 04:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:40 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-XCoXi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:41 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)) 04:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:41 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-Rkmsii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:41 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)) 04:39:41 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)) 04:39:41 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)) 04:39:41 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)) 04:39:41 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:39:41 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:39:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:39:41 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 04:39:41 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 04:39:41 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 04:39:41 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 04:39:41 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 04:39:41 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 04:39:43 INFO - Downloading blessings-1.6.tar.gz 04:39:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:39:43 INFO - Installing collected packages: blessings 04:39:43 INFO - Running setup.py install for blessings 04:39:43 INFO - Successfully installed blessings 04:39:43 INFO - Cleaning up... 04:39:44 INFO - Return code: 0 04:39:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:39:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:44 INFO - Reading from file tmpfile_stdout 04:39:44 INFO - Current package versions: 04:39:44 INFO - blessings == 1.6 04:39:44 INFO - blobuploader == 1.2.4 04:39:44 INFO - docopt == 0.6.1 04:39:44 INFO - functools32 == 3.2.3-2 04:39:44 INFO - jsonschema == 2.5.1 04:39:44 INFO - manifestparser == 1.1 04:39:44 INFO - mozInstall == 1.12 04:39:44 INFO - mozcrash == 1.0 04:39:44 INFO - mozdebug == 0.1 04:39:44 INFO - mozdevice == 0.50 04:39:44 INFO - mozfile == 1.2 04:39:44 INFO - mozhttpd == 0.7 04:39:44 INFO - mozinfo == 0.9 04:39:44 INFO - mozleak == 0.1 04:39:44 INFO - mozlog == 3.4 04:39:44 INFO - moznetwork == 0.27 04:39:44 INFO - mozprocess == 0.25 04:39:44 INFO - mozprofile == 0.28 04:39:44 INFO - mozrunner == 6.13 04:39:44 INFO - mozscreenshot == 0.1 04:39:44 INFO - mozsystemmonitor == 0.3 04:39:44 INFO - moztest == 0.8 04:39:44 INFO - mozversion == 1.4 04:39:44 INFO - psutil == 3.1.1 04:39:44 INFO - requests == 1.2.3 04:39:44 INFO - wsgiref == 0.1.2 04:39:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39: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')]} 04:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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')]} 04:39:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:44 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 0x1019d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcaa856eb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017b5d30>, '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 0x1016dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017aabe8>, '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.pNATGBdyHy/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.PkMvJcgzm0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 04:39:44 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 04:39:44 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 04:39:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pNATGBdyHy/Render', 04:39:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:44 INFO - 'HOME': '/Users/cltbld', 04:39:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:44 INFO - 'LOGNAME': 'cltbld', 04:39:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:44 INFO - 'MOZ_NO_REMOTE': '1', 04:39:44 INFO - 'NO_EM_RESTART': '1', 04:39:44 INFO - 'PAGER': '/bin/cat', 04:39:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:44 INFO - 'PWD': '/builds/slave/test', 04:39:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:44 INFO - 'SHELL': '/bin/bash', 04:39:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PkMvJcgzm0/Listeners', 04:39:44 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 04:39:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:44 INFO - 'USER': 'cltbld', 04:39:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:44 INFO - 'XPC_FLAGS': '0x0', 04:39:44 INFO - 'XPC_SERVICE_NAME': '0', 04:39:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:44 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)) 04:39:44 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)) 04:39:44 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)) 04:39:44 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)) 04:39:44 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)) 04:39:44 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)) 04:39:44 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)) 04:39:44 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)) 04:39:44 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)) 04:39:44 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)) 04:39:44 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)) 04:39:44 INFO - Cleaning up... 04:39:44 INFO - Return code: 0 04:39:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:39: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')]} 04:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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')]} 04:39:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019da768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcaa856eb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017b5d30>, '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 0x1016dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017aabe8>, '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.pNATGBdyHy/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.PkMvJcgzm0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 04:39:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:39:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:39:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pNATGBdyHy/Render', 04:39:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:44 INFO - 'HOME': '/Users/cltbld', 04:39:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:44 INFO - 'LOGNAME': 'cltbld', 04:39:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:44 INFO - 'MOZ_NO_REMOTE': '1', 04:39:44 INFO - 'NO_EM_RESTART': '1', 04:39:44 INFO - 'PAGER': '/bin/cat', 04:39:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:44 INFO - 'PWD': '/builds/slave/test', 04:39:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:44 INFO - 'SHELL': '/bin/bash', 04:39:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PkMvJcgzm0/Listeners', 04:39:44 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 04:39:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:44 INFO - 'USER': 'cltbld', 04:39:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:44 INFO - 'XPC_FLAGS': '0x0', 04:39:44 INFO - 'XPC_SERVICE_NAME': '0', 04:39:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:39:44 INFO - Cleaning up... 04:39:44 INFO - Return code: 0 04:39:44 INFO - Running post-action listener: _resource_record_post_action 04:39:44 INFO - Running post-action listener: _start_resource_monitoring 04:39:44 INFO - Starting resource monitoring. 04:39:44 INFO - [mozharness: 2017-04-19 11:39:44.902517Z] Finished create-virtualenv step (success) 04:39:44 INFO - [mozharness: 2017-04-19 11:39:44.903476Z] Running install step. 04:39:44 INFO - Running pre-action listener: _resource_record_pre_action 04:39:44 INFO - Running main action method: install 04:39:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:45 INFO - Reading from file tmpfile_stdout 04:39:45 INFO - Detecting whether we're running mozinstall >=1.0... 04:39:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:39:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:39:45 INFO - Reading from file tmpfile_stdout 04:39:45 INFO - Output received: 04:39:45 INFO - Usage: mozinstall [options] installer 04:39:45 INFO - Options: 04:39:45 INFO - -h, --help show this help message and exit 04:39:45 INFO - -d DEST, --destination=DEST 04:39:45 INFO - Directory to install application into. [default: 04:39:45 INFO - "/builds/slave/test"] 04:39:45 INFO - --app=APP Application being installed. [default: firefox] 04:39:45 INFO - mkdir: /builds/slave/test/build/application 04:39:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:39:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:40:05 INFO - Reading from file tmpfile_stdout 04:40:05 INFO - Output received: 04:40:05 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:40:05 INFO - Running post-action listener: _resource_record_post_action 04:40:05 INFO - [mozharness: 2017-04-19 11:40:05.157676Z] Finished install step (success) 04:40:05 INFO - [mozharness: 2017-04-19 11:40:05.157808Z] Running run-tests step. 04:40:05 INFO - Running pre-action listener: _resource_record_pre_action 04:40:05 INFO - Running main action method: run_tests 04:40:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:40:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:40:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:40:05 INFO - 2017-04-19 04:40:05.172 screenresolution[1623:7402] starting screenresolution argv=screenresolution get 04:40:05 INFO - 2017-04-19 04:40:05.175 screenresolution[1623:7402] Display 0: 1600x1200x32@60 04:40:05 INFO - 2017-04-19 04:40:05.180 screenresolution[1624:7405] starting screenresolution argv=screenresolution list 04:40:05 INFO - Available Modes on Display 0 04:40:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:40:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:40:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:40:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:40:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:40:05 INFO - Intel Iris: 04:40:05 INFO - Chipset Model: Intel Iris 04:40:05 INFO - Type: GPU 04:40:05 INFO - Bus: Built-In 04:40:05 INFO - VRAM (Dynamic, Max): 1536 MB 04:40:05 INFO - Vendor: Intel (0x8086) 04:40:05 INFO - Device ID: 0x0a2e 04:40:05 INFO - Revision ID: 0x0009 04:40:05 INFO - Displays: 04:40:05 INFO - Display: 04:40:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:40:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:40:05 INFO - Display Serial Number: 1600x1200 60 04:40:05 INFO - Main Display: Yes 04:40:05 INFO - Mirror: Off 04:40:05 INFO - Online: Yes 04:40:05 INFO - Rotation: Supported 04:40:05 INFO - Return code: 0 04:40:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:40:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:40:05 INFO - Python 2.7.3 04:40:05 INFO - Return code: 0 04:40:05 INFO - grabbing minidump binary from tooltool 04:40:05 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')]} 04:40:05 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 0x1017b5d30>, '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 0x1016dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1017aabe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:40:05 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 04:40:05 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 04:40:05 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 04:40:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:40:05 INFO - Return code: 0 04:40:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:40:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:40:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:40:05 INFO - ENV: RUST_BACKTRACE is now 1 04:40:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:40:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:40:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VdEa7XrZRIOj-2F5cQwT0A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0231', '--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 04:40:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VdEa7XrZRIOj-2F5cQwT0A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0231 --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 04:40:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pNATGBdyHy/Render', 04:40:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:05 INFO - 'HOME': '/Users/cltbld', 04:40:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:05 INFO - 'LOGNAME': 'cltbld', 04:40:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:40:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:05 INFO - 'MOZ_NO_REMOTE': '1', 04:40:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:40:05 INFO - 'NO_EM_RESTART': '1', 04:40:05 INFO - 'PAGER': '/bin/cat', 04:40:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:05 INFO - 'PWD': '/builds/slave/test', 04:40:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:40:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:05 INFO - 'RUST_BACKTRACE': '1', 04:40:05 INFO - 'SHELL': '/bin/bash', 04:40:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PkMvJcgzm0/Listeners', 04:40:05 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 04:40:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:05 INFO - 'USER': 'cltbld', 04:40:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:05 INFO - 'XPC_FLAGS': '0x0', 04:40:05 INFO - 'XPC_SERVICE_NAME': '0', 04:40:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:40:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VdEa7XrZRIOj-2F5cQwT0A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0231', '--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 04:40:05 INFO - mozversion application_buildid: 20170419025621 04:40:05 INFO - mozversion application_changeset: c0ea5ed7f91a6be996a4a3c5ab25e2cdf6b4377e 04:40:05 INFO - mozversion application_display_name: Nightly 04:40:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:40:05 INFO - mozversion application_name: Firefox 04:40:05 INFO - mozversion application_remotingname: firefox 04:40:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:40:05 INFO - mozversion application_vendor: Mozilla 04:40:05 INFO - mozversion application_version: 55.0a1 04:40:05 INFO - mozversion platform_buildid: 20170419025621 04:40:05 INFO - mozversion platform_changeset: c0ea5ed7f91a6be996a4a3c5ab25e2cdf6b4377e 04:40:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:40:05 INFO - mozversion platform_version: 55.0a1 04:40:05 INFO - using testdate: 1492602005 04:40:05 INFO - actual date: 1492602005 04:40:05 INFO - starting webserver on 'localhost:49242' 04:40:05 INFO - SUITE-START | Running 2 tests 04:40:05 INFO - TEST-START | dromaeo_css 04:40:05 INFO - operating with platform_type : mac_ 04:40:05 INFO - Initialising browser for dromaeo_css test... 04:40:05 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmpTqviqc/profile http://localhost:49242/getInfo.html) 04:40:08 INFO - PID 1634 | 2017-04-19 04:40:08.679 plugin-container[1636:7591] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x904b, name = 'com.apple.tsm.portname' 04:40:08 INFO - PID 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:40:08 INFO - PID 1634 | 2017-04-19 04:40:08.681 plugin-container[1636:7591] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950f, name = 'com.apple.CFPasteboardClient' 04:40:08 INFO - PID 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:40:08 INFO - PID 1634 | 2017-04-19 04:40:08.681 plugin-container[1636:7591] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:40:08 INFO - PID 1634 | __metrics Screen width/height:1600/1200 04:40:08 INFO - PID 1634 | colorDepth:24 04:40:08 INFO - PID 1634 | Browser inner width/height: 1024/689 04:40:08 INFO - PID 1634 | __metrics 04:40:08 ERROR - PID 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3385: TypeError: this.tabs is undefined 04:40:09 INFO - TEST-INFO | 1634: exit 0 04:40:09 INFO - Browser initialized. 04:40:09 INFO - Running cycle 1/1 for dromaeo_css test... 04:40:09 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmpTqviqc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:12 INFO - PID 1637 | 2017-04-19 04:40:12.364 plugin-container[1638:7724] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 04:40:12 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:40:12 INFO - PID 1637 | 2017-04-19 04:40:12.365 plugin-container[1638:7724] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4717, name = 'com.apple.CFPasteboardClient' 04:40:12 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:40:12 INFO - PID 1637 | 2017-04-19 04:40:12.365 plugin-container[1638:7724] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:40:22 INFO - PID 1637 | RSS: Main: 235970560 04:40:22 INFO - PID 1637 | 04:43:26 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 04:43:28 INFO - PID 1637 | RSS: Main: 254984192 04:43:28 INFO - PID 1637 | 04:45:10 INFO - PID 1637 | ************************* 04:45:10 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 04:45:10 INFO - PID 1637 | 04:45:10 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:45:10 INFO - PID 1637 | Full stack: 04:45:10 INFO - PID 1637 | ************************* 04:45:10 INFO - PID 1637 | ************************* 04:45:10 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 04:45:10 INFO - PID 1637 | 04:45:10 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:45:10 INFO - PID 1637 | Full stack: 04:45:10 INFO - PID 1637 | ************************* 04:45:10 INFO - PID 1637 | ************************* 04:45:10 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 04:45:10 INFO - PID 1637 | 04:45:10 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:45:10 INFO - PID 1637 | Full stack: 04:45:10 INFO - PID 1637 | ************************* 04:45:10 INFO - PID 1637 | ************************* 04:45:10 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 04:45:10 INFO - PID 1637 | 04:45:10 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:45:10 INFO - PID 1637 | Full stack: 04:45:10 INFO - PID 1637 | ************************* 04:46:30 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 04:46:31 INFO - PID 1637 | RSS: Main: 259878912 04:46:31 INFO - PID 1637 | 04:49:32 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 04:49:33 INFO - PID 1637 | RSS: Main: 268767232 04:49:33 INFO - PID 1637 | 04:52:35 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 04:52:36 INFO - PID 1637 | RSS: Main: 262234112 04:52:36 INFO - PID 1637 | 04:55:39 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 04:55:39 INFO - PID 1637 | RSS: Main: 271495168 04:55:39 INFO - PID 1637 | 04:58:41 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 04:58:41 INFO - PID 1637 | RSS: Main: 266264576 04:58:41 INFO - PID 1637 | 04:58:41 INFO - PID 1637 | __start_tp_report 04:58:41 INFO - PID 1637 | _x_x_mozilla_page_load 04:58:41 INFO - PID 1637 | _x_x_mozilla_page_load_details 04:58:41 INFO - PID 1637 | |i|pagename|runs| 04:58:41 INFO - PID 1637 | |0;dojo.html;2926.9560956585656;3610.5667319921613;3620.565532136144;3630.528031355924;3645.963540364597;6055;6215.160953271307;6216.627002379854;6238.688065596713;6268.122462855204;6154.969225153868;6163.969180154104;6242.9687851560675;6267.0286105653695;6280.6859657017085;5408.783648654059;5442.374126975409;5475.315585551806;5534.363548191969;5572.442755724435;5338.092524270884;5376.91934620981;5520.503154716075;5524.972375138119;5579.609427340088;5372.140457526777;5467.17992301154;5488.506034456918;5517.310336207974;5521.282233309684;5389.191621256804;5391.487808658171;5474.37044739856;5476.835694929158;5501.9174712379345;4454.5990860822685;4877.756112194376;5288.735563221823;5405.567554595662;5415.9458405415835;4474.284114541658;4898.902021959577;6119.563485741598;6243.87512249757;6246.875062498724;6589.93410065898;6636.867262654768;6676.799696009128;6678.966605166992;6685.4985876059;6496.902546461807;6735.93264067358;6740.460763138986;6743.460523158135;6747.257801641816;5388.973055134738;6111.166351794787;6343.55595108338;6346.9682651586445;6360.459360954324;6670.466362690973;6820.283870193558;6907.412869906114;6935.167779866449;6939.861202776017;5642.589352661835;5770.24986751728;6224.159738435344;6349.682515874188;6435.581687190318;5541.390447050821;6644.202695676549;6697.966510167418;6722.327767223239;6735.158105236846;6309.211348581427;6585.440237579859;6621.271660117383;6644.800655980328;6678.065070890079;5548.528375088082;6253.78111766086;6543.869122617616;6586.538942274091;6620.437262832713;5292.629515933848;5304.549113325334;5309.150535914312;5317.388500322435;5321.547668448148;4723.976380118146;4727.692699974491;4740.95259047412;4762.14281429346;4770.713757174581;5203.453637368098;6213.409726076015;6278.277998030194;6313.147725057059;6331.5251356147555;6712.060311556288;6737.9326206737305;6750.662466876636;6761.898571521431;6771.966140169267;5587.217789509472;6249.750009999549;6252.062190671436;6270.996640537492;6305.306416294204;5703.8859222816145;5780.21967034445;5866.12008198765;5877.324107727666;5890.793822216202;6918.204406493217;6961.164660240601;6971.2331643518155;6972.372486476242;6977.511574189961;6673.866522669422;6770.2891196425635;6776.559523630948;6786.660666966731;6817.284185160685;6587.604743715392;6681.164854393201;6851.07510486078;6899.6205208712;6998.895016574654;6548.377904099103;6598.802035938929;6611.041398997022;6612.768553100618;6622.1722284714415;6540.869182616416;6643.202815662152;6704.262531121671;6716.966415167893;6746.257911629618;5699.772009119754;6311.368863113836;6469.3530646936815;6516.250631177286;6516.771912983023;6464.450521705519;6469.805905822833;6473.190851143607;6484.059811327425;6489.123968264224;6261.029540421242;6368.87262254743;6375.936240637534;6393.776217832354;6422.6467544285515;6240.251169859646;6304.275008374096;6444.709988050456;6484.448821850196;6527.281998980014;6299.181106456132;6336.873262534816;6350.936490635035;6365.713542890674;6374.713137908712 04:58:41 INFO - PID 1637 | |1;ext.html;719.0005891810384;754.6604028187315;817.2562967699391;1175.2478413815154;1246.918950268232;34525.27373631321;36410.45384319237;37646.24707505852;37646.81176594113;37829.81085094574;33892.15269618261;38293.61706382942;38313.23373532527;38346;38362.424563631495;7883.831946214794;8042.356611471068;8438.324934005295;8681.782955426133;8700.564971751388;7017.8596428071405;8207.835843283161;8486.448380855256;8602.956985215065;8625.137486251357;8537.188967048152;8557.700480483185;8614.741557753277;8621.094785047573;8642.351823613222;8563.058063612998;8618.612162452704;8619.138086191362;8619.569021548929;8620.13798620133;8426.705065322745;8434.367422443342;8489.108643592457;8494.532800695959;8507.787305317417;38233.235335293415;38455.80772096122;38473.615263847285;38528;38619.613803862165;3593.1915319053264;3607.4769158472136;3634.1459756957092;3637.1089083174793;3641.745077844552;27655.723442765517;30437.630306636256;31298.061058168292;31303.686963130305;31461;3173.5715678383353;3215.5337476066074;3215.758818088629;3219.6136463624516;3222.1622378181605;248766;251726;274952.62523687456;300830;302333.4883325591;48020;48033.51966480361;48287.03425931462;48306;48425.51574484281;49959.75100622441;50054.74972625114;50075;50161.9967600646;50272.49727502751;14052.437902483991;14117.78823317651;14184;14184.219867907364;14236.359363828653;11469.942650286695;11476.4261786912;11532.769344613062;11536.423178841025;11565.537378504934;13602.659933501742;13709.657258568615;13727.313634318245;13805.792913106312;13957.371918263703;5025.025424235798;5911.201987731687;5958.225430693982;5982.970085149634;6006.63960162383;955.8088382323563;1051.8159322118752;1055.7888422315414;1082.3397727386289;1103.3104309806372;23710.644340334908;24623.261302160965;24886.37784055413;24982.750172498043;25142.497150056897;1054.4780333734698;1071.919606029551;1125.7579620381657;1168.1297433412162;1176.599956014959;12540.81188782169;12711.809322860165;16691.666166676598;16702.49892503227;16739.83260167383;312993;313958;314120;315690;317154;57783.71108144432;57918.4208157913;58115.12827307594;58127.70936145292;58256.41743582595;1308.5681725030906;1472.6760112775173;1531.9770203446958;1536.193498413342;1545.2428310128182;25320;27965.580516292677;29925.700742992292;30358.696413036472;30868.382632347675;34897.651023490456;35601.1099722509;39536.60463395329;39935.60064399319;40048.19903601854;234676;287869;287893;288089;289772;35382.29235415329;37053.81473092725;37401.62598373982;37441.4383784238;37568.62431375761;47312;47811.76094119507;47847.043059139316;47963.28055079107;48166.51833481761;30627.54058689166;31433.685663143075;31838.840805795822;31906;31982.200444989063;31239.906603269686;31768;31904;31918.840405797822;32033.199170020936;38183.42724859185;38280.808595957955;38333.233335333694;38345.4248186283;38403.807980959915;30641.54037689481;31330.68669313278;31549.211269718442;32248.83875580607;32449.35101298008;21975.681459112504;23438.64842027337;23944.281671549186;25076.62385064189;25112.62331065072 04:58:41 INFO - PID 1637 | |2;jquery.html;427.00064099403374;431.54687578043087;433.7137489257089;442.53533789521003;454.41607534318405;21335.039923203472;22015.559688806235;22066.22768203113;23166;23399.649005264935;22041.779582204173;23015;23159.652605210893;23325.416864578394;23438.41403964902;6079.483243924272;6219.53353498486;6460.483161347104;6464.93535064648;6473.284579586413;6197.938020619781;6248;6266.279377871535;6293.40212679797;6298.937010629904;6062.878742425149;6227.097070924736;6244.3755624437645;6254.8123556293385;6299.307076221612;6208.2239720034995;6271.78048768291;6271.87106320862;6278.183836101323;6280.905786413207;4629;5408.188771684278;5517.200005999108;5523.944760552424;5540.168974653794;27380.863095684592;27808.58287125695;27818.582721258994;28411.715882841112;28623;2251.470904337479;2308.2728940383895;2309.572729045132;2317.466982593996;2322.5935461294375;17482.562935926577;17526.824731752647;17748.3788067417;18278.17748201321;18340.633187336178;2154.2352464874903;2195.1548653768255;2196.615592271346;2215.3132528915926;2219.4451387153213;152032.83737300988;154135;154490;159589;159606;10014.79970400588;12785;12833.037522185687;12891.806622900476;12975.610731678065;16370.83629163717;16688.415905443493;16714.492826076184;16733.91633041827;16758.91620541914;7522;7819.960900195462;8627.6980305689;8956.641734330684;9226.40028398152;8592.097829727789;8602.569871506525;8605.139486051345;8766.693165739296;8781.692640757543;7971.800704982422;8199.180081991753;8209.71266005687;8238.176182381834;8272.627731752085;1830.9450716478261;2142.747414480919;2162.0919213930188;2174.3042226487373;2346.976530234676;952.5951470624957;978.8433850584015;983.5918093990914;1011.2264117949775;1036.828923227659;19144.425667230007;20947;21141;21175.15299388038;21497.892510537346;933.9446425539097;1008.8032833597525;1025.026225086171;1029.3669393323053;1041.630221271453;9557;10854.565817367375;11313.377764222882;11331.546738130548;11392.886071139348;552154;553621;558615;564272;574757;126149;127161;129579;130921;131733;1042.968710938673;1237.5730373021293;1240.6340129661771;1241.453760345445;1244.9190802597984;21399.25102621401;22541.77458225397;22792;22878.42803929915;23004.654930175726;55975.60060998508;56086.158707618604;56317.87364252774;56977.430225698874;57122;59899.10151347821;73672;76382.09044773925;77228.61385693036;77485.2251477478;8291.792705182419;8551.572421378782;8614.741557753277;8769.91230087691;9002.86495702578;13751.381187846771;13857.792133118213;13958.860411395755;14304.642383940069;14324.57026289213;9987.750306242402;11453.713657158305;11761.353125578175;11914.642560723192;12009.339486328336;11198.776024479628;11300.378479183724;11349.375784331942;11436.542538298374;11570.88429115698;11986.64040078799;12087.395630218278;12098;12245.87754122483;12250.938745306217;8628.266597339296;8731.912680873364;8733.912660873564;9077.591508382007;9121.726348209564;11692.824607631062;11826.881731182579;11911.463984120908;12095.939520302341;12189.329586872807 04:58:41 INFO - PID 1637 | |3;mootools.html;1213.9438688341143;1406.374163497244;1416.0724725304929;1437.7987081808549;1437.8346490153635;11257.268277561952;11795.351255680946;11804.055675545957;11804.76390472191;12134.271943683385;11627.186096973215;11784.234024788382;11850.525978960832;11850.992665623411;11869.52521899123;2504.6618706474665;2540.5300019496453;2542.872856357184;2552.719200887901;2558.48830233953;2475.8762061896923;2504.8371855829405;2548.936276593091;2550.60465627828;2551;2466.2724496273554;2520.269121954631;2525.684289463817;2527.810414218932;2541.758532939368;2437.0860927152316;2487.6517287579754;2504.261242933339;2528.683914510686;2536.3025168078925;2437.695288088989;2492.7881130103965;2508.397984483729;2549.6175573663913;2550.6556614857127;10810.189235807346;10977;11770.352630605314;12012.279263244232;12052.276863388224;6499.675016249216;6710.396064354231;6721.327867213288;6753.223379311344;6774.5257831951785;4096.897577560555;4318.589733975267;4394.736315821061;4425.446819147606;4459.10817836434;1216.2763155922212;1253.3795771093276;1297.040190259211;1300.8699130087011;1301.531448678475;14777.482788102472;15247.542573722916;16398.180090995404;16488;16617.169141542876;5579.609427340129;5629.4652008059165;5870.882582348329;5871.266091738533;5901.380355062656;9435.339526233234;12204.02367810573;12563.309018003914;12608.684782880318;12621.93689031549;6624.006399040086;6642.501812364092;6647.933520664731;6649.401553860176;6651.201855777338;6114.357992410733;6240.781572644935;6243.531735119885;6265.749370025239;6287.7799277026;4408.7575183365225;4505.414296141481;4510.391097201836;4515.322701594721;4609.00906305146;1295.8315418995471;1320.3068389095802;1320.313437012748;1336.3451908564928;1337.0573745509394;711.4237467651219;811.7199566149669;818.8392507521643;829.5769157729601;829.9418241741828;6274.152989346379;6285.59143655661;6432.421082102634;6465.870682586322;6633.1045308882685;591.3642833953517;604.7732100462326;606.1332294818363;607.4654304212353;608.9725962331705;3585.4980302757635;4129.91740165195;4160.313548264563;4410.580994805488;4513.616342610849;14281.285935703174;14863.405463781544;15348.769768453481;15385.230738463031;15390.3074361654;15039.774403383957;15112.697746045238;15272.236388180547;15284.541463756104;15315.923420382827;8581.871271930926;8672.95663521691;8700.390972631854;8813.779655508535;8833.646654133763;6985.755498557526;6989.8951515726285;7056.15326160864;7181.533200341961;7378.926210737824;11698.532058717896;12716.919061879844;13140.211587304791;13236.933815330862;13542.526011589942;13565.186088834702;13620.591382258548;13751.931240343734;13759.587212383645;13816.792748108988;8443.32453403714;9568.76078098053;9599;9726.46504442234;9877;10577.418241996764;10833;10884.238103332691;10967.396793176453;10993.560257589606;9286.6285348588;9294.302927280345;9320.067993200897;9416.152546270869;9531.904680953101;8996.010438851852;9052.592633331647;9097.77255568616;9174.587143578688;9174.908250917673;8300.335973122257;8332.541710205996;8334.958325208336;8429.831403371776;8457.788555286166;6080.69596520181;6102.359252278447;6201.658908760061;6234.75060997555;6256.374362563707;5830.2129212555765;6115.4190351916495;6200.286966998672;6274.937250627618;6338.841528961812 04:58:41 INFO - PID 1637 | |4;prototype.html;389.46643098954434;394.4556512013421;396.4905096950419;398.3944404505152;399.23347173427015;5858.970705146468;6095.451409373156;6143.600665956709;6161.8767624647535;6162.537809664282;4955.058538877611;5336.91994620081;5479.6164268501225;5698.43847595253;5836.5914385993;3377.6960073593373;4553.704009239405;4564.269716845305;4597.264437689971;4612.677112602119;4100.036491424513;4578.702384345007;4594.9431630724785;4598.885027874297;4628.514006029369;3510.8244587770637;3770.302494038598;4362.411074504948;4376.431063961681;4545.090981803636;3302.5871766029245;3909.3354129798004;3925.2738243424915;4185.623293903533;4495.617872480843;2981.7316441520366;3463.0649724574478;3490.4240800267926;3942.6254505821903;4026.7583944963394;4878.731669758162;5249.921251181236;5943.108533719934;5948.167256584082;5978.432048955386;4762.976185119052;5317.962997215544;5339.252504649352;5354.625176237665;5395.352557693062;6507.6420796856155;6545.312742162052;6546.541742078009;6563.4092931635905;6577.342265773432;4139.8965025874295;4313.698041137121;4376.40918476008;4378.540253273392;4409.184300904343;6008.008678568031;6674.3325667433355;6692.196936367618;6795.946628272576;6825.761098361583;3820.083180036771;3880.9133442636107;4045.5145382554283;4337.783110844508;4442.755648439367;4495.865124046284;4508.774561271924;4520.954790452053;4528.841490547881;4535.092981403733;4177.498700156001;5287.894242115213;5331.280277162534;5378.838634840961;5414.242006119146;5704.572157088235;6519.674016299166;6534.183227096613;6548.69026194763;6569.80290591283;1309.3911331230834;1352.6618345413647;1424.423108641002;1554.8833837462237;1555.9066456012677;890.6481939633809;968.9335101344925;1011.1001208924064;1020.831562792131;1026.3021145621049;5207.9063396687125;5820.738066787005;6221.222347206599;6296.205581409276;6308.022256550242;6111.54163437744;6738.854394752904;6763.560368576027;6807.795766127024;6864.931350686529;5848.941510584839;5993.790217342372;6188.977164842798;6190;6198.721057552421;3474.530938323294;3528.788272703646;3540.221151346751;3543.805090720035;3547.379208638478;6091.51267898567;6677;6693.464522838161;6926;6959.721611135599;5696.003199440164;5924.466797988115;6902.827429314308;6965.477589180831;7034.366906978396;5082.517160869711;6043.456088952015;6768.627725475146;6775.593464392152;7072.434205263567;5642.899634571383;6710.328967103251;6726.535834045569;6792.76225332111;6830.282820303796;6425.485961123192;6535.3137920517665;6616.636085015178;6686.5653732507235;6720.68946555417;6022.019100545258;6241.719122639583;6886.380225779704;7001.36987671112;7038.472114591324;3932.80335983194;4431.512533621363;4463.928657122332;4472.530384309601;4495.932561011522;5132.30713853625;6546.770863019962;6671.498188179433;6685.732570697118;6710.563813352116;6129.233845769279;6246.063720246738;6496;6517.641529715722;6597.4392176663605;4959.60323174138;5595.328560572757;6204.852102361077;6422.26143993428;6551.558657095431;5832.445917637818;6353.823088455772;6358.1734374531015;6373.968130159319;6420.6147631142285;5720.2849643794525;6245.937540624535;6405.391487808651;6499.5775274607;6507.527139686888;5792.3049234090495;6078.6048906820915;6199.884020876286;6325.703230837576;6384.233891932998 04:58:41 INFO - PID 1637 | |5;yui.html;832.6586099699125;847.7033038436547;849.8852654891591;867.7266661001784;873.6374404622084;16068.27692753826;16490.91754541227;16538.751918721227;18258.634827303445;18819.623607527843;17636.735448968277;17993.37023204188;18075.27698892046;18157.546061348472;18344.881370167102;968.8498282766183;998.4608311511811;998.5606333213399;998.7503124218945;1000.7147962830595;811.5293129984594;832.8667413213886;991.0386924683046;994.0357852882693;994.0804755601076;1022.734089136826;1040.8490768838515;1057.4342726641248;1058.142904247562;1060.984085238722;1020.1991436722175;1036.098594223031;1053.7945100705365;1053.9104176145038;1056.6935588679273;732.8131326511759;742.2874040920723;753.4989232160607;761.8933349331098;776.1113525013827;13878.583642490741;16954.915225423792;16957.49127526176;16962.151892405454;17099;16414.015159090373;16814;17060.146992650443;17135.314587416487;17161.485155445356;13809.723805523834;13909.956753243547;14074.014818962676;14140.222287774168;14152.36314365856;3521.5421995140723;3561.056320075182;3568.072301201706;3585;3586.1751797086554;98459.50770246104;106074;114745.42627286894;123619;124681.75318246792;13193.538226162038;13508.392122354519;13509.66225844342;13511.256880871646;13519.256440895846;23944.042238310274;24365.390865228157;24775.25674229776;24949.5010099797;25047.12335068264;7606.923930760732;7802.68789248435;7823;7860.135385107748;7863.13505514393;3760.041189496661;3802.543694756647;3856.768593884376;3882.7087968402484;3898.317794385971;4239.47006624172;4368.563143685606;4387.802548885308;4393.0994146199955;4403.603675669141;915.4049867586123;940.8682784410188;942.6936245720168;956.8421210500329;958.5973890965811;531.7394476706386;600.8793599936088;606.8348770360917;616.8858761129205;642.7782415066795;10561.155107591374;10942.069924056384;11191.32852028881;11923.165378423428;11951.701207469883;528.7673423693562;633.4932054356589;636.9745210191633;656.5601047298321;680.3944489404435;5390;5463.535599474009;5507.5593952483705;5522.696251706115;5608.9439105609235;101250.4937475308;102043.4897825521;102345.46481802779;103037.84810759433;104909.47545262225;91200.54399728091;91346.54326728324;92151.53924230336;93005;93119;78107;79263.60368198121;79789;79885.60057199793;80207.59896200482;11046.944765276443;11380.089592832388;11396.430178490877;11413.258138220988;11499.674771719698;43404.565954340054;44148.89627759332;44408;44670.77664611656;44783.55216447794;54680.17979730228;55505.72247138739;55959.88080238291;56241.71879140578;57289;14126.223057731924;14305.141691498544;14316.28418579046;14377.137371757728;14404.351804169048;15286.388544458097;15682;15774.68450630958;15827.920860395625;15844.128572928139;14525.78211326852;14581.781273281122;14644.926775366055;14646.853531464974;14786.482473113389;16538.33846646169;17164.141792910556;17242.655146897243;17376;17381.56546086358;15118.848811511743;16269.837301626832;16707;16714.16429178512;16715.99704017763;11275.605353812578;11397.430128493708;11727.76544469123;12114.75770484603;12176;12681.93659031699;12731.427085781348;13295.401706923405;13943.790843137158;14063.648408789453 04:58:41 INFO - PID 1637 | __end_tp_report 04:58:41 INFO - PID 1637 | __start_cc_report 04:58:41 INFO - PID 1637 | _x_x_mozilla_cycle_collect,420 04:58:41 INFO - PID 1637 | __end_cc_report 04:58:41 INFO - PID 1637 | __startTimestamp1492603121626__endTimestamp 04:58:41 INFO - PID 1637 | 04:58:41 INFO - PID 1637 | ------- Summary: start ------- 04:58:41 INFO - PID 1637 | Number of tests: 6 04:58:41 INFO - PID 1637 | 04:58:41 INFO - PID 1637 | [#0] dojo.html Cycles:165 Average:6082.49 Median:6311.37 stddev:757.84 (12.0%) stddev-sans-first:718.60 04:58:41 INFO - PID 1637 | Values: 2927.0 3610.6 3620.6 3630.5 3646.0 6055.0 6215.2 6216.6 6238.7 6268.1 6155.0 6164.0 6243.0 6267.0 6280.7 5408.8 5442.4 5475.3 5534.4 5572.4 5338.1 5376.9 5520.5 5525.0 5579.6 5372.1 5467.2 5488.5 5517.3 5521.3 5389.2 5391.5 5474.4 5476.8 5501.9 4454.6 4877.8 5288.7 5405.6 5415.9 4474.3 4898.9 6119.6 6243.9 6246.9 6589.9 6636.9 6676.8 6679.0 6685.5 6496.9 6735.9 6740.5 6743.5 6747.3 5389.0 6111.2 6343.6 6347.0 6360.5 6670.5 6820.3 6907.4 6935.2 6939.9 5642.6 5770.2 6224.2 6349.7 6435.6 5541.4 6644.2 6698.0 6722.3 6735.2 6309.2 6585.4 6621.3 6644.8 6678.1 5548.5 6253.8 6543.9 6586.5 6620.4 5292.6 5304.5 5309.2 5317.4 5321.5 4724.0 4727.7 4741.0 4762.1 4770.7 5203.5 6213.4 6278.3 6313.1 6331.5 6712.1 6737.9 6750.7 6761.9 6772.0 5587.2 6249.8 6252.1 6271.0 6305.3 5703.9 5780.2 5866.1 5877.3 5890.8 6918.2 6961.2 6971.2 6972.4 6977.5 6673.9 6770.3 6776.6 6786.7 6817.3 6587.6 6681.2 6851.1 6899.6 6998.9 6548.4 6598.8 6611.0 6612.8 6622.2 6540.9 6643.2 6704.3 6717.0 6746.3 5699.8 6311.4 6469.4 6516.3 6516.8 6464.5 6469.8 6473.2 6484.1 6489.1 6261.0 6368.9 6375.9 6393.8 6422.6 6240.3 6304.3 6444.7 6484.4 6527.3 6299.2 6336.9 6350.9 6365.7 6374.7 04:58:41 INFO - PID 1637 | 04:58:41 INFO - PID 1637 | [#1] ext.html Cycles:180 Average:44864.81 Median:33170.75 stddev:76018.46 (229.2%) stddev-sans-first:76159.45 04:58:41 INFO - PID 1637 | Values: 719.0 754.7 817.3 1175.2 1246.9 34525.3 36410.5 37646.2 37646.8 37829.8 33892.2 38293.6 38313.2 38346.0 38362.4 7883.8 8042.4 8438.3 8681.8 8700.6 7017.9 8207.8 8486.4 8603.0 8625.1 8537.2 8557.7 8614.7 8621.1 8642.4 8563.1 8618.6 8619.1 8619.6 8620.1 8426.7 8434.4 8489.1 8494.5 8507.8 38233.2 38455.8 38473.6 38528.0 38619.6 3593.2 3607.5 3634.1 3637.1 3641.7 27655.7 30437.6 31298.1 31303.7 31461.0 3173.6 3215.5 3215.8 3219.6 3222.2 248766.0 251726.0 274952.6 300830.0 302333.5 48020.0 48033.5 48287.0 48306.0 48425.5 49959.8 50054.7 50075.0 50162.0 50272.5 14052.4 14117.8 14184.0 14184.2 14236.4 11469.9 11476.4 11532.8 11536.4 11565.5 13602.7 13709.7 13727.3 13805.8 13957.4 5025.0 5911.2 5958.2 5983.0 6006.6 955.8 1051.8 1055.8 1082.3 1103.3 23710.6 24623.3 24886.4 24982.8 25142.5 1054.5 1071.9 1125.8 1168.1 1176.6 12540.8 12711.8 16691.7 16702.5 16739.8 312993.0 313958.0 314120.0 315690.0 317154.0 57783.7 57918.4 58115.1 58127.7 58256.4 1308.6 1472.7 1532.0 1536.2 1545.2 25320.0 27965.6 29925.7 30358.7 30868.4 34897.7 35601.1 39536.6 39935.6 40048.2 234676.0 287869.0 287893.0 288089.0 289772.0 35382.3 37053.8 37401.6 37441.4 37568.6 47312.0 47811.8 47847.0 47963.3 48166.5 30627.5 31433.7 31838.8 31906.0 31982.2 31239.9 31768.0 31904.0 31918.8 32033.2 38183.4 38280.8 38333.2 38345.4 38403.8 30641.5 31330.7 31549.2 32248.8 32449.4 21975.7 23438.6 23944.3 25076.6 25112.6 04:58:41 INFO - PID 1637 | 04:58:41 INFO - PID 1637 | [#2] jquery.html Cycles:180 Average:35944.05 Median:12734.61 stddev:94902.42 (745.2%) stddev-sans-first:95131.18 04:58:41 INFO - PID 1637 | Values: 427.0 431.5 433.7 442.5 454.4 21335.0 22015.6 22066.2 23166.0 23399.6 22041.8 23015.0 23159.7 23325.4 23438.4 6079.5 6219.5 6460.5 6464.9 6473.3 6197.9 6248.0 6266.3 6293.4 6298.9 6062.9 6227.1 6244.4 6254.8 6299.3 6208.2 6271.8 6271.9 6278.2 6280.9 4629.0 5408.2 5517.2 5523.9 5540.2 27380.9 27808.6 27818.6 28411.7 28623.0 2251.5 2308.3 2309.6 2317.5 2322.6 17482.6 17526.8 17748.4 18278.2 18340.6 2154.2 2195.2 2196.6 2215.3 2219.4 152032.8 154135.0 154490.0 159589.0 159606.0 10014.8 12785.0 12833.0 12891.8 12975.6 16370.8 16688.4 16714.5 16733.9 16758.9 7522.0 7820.0 8627.7 8956.6 9226.4 8592.1 8602.6 8605.1 8766.7 8781.7 7971.8 8199.2 8209.7 8238.2 8272.6 1830.9 2142.7 2162.1 2174.3 2347.0 952.6 978.8 983.6 1011.2 1036.8 19144.4 20947.0 21141.0 21175.2 21497.9 933.9 1008.8 1025.0 1029.4 1041.6 9557.0 10854.6 11313.4 11331.5 11392.9 552154.0 553621.0 558615.0 564272.0 574757.0 126149.0 127161.0 129579.0 130921.0 131733.0 1043.0 1237.6 1240.6 1241.5 1244.9 21399.3 22541.8 22792.0 22878.4 23004.7 55975.6 56086.2 56317.9 56977.4 57122.0 59899.1 73672.0 76382.1 77228.6 77485.2 8291.8 8551.6 8614.7 8769.9 9002.9 13751.4 13857.8 13958.9 14304.6 14324.6 9987.8 11453.7 11761.4 11914.6 12009.3 11198.8 11300.4 11349.4 11436.5 11570.9 11986.6 12087.4 12098.0 12245.9 12250.9 8628.3 8731.9 8733.9 9077.6 9121.7 11692.8 11826.9 11911.5 12095.9 12189.3 04:58:41 INFO - PID 1637 | 04:58:41 INFO - PID 1637 | [#3] mootools.html Cycles:180 Average:7159.32 Median:4113.41 stddev:4487.85 (109.1%) stddev-sans-first:4478.20 04:58:41 INFO - PID 1637 | Values: 1213.9 1406.4 1416.1 1437.8 1437.8 11257.3 11795.4 11804.1 11804.8 12134.3 11627.2 11784.2 11850.5 11851.0 11869.5 2504.7 2540.5 2542.9 2552.7 2558.5 2475.9 2504.8 2548.9 2550.6 2551.0 2466.3 2520.3 2525.7 2527.8 2541.8 2437.1 2487.7 2504.3 2528.7 2536.3 2437.7 2492.8 2508.4 2549.6 2550.7 10810.2 10977.0 11770.4 12012.3 12052.3 6499.7 6710.4 6721.3 6753.2 6774.5 4096.9 4318.6 4394.7 4425.4 4459.1 1216.3 1253.4 1297.0 1300.9 1301.5 14777.5 15247.5 16398.2 16488.0 16617.2 5579.6 5629.5 5870.9 5871.3 5901.4 9435.3 12204.0 12563.3 12608.7 12621.9 6624.0 6642.5 6647.9 6649.4 6651.2 6114.4 6240.8 6243.5 6265.7 6287.8 4408.8 4505.4 4510.4 4515.3 4609.0 1295.8 1320.3 1320.3 1336.3 1337.1 711.4 811.7 818.8 829.6 829.9 6274.2 6285.6 6432.4 6465.9 6633.1 591.4 604.8 606.1 607.5 609.0 3585.5 4129.9 4160.3 4410.6 4513.6 14281.3 14863.4 15348.8 15385.2 15390.3 15039.8 15112.7 15272.2 15284.5 15315.9 8581.9 8673.0 8700.4 8813.8 8833.6 6985.8 6989.9 7056.2 7181.5 7378.9 11698.5 12716.9 13140.2 13236.9 13542.5 13565.2 13620.6 13751.9 13759.6 13816.8 8443.3 9568.8 9599.0 9726.5 9877.0 10577.4 10833.0 10884.2 10967.4 10993.6 9286.6 9294.3 9320.1 9416.2 9531.9 8996.0 9052.6 9097.8 9174.6 9174.9 8300.3 8332.5 8335.0 8429.8 8457.8 6080.7 6102.4 6201.7 6234.8 6256.4 5830.2 6115.4 6200.3 6274.9 6338.8 04:58:41 INFO - PID 1637 | 04:58:41 INFO - PID 1637 | [#4] prototype.html Cycles:180 Average:5182.62 Median:5834.52 stddev:1661.93 (28.5%) stddev-sans-first:1627.18 04:58:41 INFO - PID 1637 | Values: 389.5 394.5 396.5 398.4 399.2 5859.0 6095.5 6143.6 6161.9 6162.5 4955.1 5336.9 5479.6 5698.4 5836.6 3377.7 4553.7 4564.3 4597.3 4612.7 4100.0 4578.7 4594.9 4598.9 4628.5 3510.8 3770.3 4362.4 4376.4 4545.1 3302.6 3909.3 3925.3 4185.6 4495.6 2981.7 3463.1 3490.4 3942.6 4026.8 4878.7 5249.9 5943.1 5948.2 5978.4 4763.0 5318.0 5339.3 5354.6 5395.4 6507.6 6545.3 6546.5 6563.4 6577.3 4139.9 4313.7 4376.4 4378.5 4409.2 6008.0 6674.3 6692.2 6795.9 6825.8 3820.1 3880.9 4045.5 4337.8 4442.8 4495.9 4508.8 4521.0 4528.8 4535.1 4177.5 5287.9 5331.3 5378.8 5414.2 5704.6 6519.7 6534.2 6548.7 6569.8 1309.4 1352.7 1424.4 1554.9 1555.9 890.6 968.9 1011.1 1020.8 1026.3 5207.9 5820.7 6221.2 6296.2 6308.0 6111.5 6738.9 6763.6 6807.8 6864.9 5848.9 5993.8 6189.0 6190.0 6198.7 3474.5 3528.8 3540.2 3543.8 3547.4 6091.5 6677.0 6693.5 6926.0 6959.7 5696.0 5924.5 6902.8 6965.5 7034.4 5082.5 6043.5 6768.6 6775.6 7072.4 5642.9 6710.3 6726.5 6792.8 6830.3 6425.5 6535.3 6616.6 6686.6 6720.7 6022.0 6241.7 6886.4 7001.4 7038.5 3932.8 4431.5 4463.9 4472.5 4495.9 5132.3 6546.8 6671.5 6685.7 6710.6 6129.2 6246.1 6496.0 6517.6 6597.4 4959.6 5595.3 6204.9 6422.3 6551.6 5832.4 6353.8 6358.2 6374.0 6420.6 5720.3 6245.9 6405.4 6499.6 6507.5 5792.3 6078.6 6199.9 6325.7 6384.2 04:58:41 INFO - PID 1637 | 04:58:41 INFO - PID 1637 | [#5] yui.html Cycles:180 Average:21315.77 Median:18116.41 stddev:29515.57 (162.9%) stddev-sans-first:29558.30 04:58:41 INFO - PID 1637 | Values: 832.7 847.7 849.9 867.7 873.6 16068.3 16490.9 16538.8 18258.6 18819.6 17636.7 17993.4 18075.3 18157.5 18344.9 968.8 998.5 998.6 998.8 1000.7 811.5 832.9 991.0 994.0 994.1 1022.7 1040.8 1057.4 1058.1 1061.0 1020.2 1036.1 1053.8 1053.9 1056.7 732.8 742.3 753.5 761.9 776.1 13878.6 16954.9 16957.5 16962.2 17099.0 16414.0 16814.0 17060.1 17135.3 17161.5 13809.7 13910.0 14074.0 14140.2 14152.4 3521.5 3561.1 3568.1 3585.0 3586.2 98459.5 106074.0 114745.4 123619.0 124681.8 13193.5 13508.4 13509.7 13511.3 13519.3 23944.0 24365.4 24775.3 24949.5 25047.1 7606.9 7802.7 7823.0 7860.1 7863.1 3760.0 3802.5 3856.8 3882.7 3898.3 4239.5 4368.6 4387.8 4393.1 4403.6 915.4 940.9 942.7 956.8 958.6 531.7 600.9 606.8 616.9 642.8 10561.2 10942.1 11191.3 11923.2 11951.7 528.8 633.5 637.0 656.6 680.4 5390.0 5463.5 5507.6 5522.7 5608.9 101250.5 102043.5 102345.5 103037.8 104909.5 91200.5 91346.5 92151.5 93005.0 93119.0 78107.0 79263.6 79789.0 79885.6 80207.6 11046.9 11380.1 11396.4 11413.3 11499.7 43404.6 44148.9 44408.0 44670.8 44783.6 54680.2 55505.7 55959.9 56241.7 57289.0 14126.2 14305.1 14316.3 14377.1 14404.4 15286.4 15682.0 15774.7 15827.9 15844.1 14525.8 14581.8 14644.9 14646.9 14786.5 16538.3 17164.1 17242.7 17376.0 17381.6 15118.8 16269.8 16707.0 16714.2 16716.0 11275.6 11397.4 11727.8 12114.8 12176.0 12681.9 12731.4 13295.4 13943.8 14063.6 04:58:41 INFO - PID 1637 | -------- Summary: end -------- 04:58:41 INFO - PID 1637 | 04:58:42 INFO - TEST-INFO | 1637: exit 0 04:58:42 INFO - TEST-OK | dromaeo_css | took 1116566ms 04:58:42 INFO - TEST-START | kraken 04:58:42 INFO - operating with platform_type : mac_ 04:58:42 INFO - Initialising browser for kraken test... 04:58:42 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmpUxgeqv/profile http://localhost:49242/getInfo.html) 04:58:45 INFO - PID 1650 | 2017-04-19 04:58:45.084 plugin-container[1651:10185] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 04:58:45 INFO - PID 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:58:45 INFO - PID 1650 | 2017-04-19 04:58:45.087 plugin-container[1651:10185] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 04:58:45 INFO - PID 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:58:45 INFO - PID 1650 | 2017-04-19 04:58:45.087 plugin-container[1651:10185] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:58:45 INFO - PID 1650 | __metrics Screen width/height:1600/1200 04:58:45 INFO - PID 1650 | colorDepth:24 04:58:45 INFO - PID 1650 | Browser inner width/height: 1024/689 04:58:45 INFO - PID 1650 | __metrics 04:58:45 ERROR - PID 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3385: TypeError: this.tabs is undefined 04:58:46 INFO - TEST-INFO | 1650: exit 0 04:58:46 INFO - Browser initialized. 04:58:46 INFO - Running cycle 1/1 for kraken test... 04:58:46 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmpUxgeqv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:58:48 INFO - PID 1652 | 2017-04-19 04:58:48.533 plugin-container[1653:10313] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c47, name = 'com.apple.tsm.portname' 04:58:48 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:58:48 INFO - PID 1652 | 2017-04-19 04:58:48.534 plugin-container[1653:10313] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900f, name = 'com.apple.CFPasteboardClient' 04:58:48 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:58:48 INFO - PID 1652 | 2017-04-19 04:58:48.534 plugin-container[1653:10313] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:58:58 INFO - PID 1652 | RSS: Main: 234913792 04:58:58 INFO - PID 1652 | 04:59:01 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 04:59:02 INFO - PID 1652 | RSS: Main: 248143872 04:59:02 INFO - PID 1652 | 04:59:04 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 04:59:05 INFO - PID 1652 | RSS: Main: 256454656 04:59:05 INFO - PID 1652 | 04:59:08 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 04:59:09 INFO - PID 1652 | RSS: Main: 259260416 04:59:09 INFO - PID 1652 | 04:59:11 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 04:59:12 INFO - PID 1652 | RSS: Main: 261554176 04:59:12 INFO - PID 1652 | 04:59:14 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:59:14 INFO - PID 1652 | RSS: Main: 261517312 04:59:14 INFO - PID 1652 | 04:59:18 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 04:59:18 INFO - PID 1652 | RSS: Main: 267022336 04:59:18 INFO - PID 1652 | 04:59:21 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 04:59:22 INFO - PID 1652 | RSS: Main: 268292096 04:59:22 INFO - PID 1652 | 04:59:25 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 04:59:25 INFO - PID 1652 | RSS: Main: 268271616 04:59:25 INFO - PID 1652 | 04:59:27 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:59:27 INFO - PID 1652 | RSS: Main: 267902976 04:59:27 INFO - PID 1652 | 04:59:29 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:59:30 INFO - PID 1652 | RSS: Main: 268197888 04:59:30 INFO - PID 1652 | 04:59:32 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:59:33 INFO - PID 1652 | RSS: Main: 267882496 04:59:33 INFO - PID 1652 | 04:59:36 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:59:37 INFO - PID 1652 | RSS: Main: 268185600 04:59:37 INFO - PID 1652 | 04:59:40 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:59:40 INFO - PID 1652 | RSS: Main: 267993088 04:59:40 INFO - PID 1652 | 04:59:42 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 04:59:42 INFO - PID 1652 | RSS: Main: 269475840 04:59:42 INFO - PID 1652 | 04:59:42 INFO - PID 1652 | __start_tp_report 04:59:42 INFO - PID 1652 | _x_x_mozilla_page_load 04:59:42 INFO - PID 1652 | _x_x_mozilla_page_load_details 04:59:42 INFO - PID 1652 | |i|pagename|runs| 04:59:42 INFO - PID 1652 | |0;ai-astar;104;116;116;114;118;115;114;114;137;174 04:59:42 INFO - PID 1652 | |1;audio-beat-detection;147;114;121;148;113;119;135;149;143;112 04:59:42 INFO - PID 1652 | |2;audio-dft;197;205;199;250;294;240;241;275;198;199 04:59:42 INFO - PID 1652 | |3;audio-fft;83;57;62;97;88;88;85;63;80;58 04:59:42 INFO - PID 1652 | |4;audio-oscillator;93;70;84;75;71;70;93;70;73;93 04:59:42 INFO - PID 1652 | |5;imaging-gaussian-blur;116;77;116;135;113;124;135;90;135;134 04:59:42 INFO - PID 1652 | |6;imaging-darkroom;97;98;98;98;97;98;98;98;98;107 04:59:42 INFO - PID 1652 | |7;imaging-desaturate;92;91;91;91;93;91;90;93;90;91 04:59:42 INFO - PID 1652 | |8;json-parse-financial;51;51;50;54;52;51;53;52;50;52 04:59:42 INFO - PID 1652 | |9;json-stringify-tinderbox;56;64;57;58;73;89;84;64;61;61 04:59:42 INFO - PID 1652 | |10;stanford-crypto-aes;85;83;83;83;83;96;83;99;105;107 04:59:42 INFO - PID 1652 | |11;stanford-crypto-ccm;179;158;151;135;152;137;142;161;206;153 04:59:42 INFO - PID 1652 | |12;stanford-crypto-pbkdf2;180;186;184;190;186;188;188;185;185;184 04:59:42 INFO - PID 1652 | |13;stanford-crypto-sha256-iterative;77;87;90;83;69;71;70;68;66;70 04:59:42 INFO - PID 1652 | __end_tp_report 04:59:42 INFO - PID 1652 | __start_cc_report 04:59:42 INFO - PID 1652 | _x_x_mozilla_cycle_collect,1011 04:59:42 INFO - PID 1652 | __end_cc_report 04:59:42 INFO - PID 1652 | __startTimestamp1492603182713__endTimestamp 04:59:42 INFO - PID 1652 | 04:59:42 INFO - PID 1652 | ------- Summary: start ------- 04:59:42 INFO - PID 1652 | Number of tests: 14 04:59:42 INFO - PID 1652 | 04:59:42 INFO - PID 1652 | [#0] ai-astar Cycles:10 Average:122.20 Median:116.00 stddev:19.95 (17.2%) stddev-sans-first:20.04 04:59:42 INFO - PID 1652 | Values: 104.0 116.0 116.0 114.0 118.0 115.0 114.0 114.0 137.0 174.0 04:59:42 INFO - PID 1652 | 04:59:42 INFO - PID 1652 | [#1] audio-beat-detection Cycles:10 Average:130.10 Median:139.00 stddev:15.77 (11.3%) stddev-sans-first:15.50 04:59:42 INFO - PID 1652 | Values: 147.0 114.0 121.0 148.0 113.0 119.0 135.0 149.0 143.0 112.0 04:59:42 INFO - PID 1652 | 04:59:42 INFO - PID 1652 | [#2] audio-dft Cycles:10 Average:229.80 Median:240.50 stddev:35.59 (14.8%) stddev-sans-first:35.72 04:59:42 INFO - PID 1652 | Values: 197.0 205.0 199.0 250.0 294.0 240.0 241.0 275.0 198.0 199.0 04:59:42 INFO - PID 1652 | 04:59:42 INFO - PID 1652 | [#3] audio-fft Cycles:10 Average:76.10 Median:84.00 stddev:14.62 (17.4%) stddev-sans-first:15.30 04:59:42 INFO - PID 1652 | Values: 83.0 57.0 62.0 97.0 88.0 88.0 85.0 63.0 80.0 58.0 04:59:42 INFO - PID 1652 | 04:59:42 INFO - PID 1652 | [#4] audio-oscillator Cycles:10 Average:79.20 Median:79.50 stddev:10.39 (13.1%) stddev-sans-first:9.75 04:59:42 INFO - PID 1652 | Values: 93.0 70.0 84.0 75.0 71.0 70.0 93.0 70.0 73.0 93.0 04:59:42 INFO - PID 1652 | 04:59:42 INFO - PID 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:135.00 stddev:20.15 (14.9%) stddev-sans-first:21.37 04:59:42 INFO - PID 1652 | Values: 116.0 77.0 116.0 135.0 113.0 124.0 135.0 90.0 135.0 134.0 04:59:42 INFO - PID 1652 | 04:59:42 INFO - PID 1652 | [#6] imaging-darkroom Cycles:10 Average:98.70 Median:98.00 stddev:2.95 (3.0%) stddev-sans-first:3.06 04:59:42 INFO - PID 1652 | Values: 97.0 98.0 98.0 98.0 97.0 98.0 98.0 98.0 98.0 107.0 04:59:42 INFO - PID 1652 | 04:59:42 INFO - PID 1652 | [#7] imaging-desaturate Cycles:10 Average:91.30 Median:91.00 stddev:1.06 (1.2%) stddev-sans-first:1.09 04:59:42 INFO - PID 1652 | Values: 92.0 91.0 91.0 91.0 93.0 91.0 90.0 93.0 90.0 91.0 04:59:42 INFO - PID 1652 | 04:59:42 INFO - PID 1652 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:52.00 stddev:1.26 (2.4%) stddev-sans-first:1.32 04:59:42 INFO - PID 1652 | Values: 51.0 51.0 50.0 54.0 52.0 51.0 53.0 52.0 50.0 52.0 04:59:42 INFO - PID 1652 | 04:59:42 INFO - PID 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:64.00 stddev:11.55 (18.0%) stddev-sans-first:11.58 04:59:42 INFO - PID 1652 | Values: 56.0 64.0 57.0 58.0 73.0 89.0 84.0 64.0 61.0 61.0 04:59:42 INFO - PID 1652 | 04:59:42 INFO - PID 1652 | [#10] stanford-crypto-aes Cycles:10 Average:90.70 Median:83.00 stddev:9.98 (12.0%) stddev-sans-first:10.37 04:59:42 INFO - PID 1652 | Values: 85.0 83.0 83.0 83.0 83.0 96.0 83.0 99.0 105.0 107.0 04:59:42 INFO - PID 1652 | 04:59:42 INFO - PID 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:157.40 Median:155.50 stddev:21.31 (13.7%) stddev-sans-first:21.12 04:59:42 INFO - PID 1652 | Values: 179.0 158.0 151.0 135.0 152.0 137.0 142.0 161.0 206.0 153.0 04:59:42 INFO - PID 1652 | 04:59:42 INFO - PID 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.60 Median:186.00 stddev:2.76 (1.5%) stddev-sans-first:2.05 04:59:42 INFO - PID 1652 | Values: 180.0 186.0 184.0 190.0 186.0 188.0 188.0 185.0 185.0 184.0 04:59:42 INFO - PID 1652 | 04:59:42 INFO - PID 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.10 Median:74.00 stddev:8.62 (11.7%) stddev-sans-first:9.12 04:59:42 INFO - PID 1652 | Values: 77.0 87.0 90.0 83.0 69.0 71.0 70.0 68.0 66.0 70.0 04:59:42 INFO - PID 1652 | -------- Summary: end -------- 04:59:42 INFO - PID 1652 | 04:59:43 INFO - TEST-INFO | 1652: exit 0 04:59:43 INFO - TEST-OK | kraken | took 61601ms 04:59:43 INFO - SUITE-END | took 1178s 04:59:44 INFO - Completed test suite (00:19:38) 04:59:44 INFO - javascript benchmark 04:59:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7857.84659784737, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2926.9560956585656, 3610.5667319921613, 3620.565532136144, 3630.528031355924, 3645.963540364597, 6055.0, 6215.160953271307, 6216.627002379854, 6238.688065596713, 6268.122462855204, 6154.969225153868, 6163.969180154104, 6242.9687851560675, 6267.0286105653695, 6280.6859657017085, 5408.783648654059, 5442.374126975409, 5475.315585551806, 5534.363548191969, 5572.442755724435, 5338.092524270884, 5376.91934620981, 5520.503154716075, 5524.972375138119, 5579.609427340088, 5372.140457526777, 5467.17992301154, 5488.506034456918, 5517.310336207974, 5521.282233309684, 5389.191621256804, 5391.487808658171, 5474.37044739856, 5476.835694929158, 5501.9174712379345, 4454.5990860822685, 4877.756112194376, 5288.735563221823, 5405.567554595662, 5415.9458405415835, 4474.284114541658, 4898.902021959577, 6119.563485741598, 6243.87512249757, 6246.875062498724, 6589.93410065898, 6636.867262654768, 6676.799696009128, 6678.966605166992, 6685.4985876059, 6496.902546461807, 6735.93264067358, 6740.460763138986, 6743.460523158135, 6747.257801641816, 5388.973055134738, 6111.166351794787, 6343.55595108338, 6346.9682651586445, 6360.459360954324, 6670.466362690973, 6820.283870193558, 6907.412869906114, 6935.167779866449, 6939.861202776017, 5642.589352661835, 5770.24986751728, 6224.159738435344, 6349.682515874188, 6435.581687190318, 5541.390447050821, 6644.202695676549, 6697.966510167418, 6722.327767223239, 6735.158105236846, 6309.211348581427, 6585.440237579859, 6621.271660117383, 6644.800655980328, 6678.065070890079, 5548.528375088082, 6253.78111766086, 6543.869122617616, 6586.538942274091, 6620.437262832713, 5292.629515933848, 5304.549113325334, 5309.150535914312, 5317.388500322435, 5321.547668448148, 4723.976380118146, 4727.692699974491, 4740.95259047412, 4762.14281429346, 4770.713757174581, 5203.453637368098, 6213.409726076015, 6278.277998030194, 6313.147725057059, 6331.5251356147555, 6712.060311556288, 6737.9326206737305, 6750.662466876636, 6761.898571521431, 6771.966140169267, 5587.217789509472, 6249.750009999549, 6252.062190671436, 6270.996640537492, 6305.306416294204, 5703.8859222816145, 5780.21967034445, 5866.12008198765, 5877.324107727666, 5890.793822216202, 6918.204406493217, 6961.164660240601, 6971.2331643518155, 6972.372486476242, 6977.511574189961, 6673.866522669422, 6770.2891196425635, 6776.559523630948, 6786.660666966731, 6817.284185160685, 6587.604743715392, 6681.164854393201, 6851.07510486078, 6899.6205208712, 6998.895016574654, 6548.377904099103, 6598.802035938929, 6611.041398997022, 6612.768553100618, 6622.1722284714415, 6540.869182616416, 6643.202815662152, 6704.262531121671, 6716.966415167893, 6746.257911629618, 5699.772009119754, 6311.368863113836, 6469.3530646936815, 6516.250631177286, 6516.771912983023, 6464.450521705519, 6469.805905822833, 6473.190851143607, 6484.059811327425, 6489.123968264224, 6261.029540421242, 6368.87262254743, 6375.936240637534, 6393.776217832354, 6422.6467544285515, 6240.251169859646, 6304.275008374096, 6444.709988050456, 6484.448821850196, 6527.281998980014, 6299.181106456132, 6336.873262534816, 6350.936490635035, 6365.713542890674, 6374.713137908712], "value": 6032.625269838995, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.0005891810384, 754.6604028187315, 817.2562967699391, 1175.2478413815154, 1246.918950268232, 34525.27373631321, 36410.45384319237, 37646.24707505852, 37646.81176594113, 37829.81085094574, 33892.15269618261, 38293.61706382942, 38313.23373532527, 38346.0, 38362.424563631495, 7883.831946214794, 8042.356611471068, 8438.324934005295, 8681.782955426133, 8700.564971751388, 7017.8596428071405, 8207.835843283161, 8486.448380855256, 8602.956985215065, 8625.137486251357, 8537.188967048152, 8557.700480483185, 8614.741557753277, 8621.094785047573, 8642.351823613222, 8563.058063612998, 8618.612162452704, 8619.138086191362, 8619.569021548929, 8620.13798620133, 8426.705065322745, 8434.367422443342, 8489.108643592457, 8494.532800695959, 8507.787305317417, 38233.235335293415, 38455.80772096122, 38473.615263847285, 38528.0, 38619.613803862165, 3593.1915319053264, 3607.4769158472136, 3634.1459756957092, 3637.1089083174793, 3641.745077844552, 27655.723442765517, 30437.630306636256, 31298.061058168292, 31303.686963130305, 31461.0, 3173.5715678383353, 3215.5337476066074, 3215.758818088629, 3219.6136463624516, 3222.1622378181605, 248766.0, 251726.0, 274952.62523687456, 300830.0, 302333.4883325591, 48020.0, 48033.51966480361, 48287.03425931462, 48306.0, 48425.51574484281, 49959.75100622441, 50054.74972625114, 50075.0, 50161.9967600646, 50272.49727502751, 14052.437902483991, 14117.78823317651, 14184.0, 14184.219867907364, 14236.359363828653, 11469.942650286695, 11476.4261786912, 11532.769344613062, 11536.423178841025, 11565.537378504934, 13602.659933501742, 13709.657258568615, 13727.313634318245, 13805.792913106312, 13957.371918263703, 5025.025424235798, 5911.201987731687, 5958.225430693982, 5982.970085149634, 6006.63960162383, 955.8088382323563, 1051.8159322118752, 1055.7888422315414, 1082.3397727386289, 1103.3104309806372, 23710.644340334908, 24623.261302160965, 24886.37784055413, 24982.750172498043, 25142.497150056897, 1054.4780333734698, 1071.919606029551, 1125.7579620381657, 1168.1297433412162, 1176.599956014959, 12540.81188782169, 12711.809322860165, 16691.666166676598, 16702.49892503227, 16739.83260167383, 312993.0, 313958.0, 314120.0, 315690.0, 317154.0, 57783.71108144432, 57918.4208157913, 58115.12827307594, 58127.70936145292, 58256.41743582595, 1308.5681725030906, 1472.6760112775173, 1531.9770203446958, 1536.193498413342, 1545.2428310128182, 25320.0, 27965.580516292677, 29925.700742992292, 30358.696413036472, 30868.382632347675, 34897.651023490456, 35601.1099722509, 39536.60463395329, 39935.60064399319, 40048.19903601854, 234676.0, 287869.0, 287893.0, 288089.0, 289772.0, 35382.29235415329, 37053.81473092725, 37401.62598373982, 37441.4383784238, 37568.62431375761, 47312.0, 47811.76094119507, 47847.043059139316, 47963.28055079107, 48166.51833481761, 30627.54058689166, 31433.685663143075, 31838.840805795822, 31906.0, 31982.200444989063, 31239.906603269686, 31768.0, 31904.0, 31918.840405797822, 32033.199170020936, 38183.42724859185, 38280.808595957955, 38333.233335333694, 38345.4248186283, 38403.807980959915, 30641.54037689481, 31330.68669313278, 31549.211269718442, 32248.83875580607, 32449.35101298008, 21975.681459112504, 23438.64842027337, 23944.281671549186, 25076.62385064189, 25112.62331065072], "value": 17878.735583393085, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.00064099403374, 431.54687578043087, 433.7137489257089, 442.53533789521003, 454.41607534318405, 21335.039923203472, 22015.559688806235, 22066.22768203113, 23166.0, 23399.649005264935, 22041.779582204173, 23015.0, 23159.652605210893, 23325.416864578394, 23438.41403964902, 6079.483243924272, 6219.53353498486, 6460.483161347104, 6464.93535064648, 6473.284579586413, 6197.938020619781, 6248.0, 6266.279377871535, 6293.40212679797, 6298.937010629904, 6062.878742425149, 6227.097070924736, 6244.3755624437645, 6254.8123556293385, 6299.307076221612, 6208.2239720034995, 6271.78048768291, 6271.87106320862, 6278.183836101323, 6280.905786413207, 4629.0, 5408.188771684278, 5517.200005999108, 5523.944760552424, 5540.168974653794, 27380.863095684592, 27808.58287125695, 27818.582721258994, 28411.715882841112, 28623.0, 2251.470904337479, 2308.2728940383895, 2309.572729045132, 2317.466982593996, 2322.5935461294375, 17482.562935926577, 17526.824731752647, 17748.3788067417, 18278.17748201321, 18340.633187336178, 2154.2352464874903, 2195.1548653768255, 2196.615592271346, 2215.3132528915926, 2219.4451387153213, 152032.83737300988, 154135.0, 154490.0, 159589.0, 159606.0, 10014.79970400588, 12785.0, 12833.037522185687, 12891.806622900476, 12975.610731678065, 16370.83629163717, 16688.415905443493, 16714.492826076184, 16733.91633041827, 16758.91620541914, 7522.0, 7819.960900195462, 8627.6980305689, 8956.641734330684, 9226.40028398152, 8592.097829727789, 8602.569871506525, 8605.139486051345, 8766.693165739296, 8781.692640757543, 7971.800704982422, 8199.180081991753, 8209.71266005687, 8238.176182381834, 8272.627731752085, 1830.9450716478261, 2142.747414480919, 2162.0919213930188, 2174.3042226487373, 2346.976530234676, 952.5951470624957, 978.8433850584015, 983.5918093990914, 1011.2264117949775, 1036.828923227659, 19144.425667230007, 20947.0, 21141.0, 21175.15299388038, 21497.892510537346, 933.9446425539097, 1008.8032833597525, 1025.026225086171, 1029.3669393323053, 1041.630221271453, 9557.0, 10854.565817367375, 11313.377764222882, 11331.546738130548, 11392.886071139348, 552154.0, 553621.0, 558615.0, 564272.0, 574757.0, 126149.0, 127161.0, 129579.0, 130921.0, 131733.0, 1042.968710938673, 1237.5730373021293, 1240.6340129661771, 1241.453760345445, 1244.9190802597984, 21399.25102621401, 22541.77458225397, 22792.0, 22878.42803929915, 23004.654930175726, 55975.60060998508, 56086.158707618604, 56317.87364252774, 56977.430225698874, 57122.0, 59899.10151347821, 73672.0, 76382.09044773925, 77228.61385693036, 77485.2251477478, 8291.792705182419, 8551.572421378782, 8614.741557753277, 8769.91230087691, 9002.86495702578, 13751.381187846771, 13857.792133118213, 13958.860411395755, 14304.642383940069, 14324.57026289213, 9987.750306242402, 11453.713657158305, 11761.353125578175, 11914.642560723192, 12009.339486328336, 11198.776024479628, 11300.378479183724, 11349.375784331942, 11436.542538298374, 11570.88429115698, 11986.64040078799, 12087.395630218278, 12098.0, 12245.87754122483, 12250.938745306217, 8628.266597339296, 8731.912680873364, 8733.912660873564, 9077.591508382007, 9121.726348209564, 11692.824607631062, 11826.881731182579, 11911.463984120908, 12095.939520302341, 12189.329586872807], "value": 10559.961598641561, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1213.9438688341143, 1406.374163497244, 1416.0724725304929, 1437.7987081808549, 1437.8346490153635, 11257.268277561952, 11795.351255680946, 11804.055675545957, 11804.76390472191, 12134.271943683385, 11627.186096973215, 11784.234024788382, 11850.525978960832, 11850.992665623411, 11869.52521899123, 2504.6618706474665, 2540.5300019496453, 2542.872856357184, 2552.719200887901, 2558.48830233953, 2475.8762061896923, 2504.8371855829405, 2548.936276593091, 2550.60465627828, 2551.0, 2466.2724496273554, 2520.269121954631, 2525.684289463817, 2527.810414218932, 2541.758532939368, 2437.0860927152316, 2487.6517287579754, 2504.261242933339, 2528.683914510686, 2536.3025168078925, 2437.695288088989, 2492.7881130103965, 2508.397984483729, 2549.6175573663913, 2550.6556614857127, 10810.189235807346, 10977.0, 11770.352630605314, 12012.279263244232, 12052.276863388224, 6499.675016249216, 6710.396064354231, 6721.327867213288, 6753.223379311344, 6774.5257831951785, 4096.897577560555, 4318.589733975267, 4394.736315821061, 4425.446819147606, 4459.10817836434, 1216.2763155922212, 1253.3795771093276, 1297.040190259211, 1300.8699130087011, 1301.531448678475, 14777.482788102472, 15247.542573722916, 16398.180090995404, 16488.0, 16617.169141542876, 5579.609427340129, 5629.4652008059165, 5870.882582348329, 5871.266091738533, 5901.380355062656, 9435.339526233234, 12204.02367810573, 12563.309018003914, 12608.684782880318, 12621.93689031549, 6624.006399040086, 6642.501812364092, 6647.933520664731, 6649.401553860176, 6651.201855777338, 6114.357992410733, 6240.781572644935, 6243.531735119885, 6265.749370025239, 6287.7799277026, 4408.7575183365225, 4505.414296141481, 4510.391097201836, 4515.322701594721, 4609.00906305146, 1295.8315418995471, 1320.3068389095802, 1320.313437012748, 1336.3451908564928, 1337.0573745509394, 711.4237467651219, 811.7199566149669, 818.8392507521643, 829.5769157729601, 829.9418241741828, 6274.152989346379, 6285.59143655661, 6432.421082102634, 6465.870682586322, 6633.1045308882685, 591.3642833953517, 604.7732100462326, 606.1332294818363, 607.4654304212353, 608.9725962331705, 3585.4980302757635, 4129.91740165195, 4160.313548264563, 4410.580994805488, 4513.616342610849, 14281.285935703174, 14863.405463781544, 15348.769768453481, 15385.230738463031, 15390.3074361654, 15039.774403383957, 15112.697746045238, 15272.236388180547, 15284.541463756104, 15315.923420382827, 8581.871271930926, 8672.95663521691, 8700.390972631854, 8813.779655508535, 8833.646654133763, 6985.755498557526, 6989.8951515726285, 7056.15326160864, 7181.533200341961, 7378.926210737824, 11698.532058717896, 12716.919061879844, 13140.211587304791, 13236.933815330862, 13542.526011589942, 13565.186088834702, 13620.591382258548, 13751.931240343734, 13759.587212383645, 13816.792748108988, 8443.32453403714, 9568.76078098053, 9599.0, 9726.46504442234, 9877.0, 10577.418241996764, 10833.0, 10884.238103332691, 10967.396793176453, 10993.560257589606, 9286.6285348588, 9294.302927280345, 9320.067993200897, 9416.152546270869, 9531.904680953101, 8996.010438851852, 9052.592633331647, 9097.77255568616, 9174.587143578688, 9174.908250917673, 8300.335973122257, 8332.541710205996, 8334.958325208336, 8429.831403371776, 8457.788555286166, 6080.69596520181, 6102.359252278447, 6201.658908760061, 6234.75060997555, 6256.374362563707, 5830.2129212555765, 6115.4190351916495, 6200.286966998672, 6274.937250627618, 6338.841528961812], "value": 5378.030767961993, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.46643098954434, 394.4556512013421, 396.4905096950419, 398.3944404505152, 399.23347173427015, 5858.970705146468, 6095.451409373156, 6143.600665956709, 6161.8767624647535, 6162.537809664282, 4955.058538877611, 5336.91994620081, 5479.6164268501225, 5698.43847595253, 5836.5914385993, 3377.6960073593373, 4553.704009239405, 4564.269716845305, 4597.264437689971, 4612.677112602119, 4100.036491424513, 4578.702384345007, 4594.9431630724785, 4598.885027874297, 4628.514006029369, 3510.8244587770637, 3770.302494038598, 4362.411074504948, 4376.431063961681, 4545.090981803636, 3302.5871766029245, 3909.3354129798004, 3925.2738243424915, 4185.623293903533, 4495.617872480843, 2981.7316441520366, 3463.0649724574478, 3490.4240800267926, 3942.6254505821903, 4026.7583944963394, 4878.731669758162, 5249.921251181236, 5943.108533719934, 5948.167256584082, 5978.432048955386, 4762.976185119052, 5317.962997215544, 5339.252504649352, 5354.625176237665, 5395.352557693062, 6507.6420796856155, 6545.312742162052, 6546.541742078009, 6563.4092931635905, 6577.342265773432, 4139.8965025874295, 4313.698041137121, 4376.40918476008, 4378.540253273392, 4409.184300904343, 6008.008678568031, 6674.3325667433355, 6692.196936367618, 6795.946628272576, 6825.761098361583, 3820.083180036771, 3880.9133442636107, 4045.5145382554283, 4337.783110844508, 4442.755648439367, 4495.865124046284, 4508.774561271924, 4520.954790452053, 4528.841490547881, 4535.092981403733, 4177.498700156001, 5287.894242115213, 5331.280277162534, 5378.838634840961, 5414.242006119146, 5704.572157088235, 6519.674016299166, 6534.183227096613, 6548.69026194763, 6569.80290591283, 1309.3911331230834, 1352.6618345413647, 1424.423108641002, 1554.8833837462237, 1555.9066456012677, 890.6481939633809, 968.9335101344925, 1011.1001208924064, 1020.831562792131, 1026.3021145621049, 5207.9063396687125, 5820.738066787005, 6221.222347206599, 6296.205581409276, 6308.022256550242, 6111.54163437744, 6738.854394752904, 6763.560368576027, 6807.795766127024, 6864.931350686529, 5848.941510584839, 5993.790217342372, 6188.977164842798, 6190.0, 6198.721057552421, 3474.530938323294, 3528.788272703646, 3540.221151346751, 3543.805090720035, 3547.379208638478, 6091.51267898567, 6677.0, 6693.464522838161, 6926.0, 6959.721611135599, 5696.003199440164, 5924.466797988115, 6902.827429314308, 6965.477589180831, 7034.366906978396, 5082.517160869711, 6043.456088952015, 6768.627725475146, 6775.593464392152, 7072.434205263567, 5642.899634571383, 6710.328967103251, 6726.535834045569, 6792.76225332111, 6830.282820303796, 6425.485961123192, 6535.3137920517665, 6616.636085015178, 6686.5653732507235, 6720.68946555417, 6022.019100545258, 6241.719122639583, 6886.380225779704, 7001.36987671112, 7038.472114591324, 3932.80335983194, 4431.512533621363, 4463.928657122332, 4472.530384309601, 4495.932561011522, 5132.30713853625, 6546.770863019962, 6671.498188179433, 6685.732570697118, 6710.563813352116, 6129.233845769279, 6246.063720246738, 6496.0, 6517.641529715722, 6597.4392176663605, 4959.60323174138, 5595.328560572757, 6204.852102361077, 6422.26143993428, 6551.558657095431, 5832.445917637818, 6353.823088455772, 6358.1734374531015, 6373.968130159319, 6420.6147631142285, 5720.2849643794525, 6245.937540624535, 6405.391487808651, 6499.5775274607, 6507.527139686888, 5792.3049234090495, 6078.6048906820915, 6199.884020876286, 6325.703230837576, 6384.233891932998], "value": 4666.240257082255, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [832.6586099699125, 847.7033038436547, 849.8852654891591, 867.7266661001784, 873.6374404622084, 16068.27692753826, 16490.91754541227, 16538.751918721227, 18258.634827303445, 18819.623607527843, 17636.735448968277, 17993.37023204188, 18075.27698892046, 18157.546061348472, 18344.881370167102, 968.8498282766183, 998.4608311511811, 998.5606333213399, 998.7503124218945, 1000.7147962830595, 811.5293129984594, 832.8667413213886, 991.0386924683046, 994.0357852882693, 994.0804755601076, 1022.734089136826, 1040.8490768838515, 1057.4342726641248, 1058.142904247562, 1060.984085238722, 1020.1991436722175, 1036.098594223031, 1053.7945100705365, 1053.9104176145038, 1056.6935588679273, 732.8131326511759, 742.2874040920723, 753.4989232160607, 761.8933349331098, 776.1113525013827, 13878.583642490741, 16954.915225423792, 16957.49127526176, 16962.151892405454, 17099.0, 16414.015159090373, 16814.0, 17060.146992650443, 17135.314587416487, 17161.485155445356, 13809.723805523834, 13909.956753243547, 14074.014818962676, 14140.222287774168, 14152.36314365856, 3521.5421995140723, 3561.056320075182, 3568.072301201706, 3585.0, 3586.1751797086554, 98459.50770246104, 106074.0, 114745.42627286894, 123619.0, 124681.75318246792, 13193.538226162038, 13508.392122354519, 13509.66225844342, 13511.256880871646, 13519.256440895846, 23944.042238310274, 24365.390865228157, 24775.25674229776, 24949.5010099797, 25047.12335068264, 7606.923930760732, 7802.68789248435, 7823.0, 7860.135385107748, 7863.13505514393, 3760.041189496661, 3802.543694756647, 3856.768593884376, 3882.7087968402484, 3898.317794385971, 4239.47006624172, 4368.563143685606, 4387.802548885308, 4393.0994146199955, 4403.603675669141, 915.4049867586123, 940.8682784410188, 942.6936245720168, 956.8421210500329, 958.5973890965811, 531.7394476706386, 600.8793599936088, 606.8348770360917, 616.8858761129205, 642.7782415066795, 10561.155107591374, 10942.069924056384, 11191.32852028881, 11923.165378423428, 11951.701207469883, 528.7673423693562, 633.4932054356589, 636.9745210191633, 656.5601047298321, 680.3944489404435, 5390.0, 5463.535599474009, 5507.5593952483705, 5522.696251706115, 5608.9439105609235, 101250.4937475308, 102043.4897825521, 102345.46481802779, 103037.84810759433, 104909.47545262225, 91200.54399728091, 91346.54326728324, 92151.53924230336, 93005.0, 93119.0, 78107.0, 79263.60368198121, 79789.0, 79885.60057199793, 80207.59896200482, 11046.944765276443, 11380.089592832388, 11396.430178490877, 11413.258138220988, 11499.674771719698, 43404.565954340054, 44148.89627759332, 44408.0, 44670.77664611656, 44783.55216447794, 54680.17979730228, 55505.72247138739, 55959.88080238291, 56241.71879140578, 57289.0, 14126.223057731924, 14305.141691498544, 14316.28418579046, 14377.137371757728, 14404.351804169048, 15286.388544458097, 15682.0, 15774.68450630958, 15827.920860395625, 15844.128572928139, 14525.78211326852, 14581.781273281122, 14644.926775366055, 14646.853531464974, 14786.482473113389, 16538.33846646169, 17164.141792910556, 17242.655146897243, 17376.0, 17381.56546086358, 15118.848811511743, 16269.837301626832, 16707.0, 16714.16429178512, 16715.99704017763, 11275.605353812578, 11397.430128493708, 11727.76544469123, 12114.75770484603, 12176.0, 12681.93659031699, 12731.427085781348, 13295.401706923405, 13943.790843137158, 14063.648408789453], "value": 8235.558623629964, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1572.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 116.0, 116.0, 114.0, 118.0, 115.0, 114.0, 114.0, 137.0, 174.0], "value": 122.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 114.0, 121.0, 148.0, 113.0, 119.0, 135.0, 149.0, 143.0, 112.0], "value": 130.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 205.0, 199.0, 250.0, 294.0, 240.0, 241.0, 275.0, 198.0, 199.0], "value": 229.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 57.0, 62.0, 97.0, 88.0, 88.0, 85.0, 63.0, 80.0, 58.0], "value": 76.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 70.0, 84.0, 75.0, 71.0, 70.0, 93.0, 70.0, 73.0, 93.0], "value": 79.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 77.0, 116.0, 135.0, 113.0, 124.0, 135.0, 90.0, 135.0, 134.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 98.0, 98.0, 97.0, 98.0, 98.0, 98.0, 98.0, 107.0], "value": 98.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 91.0, 91.0, 93.0, 91.0, 90.0, 93.0, 90.0, 91.0], "value": 91.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 50.0, 54.0, 52.0, 51.0, 53.0, 52.0, 50.0, 52.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 64.0, 57.0, 58.0, 73.0, 89.0, 84.0, 64.0, 61.0, 61.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 83.0, 83.0, 83.0, 96.0, 83.0, 99.0, 105.0, 107.0], "value": 90.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 158.0, 151.0, 135.0, 152.0, 137.0, 142.0, 161.0, 206.0, 153.0], "value": 157.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 186.0, 184.0, 190.0, 186.0, 188.0, 188.0, 185.0, 185.0, 184.0], "value": 185.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 87.0, 90.0, 83.0, 69.0, 71.0, 70.0, 68.0, 66.0, 70.0], "value": 75.1, "unit": "score"}]}]} 04:59:44 INFO - Return code: 0 04:59:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:59:44 ERROR - # TBPL SUCCESS # 04:59:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:59:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:59:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:59:44 INFO - 2017-04-19 04:59:44.562 screenresolution[1658:10705] starting screenresolution argv=screenresolution get 04:59:44 INFO - 2017-04-19 04:59:44.564 screenresolution[1658:10705] Display 0: 1600x1200x32@60 04:59:44 INFO - 2017-04-19 04:59:44.570 screenresolution[1659:10708] starting screenresolution argv=screenresolution list 04:59:44 INFO - Available Modes on Display 0 04:59:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:59:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:59:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:59:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:59:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:59:44 INFO - Intel Iris: 04:59:44 INFO - Chipset Model: Intel Iris 04:59:44 INFO - Type: GPU 04:59:44 INFO - Bus: Built-In 04:59:44 INFO - VRAM (Dynamic, Max): 1536 MB 04:59:44 INFO - Vendor: Intel (0x8086) 04:59:44 INFO - Device ID: 0x0a2e 04:59:44 INFO - Revision ID: 0x0009 04:59:44 INFO - Displays: 04:59:44 INFO - Display: 04:59:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:59:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:59:44 INFO - Display Serial Number: 1600x1200 60 04:59:44 INFO - Main Display: Yes 04:59:44 INFO - Mirror: Off 04:59:44 INFO - Online: Yes 04:59:44 INFO - Rotation: Supported 04:59:44 INFO - Return code: 0 04:59:44 INFO - Running post-action listener: _resource_record_post_action 04:59:44 INFO - [mozharness: 2017-04-19 11:59:44.805641Z] Finished run-tests step (success) 04:59:44 INFO - Running post-run listener: _resource_record_post_run 04:59:44 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 39263232; Write bytes: 517509632; Read time: 253; Write time: 1647 04:59:44 INFO - TinderboxPrint: CPU usage
54.2% 04:59:44 INFO - TinderboxPrint: I/O read bytes / time
39,263,232 / 253 04:59:44 INFO - TinderboxPrint: I/O write bytes / time
517,509,632 / 1,647 04:59:44 INFO - TinderboxPrint: CPU idle
2,198.8 (45.8%) 04:59:44 INFO - TinderboxPrint: CPU system
965.3 (20.1%) 04:59:44 INFO - TinderboxPrint: CPU user
1,633.7 (34.1%) 04:59:44 INFO - TinderboxPrint: Swap in / out
247,287,808 / 0 04:59:44 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205414912; Write bytes: 204162560; Read time: 15881; Write time: 449 04:59:44 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 35392512; Write bytes: 306170880; Read time: 227; Write time: 1171 04:59:45 INFO - Running post-run listener: _upload_blobber_files 04:59:45 INFO - Blob upload gear active. 04:59:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:59:45 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 04:59:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:59:45 INFO - (blobuploader) - INFO - Open directory for files ... 04:59:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:59:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:59:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:46 INFO - (blobuploader) - INFO - Done attempting. 04:59:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:59:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:59:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:48 INFO - (blobuploader) - INFO - Done attempting. 04:59:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:59:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:59:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:49 INFO - (blobuploader) - INFO - Done attempting. 04:59:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:59:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:59:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:51 INFO - (blobuploader) - INFO - Done attempting. 04:59:51 INFO - (blobuploader) - INFO - Iteration through files over. 04:59:51 INFO - Return code: 0 04:59:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:59:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:59:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e66484762b0a2cae69a231b7bf21297a1c8092baa21f500d59f301f04d84aa0d64e9440ad5fc7c7fb034f3b57cb184d935f8dd9d2f4bf8059c0e021da72c25bd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a0a73bf38fcfca0c9e781e23760ac49ccfd919f8060edb5f36e678d94cf46d3915d9deca5c49bb917c41ed5568ca239758b344a02ae2e7cd1882e5a0491ecc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e828ce17322f75fc37b043721cd9f7f51558ab8365638183f42c7b9e9dcbe97418c5554badd74ba8cb38d68335a7c817a2fbb565779bbae09d4603a563f32b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c24d77bc1945398279f9db726518e854068d4b32ffc031b381c8a98afd29f59623c777374eb3f8ea0a9f67960dd67cf5f5c7f4699df8c496f0d9a396f80958d7"} 04:59:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:59:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:59:51 INFO - Contents: 04:59:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e66484762b0a2cae69a231b7bf21297a1c8092baa21f500d59f301f04d84aa0d64e9440ad5fc7c7fb034f3b57cb184d935f8dd9d2f4bf8059c0e021da72c25bd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a0a73bf38fcfca0c9e781e23760ac49ccfd919f8060edb5f36e678d94cf46d3915d9deca5c49bb917c41ed5568ca239758b344a02ae2e7cd1882e5a0491ecc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e828ce17322f75fc37b043721cd9f7f51558ab8365638183f42c7b9e9dcbe97418c5554badd74ba8cb38d68335a7c817a2fbb565779bbae09d4603a563f32b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c24d77bc1945398279f9db726518e854068d4b32ffc031b381c8a98afd29f59623c777374eb3f8ea0a9f67960dd67cf5f5c7f4699df8c496f0d9a396f80958d7"} 04:59:51 INFO - Running post-run listener: copy_logs_to_upload_dir 04:59:51 INFO - Copying logs to upload dir... 04:59:51 INFO - mkdir: /builds/slave/test/build/upload/logs 04:59:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.746360 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-19 04:59:51.920763) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-19 04:59:51.924404) ========= 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.pNATGBdyHy/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.PkMvJcgzm0/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e66484762b0a2cae69a231b7bf21297a1c8092baa21f500d59f301f04d84aa0d64e9440ad5fc7c7fb034f3b57cb184d935f8dd9d2f4bf8059c0e021da72c25bd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a0a73bf38fcfca0c9e781e23760ac49ccfd919f8060edb5f36e678d94cf46d3915d9deca5c49bb917c41ed5568ca239758b344a02ae2e7cd1882e5a0491ecc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e828ce17322f75fc37b043721cd9f7f51558ab8365638183f42c7b9e9dcbe97418c5554badd74ba8cb38d68335a7c817a2fbb565779bbae09d4603a563f32b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c24d77bc1945398279f9db726518e854068d4b32ffc031b381c8a98afd29f59623c777374eb3f8ea0a9f67960dd67cf5f5c7f4699df8c496f0d9a396f80958d7"} build_url:https://queue.taskcluster.net/v1/task/VdEa7XrZRIOj-2F5cQwT0A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011282 build_url: 'https://queue.taskcluster.net/v1/task/VdEa7XrZRIOj-2F5cQwT0A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e66484762b0a2cae69a231b7bf21297a1c8092baa21f500d59f301f04d84aa0d64e9440ad5fc7c7fb034f3b57cb184d935f8dd9d2f4bf8059c0e021da72c25bd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a0a73bf38fcfca0c9e781e23760ac49ccfd919f8060edb5f36e678d94cf46d3915d9deca5c49bb917c41ed5568ca239758b344a02ae2e7cd1882e5a0491ecc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e828ce17322f75fc37b043721cd9f7f51558ab8365638183f42c7b9e9dcbe97418c5554badd74ba8cb38d68335a7c817a2fbb565779bbae09d4603a563f32b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c24d77bc1945398279f9db726518e854068d4b32ffc031b381c8a98afd29f59623c777374eb3f8ea0a9f67960dd67cf5f5c7f4699df8c496f0d9a396f80958d7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-19 04:59:51.958728) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 04:59:51.959019) ========= 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.pNATGBdyHy/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.PkMvJcgzm0/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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-04-19 04:59:52.007779) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-19 04:59:52.008132) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-19 04:59:52.008431) ========= ========= Total master_lag: 0.18 =========