builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0083 starttime: 1492786309.48 results: success (0) buildid: 20170421065627 builduid: 4a0b40d291a44fb59d920707dc65149f revision: c8198aa6e7677e90cc7f1e2df0a14a5cc2719055 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 07:51:49.482610) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 07:51:49.483088) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 07:51:49.483363) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 07:51:49.509977) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 07:51:49.510378) ========= 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.hDxazQRp9b/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.lKsDU2zsE4/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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-21 07:51:49-- 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% 12.0M=0.001s 2017-04-21 07:51:49 (12.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.248865 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 07:51:49.783948) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 07:51:49.784266) ========= 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.hDxazQRp9b/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.lKsDU2zsE4/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.029008 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 07:51:49.834964) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-21 07:51:49.835351) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c8198aa6e7677e90cc7f1e2df0a14a5cc2719055 --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 c8198aa6e7677e90cc7f1e2df0a14a5cc2719055 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hDxazQRp9b/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.lKsDU2zsE4/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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-21 07:51:49,905 truncating revision to first 12 chars 2017-04-21 07:51:49,905 Setting DEBUG logging. 2017-04-21 07:51:49,905 attempt 1/10 2017-04-21 07:51:49,905 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c8198aa6e767?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-21 07:51:50,927 unpacking tar archive at: mozilla-central-c8198aa6e767/testing/mozharness/ program finished with exit code 0 elapsedTime=1.316186 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-21 07:51:51.175127) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 07:51:51.175449) ========= script_repo_revision: c8198aa6e7677e90cc7f1e2df0a14a5cc2719055 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 07:51:51.175882) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 07:51:51.176146) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 07:51:51.195966) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-04-21 07:51:51.196377) ========= /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.hDxazQRp9b/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.lKsDU2zsE4/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:51:51 INFO - MultiFileLogger online at 20170421 07:51:51 in /builds/slave/test 07:51:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:51:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:51:51 INFO - {'append_to_log': False, 07:51:51 INFO - 'base_work_dir': '/builds/slave/test', 07:51:51 INFO - 'blob_upload_branch': 'Firefox', 07:51:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:51:51 INFO - 'branch': 'Firefox', 07:51:51 INFO - 'buildbot_json_path': 'buildprops.json', 07:51:51 INFO - 'config_files': ('talos/mac_config.py',), 07:51:51 INFO - 'default_actions': ('clobber', 07:51:51 INFO - 'read-buildbot-config', 07:51:51 INFO - 'download-and-extract', 07:51:51 INFO - 'populate-webroot', 07:51:51 INFO - 'create-virtualenv', 07:51:51 INFO - 'install', 07:51:51 INFO - 'run-tests'), 07:51:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:51:51 INFO - 'download_minidump_stackwalk': True, 07:51:51 INFO - 'download_symbols': 'ondemand', 07:51:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:51:51 INFO - 'tooltool.py': '/tools/tooltool.py', 07:51:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:51:51 INFO - '/tools/misc-python/virtualenv.py')}, 07:51:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:51:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:51:51 INFO - 'gecko_profile': False, 07:51:51 INFO - 'gecko_profile_interval': 0, 07:51:51 INFO - 'installer_path': 'installer.exe', 07:51:51 INFO - 'log_level': 'info', 07:51:51 INFO - 'log_name': 'talos', 07:51:51 INFO - 'log_to_console': True, 07:51:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:51:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:51:51 INFO - 'opt_config_files': (), 07:51:51 INFO - 'pip_index': False, 07:51:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:51:51 INFO - 'cmd': ('bash', 07:51:51 INFO - '-c', 07:51:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:51:51 INFO - 'enabled': True, 07:51:51 INFO - 'halt_on_failure': False, 07:51:51 INFO - 'name': 'check_screen_resolution'},), 07:51:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:51:51 INFO - 'cmd': ('bash', 07:51:51 INFO - '-c', 07:51:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:51:51 INFO - 'enabled': True, 07:51:51 INFO - 'halt_on_failure': False, 07:51:51 INFO - 'name': 'check_screen_resolution'},), 07:51:51 INFO - 'run_cmd_checks_enabled': True, 07:51:51 INFO - 'suite': 'dromaeojs-e10s', 07:51:51 INFO - 'system_bits': '32', 07:51:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:51:51 INFO - 'title': 't-yosemite-r7-0083', 07:51:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:51:51 INFO - 'use_talos_json': True, 07:51:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:51:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:51:51 INFO - 'work_dir': 'build'} 07:51:51 INFO - [mozharness: 2017-04-21 14:51:51.379605Z] Running clobber step. 07:51:51 INFO - Running pre-action listener: _resource_record_pre_action 07:51:51 INFO - Running main action method: clobber 07:51:51 INFO - rmtree: /builds/slave/test/build 07:51:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:51:53 INFO - Running post-action listener: _resource_record_post_action 07:51:53 INFO - [mozharness: 2017-04-21 14:51:53.961715Z] Finished clobber step (success) 07:51:53 INFO - [mozharness: 2017-04-21 14:51:53.961846Z] Running read-buildbot-config step. 07:51:53 INFO - Running pre-action listener: _resource_record_pre_action 07:51:53 INFO - Running main action method: read_buildbot_config 07:51:53 INFO - Using buildbot properties: 07:51:53 INFO - { 07:51:53 INFO - "project": "", 07:51:53 INFO - "product": "firefox", 07:51:53 INFO - "script_repo_revision": "production", 07:51:53 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 07:51:53 INFO - "repository": "", 07:51:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 07:51:53 INFO - "buildid": "20170421065627", 07:51:53 INFO - "pgo_build": "False", 07:51:53 INFO - "basedir": "/builds/slave/test", 07:51:53 INFO - "buildnumber": 35, 07:51:53 INFO - "slavename": "t-yosemite-r7-0083", 07:51:53 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 07:51:53 INFO - "platform": "yosemite_r7", 07:51:53 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:51:53 INFO - "branch": "mozilla-central", 07:51:53 INFO - "repo_path": "mozilla-central", 07:51:53 INFO - "revision": "c8198aa6e7677e90cc7f1e2df0a14a5cc2719055", 07:51:53 INFO - "stage_platform": "macosx64", 07:51:53 INFO - "builduid": "4a0b40d291a44fb59d920707dc65149f", 07:51:53 INFO - "slavebuilddir": "test" 07:51:53 INFO - } 07:51:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/e3g2k0poT8GbRBZ792rDiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 07:51:53 INFO - Running post-action listener: _resource_record_post_action 07:51:53 INFO - [mozharness: 2017-04-21 14:51:53.965363Z] Finished read-buildbot-config step (success) 07:51:53 INFO - [mozharness: 2017-04-21 14:51:53.965493Z] Running download-and-extract step. 07:51:53 INFO - Running pre-action listener: _resource_record_pre_action 07:51:53 INFO - Running main action method: download_and_extract 07:51:53 INFO - mkdir: /builds/slave/test/build/tests 07:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:51:53 INFO - trying https://queue.taskcluster.net/v1/task/e3g2k0poT8GbRBZ792rDiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 07:51:53 INFO - Downloading https://queue.taskcluster.net/v1/task/e3g2k0poT8GbRBZ792rDiQ/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 07:51:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e3g2k0poT8GbRBZ792rDiQ/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 07:51:54 INFO - Downloaded 1325 bytes. 07:51:54 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 07:51:54 INFO - Using the following test package requirements: 07:51:54 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:51:54 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 07:51:54 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 07:51:54 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:51:54 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 07:51:54 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:51:54 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 07:51:54 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:51:54 INFO - u'jsshell-mac.zip'], 07:51:54 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:51:54 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 07:51:54 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 07:51:54 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:51:54 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 07:51:54 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:51:54 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 07:51:54 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:51:54 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 07:51:54 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:51:54 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 07:51:54 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:51:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e3g2k0poT8GbRBZ792rDiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 07:51:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e3g2k0poT8GbRBZ792rDiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:51:54 INFO - Fetch https://queue.taskcluster.net/v1/task/e3g2k0poT8GbRBZ792rDiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 07:51:56 INFO - Expected file size: 52523365 07:51:56 INFO - Obtained file size: 52523365 07:52:12 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 07:52:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e3g2k0poT8GbRBZ792rDiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 07:52:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e3g2k0poT8GbRBZ792rDiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:52:12 INFO - Fetch https://queue.taskcluster.net/v1/task/e3g2k0poT8GbRBZ792rDiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 07:52:14 INFO - Expected file size: 52523365 07:52:14 INFO - Obtained file size: 52523365 07:52:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e3g2k0poT8GbRBZ792rDiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 07:52:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e3g2k0poT8GbRBZ792rDiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:52:30 INFO - Fetch https://queue.taskcluster.net/v1/task/e3g2k0poT8GbRBZ792rDiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 07:52:31 INFO - Expected file size: 14408811 07:52:31 INFO - Obtained file size: 14408811 07:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:31 INFO - trying https://queue.taskcluster.net/v1/task/e3g2k0poT8GbRBZ792rDiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 07:52:31 INFO - Downloading https://queue.taskcluster.net/v1/task/e3g2k0poT8GbRBZ792rDiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 07:52:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e3g2k0poT8GbRBZ792rDiQ/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 07:52:33 INFO - Downloaded 71028109 bytes. 07:52:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e3g2k0poT8GbRBZ792rDiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 07:52:33 INFO - mkdir: /builds/slave/test/properties 07:52:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:52:33 INFO - Writing to file /builds/slave/test/properties/build_url 07:52:33 INFO - Contents: 07:52:33 INFO - build_url:https://queue.taskcluster.net/v1/task/e3g2k0poT8GbRBZ792rDiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 07:52:34 INFO - Running post-action listener: _resource_record_post_action 07:52:34 INFO - Running post-action listener: set_extra_try_arguments 07:52:34 INFO - [mozharness: 2017-04-21 14:52:34.473751Z] Finished download-and-extract step (success) 07:52:34 INFO - [mozharness: 2017-04-21 14:52:34.473899Z] Running populate-webroot step. 07:52:34 INFO - Running pre-action listener: _resource_record_pre_action 07:52:34 INFO - Running main action method: populate_webroot 07:52:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:52:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:52:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:52:34 INFO - '--tppagecycles', 07:52:34 INFO - '7'], 07:52:34 INFO - 'tests': ['tsvgm']}}, 07:52:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:52:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:52:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:52:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:52:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:52:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:52:34 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:52:34 INFO - 'talos_options': ['--disable-e10s'], 07:52:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:52:34 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:52:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:52:34 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:52:34 INFO - 'talos_options': ['--disable-e10s'], 07:52:34 INFO - 'tests': ['damp', 'tps']}, 07:52:34 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:52:34 INFO - 'tests': ['damp', 'tps']}, 07:52:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:52:34 INFO - 'tests': ['dromaeo_dom']}, 07:52:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:52:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:52:34 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 07:52:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:52:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:52:34 INFO - 'tests': ['a11yr', 07:52:34 INFO - 'ts_paint', 07:52:34 INFO - 'tpaint', 07:52:34 INFO - 'sessionrestore', 07:52:34 INFO - 'sessionrestore_no_auto_restore', 07:52:34 INFO - 'tabpaint']}, 07:52:34 INFO - 'other-e10s': {'tests': ['a11yr', 07:52:34 INFO - 'ts_paint', 07:52:34 INFO - 'tpaint', 07:52:34 INFO - 'sessionrestore', 07:52:34 INFO - 'sessionrestore_no_auto_restore', 07:52:34 INFO - 'tabpaint']}, 07:52:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:52:34 INFO - 'ts_paint', 07:52:34 INFO - 'tpaint', 07:52:34 INFO - 'sessionrestore', 07:52:34 INFO - 'sessionrestore_no_auto_restore', 07:52:34 INFO - 'tabpaint']}, 07:52:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:52:34 INFO - 'ts_paint', 07:52:34 INFO - 'tpaint', 07:52:34 INFO - 'sessionrestore', 07:52:34 INFO - 'sessionrestore_no_auto_restore', 07:52:34 INFO - 'tabpaint']}, 07:52:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:52:34 INFO - 'tests': ['a11yr', 07:52:34 INFO - 'ts_paint', 07:52:34 INFO - 'tpaint', 07:52:34 INFO - 'sessionrestore', 07:52:34 INFO - 'sessionrestore_no_auto_restore', 07:52:34 INFO - 'tabpaint']}, 07:52:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:52:34 INFO - 'tests': ['a11yr', 07:52:34 INFO - 'ts_paint', 07:52:34 INFO - 'tpaint', 07:52:34 INFO - 'sessionrestore', 07:52:34 INFO - 'sessionrestore_no_auto_restore', 07:52:34 INFO - 'tabpaint']}, 07:52:34 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 07:52:34 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 07:52:34 INFO - 'bloom_basic_ref']}, 07:52:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:52:34 INFO - 'tests': ['tsvgx', 07:52:34 INFO - 'tsvgr_opacity', 07:52:34 INFO - 'tart', 07:52:34 INFO - 'tscrollx', 07:52:34 INFO - 'cart', 07:52:34 INFO - 'tsvg_static']}, 07:52:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:52:34 INFO - 'tsvgr_opacity', 07:52:34 INFO - 'tart', 07:52:34 INFO - 'tscrollx', 07:52:34 INFO - 'cart', 07:52:34 INFO - 'tsvg_static']}, 07:52:34 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:52:34 INFO - 'talos_options': ['--disable-e10s'], 07:52:34 INFO - 'tests': ['tp5o']}, 07:52:34 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:52:34 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:52:34 INFO - 'talos_options': ['--disable-e10s', 07:52:34 INFO - '--xperf_path', 07:52:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:52:34 INFO - 'tests': ['tp5n']}, 07:52:34 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:52:34 INFO - 'talos_options': ['--xperf_path', 07:52:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:52:34 INFO - 'tests': ['tp5n']}}, 07:52:34 INFO - 'talos.zip': {'path': '', 07:52:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:52:34 INFO - Running post-action listener: _resource_record_post_action 07:52:34 INFO - [mozharness: 2017-04-21 14:52:34.492780Z] Finished populate-webroot step (success) 07:52:34 INFO - [mozharness: 2017-04-21 14:52:34.492887Z] Running create-virtualenv step. 07:52:34 INFO - Running pre-action listener: _resource_record_pre_action 07:52:34 INFO - Running main action method: create_virtualenv 07:52:34 INFO - Creating virtualenv /builds/slave/test/build/venv 07:52:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:52:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:52:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:52:34 INFO - Using real prefix '/tools/python27' 07:52:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:52:35 INFO - Installing distribute.............................................................................................................................................................................................done. 07:52:38 INFO - Installing pip.................done. 07:52:38 INFO - Return code: 0 07:52:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:52:38 INFO - Reading from file tmpfile_stdout 07:52:38 INFO - Output received: 07:52:38 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:52:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:38 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 0x10a53eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a541768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc568d6a1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a31cd30>, '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 0x10a242db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a311be8>, '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.hDxazQRp9b/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.lKsDU2zsE4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:52:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:52:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hDxazQRp9b/Render', 07:52:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:38 INFO - 'HOME': '/Users/cltbld', 07:52:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:38 INFO - 'LOGNAME': 'cltbld', 07:52:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:38 INFO - 'MOZ_NO_REMOTE': '1', 07:52:38 INFO - 'NO_EM_RESTART': '1', 07:52:38 INFO - 'PAGER': '/bin/cat', 07:52:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:38 INFO - 'PWD': '/builds/slave/test', 07:52:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:38 INFO - 'SHELL': '/bin/bash', 07:52:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lKsDU2zsE4/Listeners', 07:52:38 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 07:52:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:38 INFO - 'USER': 'cltbld', 07:52:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:38 INFO - 'XPC_FLAGS': '0x0', 07:52:38 INFO - 'XPC_SERVICE_NAME': '0', 07:52:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:52:38 INFO - Cleaning up... 07:52:38 INFO - Return code: 0 07:52:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:38 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 0x10a53eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a541768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc568d6a1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a31cd30>, '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 0x10a242db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a311be8>, '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.hDxazQRp9b/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.lKsDU2zsE4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:52:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:52:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hDxazQRp9b/Render', 07:52:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:38 INFO - 'HOME': '/Users/cltbld', 07:52:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:38 INFO - 'LOGNAME': 'cltbld', 07:52:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:38 INFO - 'MOZ_NO_REMOTE': '1', 07:52:38 INFO - 'NO_EM_RESTART': '1', 07:52:38 INFO - 'PAGER': '/bin/cat', 07:52:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:38 INFO - 'PWD': '/builds/slave/test', 07:52:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:38 INFO - 'SHELL': '/bin/bash', 07:52:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lKsDU2zsE4/Listeners', 07:52:38 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 07:52:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:38 INFO - 'USER': 'cltbld', 07:52:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:38 INFO - 'XPC_FLAGS': '0x0', 07:52:38 INFO - 'XPC_SERVICE_NAME': '0', 07:52:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:39 INFO - Downloading/unpacking psutil>=3.1.1 07:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:52:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:52:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:52:42 INFO - Installing collected packages: psutil 07:52:42 INFO - Running setup.py install for psutil 07:52:42 INFO - building 'psutil._psutil_osx' extension 07:52:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:52:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:52:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:52:43 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:52:43 INFO - building 'psutil._psutil_posix' extension 07:52:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:52:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:52:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:52:43 INFO - ^ 07:52:43 INFO - 1 warning generated. 07:52:43 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:52:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:52:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:52:43 INFO - Successfully installed psutil 07:52:43 INFO - Cleaning up... 07:52:43 INFO - Return code: 0 07:52:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a53eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a541768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc568d6a1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a31cd30>, '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 0x10a242db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a311be8>, '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.hDxazQRp9b/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.lKsDU2zsE4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:52:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:52:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hDxazQRp9b/Render', 07:52:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:43 INFO - 'HOME': '/Users/cltbld', 07:52:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:43 INFO - 'LOGNAME': 'cltbld', 07:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:43 INFO - 'MOZ_NO_REMOTE': '1', 07:52:43 INFO - 'NO_EM_RESTART': '1', 07:52:43 INFO - 'PAGER': '/bin/cat', 07:52:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:43 INFO - 'PWD': '/builds/slave/test', 07:52:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:43 INFO - 'SHELL': '/bin/bash', 07:52:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lKsDU2zsE4/Listeners', 07:52:43 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 07:52:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:43 INFO - 'USER': 'cltbld', 07:52:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:43 INFO - 'XPC_FLAGS': '0x0', 07:52:43 INFO - 'XPC_SERVICE_NAME': '0', 07:52:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:52:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:52:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:52:46 INFO - Installing collected packages: mozsystemmonitor 07:52:46 INFO - Running setup.py install for mozsystemmonitor 07:52:46 INFO - Successfully installed mozsystemmonitor 07:52:46 INFO - Cleaning up... 07:52:47 INFO - Return code: 0 07:52:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:47 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 0x10a53eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a541768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc568d6a1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a31cd30>, '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 0x10a242db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a311be8>, '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.hDxazQRp9b/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.lKsDU2zsE4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:52:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:52:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:52:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hDxazQRp9b/Render', 07:52:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:47 INFO - 'HOME': '/Users/cltbld', 07:52:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:47 INFO - 'LOGNAME': 'cltbld', 07:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:47 INFO - 'MOZ_NO_REMOTE': '1', 07:52:47 INFO - 'NO_EM_RESTART': '1', 07:52:47 INFO - 'PAGER': '/bin/cat', 07:52:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:47 INFO - 'PWD': '/builds/slave/test', 07:52:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:47 INFO - 'SHELL': '/bin/bash', 07:52:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lKsDU2zsE4/Listeners', 07:52:47 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 07:52:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:47 INFO - 'USER': 'cltbld', 07:52:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:47 INFO - 'XPC_FLAGS': '0x0', 07:52:47 INFO - 'XPC_SERVICE_NAME': '0', 07:52:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:48 INFO - Downloading/unpacking jsonschema==2.5.1 07:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:52:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:51 INFO - Downloading functools32-3.2.3-2.tar.gz 07:52:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:52:51 INFO - warning: no files found matching '*.txt' 07:52:51 INFO - no previously-included directories found matching 'build' 07:52:51 INFO - no previously-included directories found matching 'dist' 07:52:51 INFO - no previously-included directories found matching '.git*' 07:52:51 INFO - Installing collected packages: jsonschema, functools32 07:52:51 INFO - Running setup.py install for functools32 07:52:51 INFO - warning: no files found matching '*.txt' 07:52:51 INFO - no previously-included directories found matching 'build' 07:52:51 INFO - no previously-included directories found matching 'dist' 07:52:51 INFO - no previously-included directories found matching '.git*' 07:52:51 INFO - Successfully installed jsonschema functools32 07:52:51 INFO - Cleaning up... 07:52:51 INFO - Return code: 0 07:52:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a53eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a541768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc568d6a1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a31cd30>, '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 0x10a242db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a311be8>, '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.hDxazQRp9b/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.lKsDU2zsE4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:52:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:52:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:52:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hDxazQRp9b/Render', 07:52:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:51 INFO - 'HOME': '/Users/cltbld', 07:52:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:51 INFO - 'LOGNAME': 'cltbld', 07:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:51 INFO - 'MOZ_NO_REMOTE': '1', 07:52:51 INFO - 'NO_EM_RESTART': '1', 07:52:51 INFO - 'PAGER': '/bin/cat', 07:52:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:51 INFO - 'PWD': '/builds/slave/test', 07:52:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:51 INFO - 'SHELL': '/bin/bash', 07:52:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lKsDU2zsE4/Listeners', 07:52:51 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 07:52:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:51 INFO - 'USER': 'cltbld', 07:52:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:51 INFO - 'XPC_FLAGS': '0x0', 07:52:51 INFO - 'XPC_SERVICE_NAME': '0', 07:52:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:52:51 INFO - Cleaning up... 07:52:51 INFO - Return code: 0 07:52:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a53eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a541768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc568d6a1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a31cd30>, '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 0x10a242db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a311be8>, '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.hDxazQRp9b/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.lKsDU2zsE4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:52:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:52:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:52:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hDxazQRp9b/Render', 07:52:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:51 INFO - 'HOME': '/Users/cltbld', 07:52:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:51 INFO - 'LOGNAME': 'cltbld', 07:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:51 INFO - 'MOZ_NO_REMOTE': '1', 07:52:51 INFO - 'NO_EM_RESTART': '1', 07:52:51 INFO - 'PAGER': '/bin/cat', 07:52:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:51 INFO - 'PWD': '/builds/slave/test', 07:52:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:51 INFO - 'SHELL': '/bin/bash', 07:52:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lKsDU2zsE4/Listeners', 07:52:51 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 07:52:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:51 INFO - 'USER': 'cltbld', 07:52:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:51 INFO - 'XPC_FLAGS': '0x0', 07:52:51 INFO - 'XPC_SERVICE_NAME': '0', 07:52:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:52 INFO - Downloading/unpacking blobuploader==1.2.4 07:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:54 INFO - Downloading blobuploader-1.2.4.tar.gz 07:52:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:52:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:52:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:55 INFO - Downloading docopt-0.6.1.tar.gz 07:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:52:55 INFO - Installing collected packages: blobuploader, requests, docopt 07:52:55 INFO - Running setup.py install for blobuploader 07:52:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:52:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:52:56 INFO - Running setup.py install for requests 07:52:56 INFO - Running setup.py install for docopt 07:52:56 INFO - Successfully installed blobuploader requests docopt 07:52:56 INFO - Cleaning up... 07:52:56 INFO - Return code: 0 07:52:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:56 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 0x10a53eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a541768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc568d6a1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a31cd30>, '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 0x10a242db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a311be8>, '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.hDxazQRp9b/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.lKsDU2zsE4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:52:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:52:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hDxazQRp9b/Render', 07:52:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:52:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:52:56 INFO - 'HOME': '/Users/cltbld', 07:52:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:52:56 INFO - 'LOGNAME': 'cltbld', 07:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:56 INFO - 'MOZ_NO_REMOTE': '1', 07:52:56 INFO - 'NO_EM_RESTART': '1', 07:52:56 INFO - 'PAGER': '/bin/cat', 07:52:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:56 INFO - 'PWD': '/builds/slave/test', 07:52:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:52:56 INFO - 'SHELL': '/bin/bash', 07:52:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lKsDU2zsE4/Listeners', 07:52:56 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 07:52:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:52:56 INFO - 'USER': 'cltbld', 07:52:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:52:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:56 INFO - 'XPC_FLAGS': '0x0', 07:52:56 INFO - 'XPC_SERVICE_NAME': '0', 07:52:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:52:57 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-GBBuHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:52:57 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-HoP8Wd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:52:57 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-zAfR6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:52:57 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-qt6CCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:52:57 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-w78aIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:52:57 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-ZEHruW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:52:57 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-MPRXZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:52:57 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-1CXpFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:52:57 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-xYQEZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:52:58 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-EQzcRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:52:58 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-tYhR_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:52:58 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-jSAcWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:52:58 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-8lIgvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:52:58 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-zvfjy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:58 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-oC0LNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:52:58 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-4SbOIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:52:58 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-SlEkf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:52:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:52:58 INFO - Running setup.py install for manifestparser 07:52:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:52:59 INFO - Running setup.py install for mozcrash 07:52:59 INFO - Running setup.py install for mozdebug 07:52:59 INFO - Running setup.py install for mozdevice 07:52:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:52:59 INFO - Running setup.py install for mozfile 07:52:59 INFO - Running setup.py install for mozhttpd 07:52:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:52:59 INFO - Running setup.py install for mozinfo 07:52:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:52:59 INFO - Running setup.py install for mozInstall 07:52:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:52:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:52:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:52:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:53:00 INFO - Running setup.py install for mozleak 07:53:00 INFO - Running setup.py install for mozlog 07:53:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:53:00 INFO - Running setup.py install for moznetwork 07:53:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:53:00 INFO - Running setup.py install for mozprocess 07:53:00 INFO - Running setup.py install for mozprofile 07:53:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:53:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:53:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:53:00 INFO - Running setup.py install for mozrunner 07:53:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:53:00 INFO - Running setup.py install for mozscreenshot 07:53:01 INFO - Running setup.py install for moztest 07:53:01 INFO - Running setup.py install for mozversion 07:53:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:53:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:53:01 INFO - Cleaning up... 07:53:01 INFO - Return code: 0 07:53:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:01 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 0x10a53eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a541768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc568d6a1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a31cd30>, '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 0x10a242db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a311be8>, '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.hDxazQRp9b/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.lKsDU2zsE4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:53:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:53:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:53:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hDxazQRp9b/Render', 07:53:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:01 INFO - 'HOME': '/Users/cltbld', 07:53:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:01 INFO - 'LOGNAME': 'cltbld', 07:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:01 INFO - 'MOZ_NO_REMOTE': '1', 07:53:01 INFO - 'NO_EM_RESTART': '1', 07:53:01 INFO - 'PAGER': '/bin/cat', 07:53:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:01 INFO - 'PWD': '/builds/slave/test', 07:53:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:01 INFO - 'SHELL': '/bin/bash', 07:53:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lKsDU2zsE4/Listeners', 07:53:01 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 07:53:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:01 INFO - 'USER': 'cltbld', 07:53:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:01 INFO - 'XPC_FLAGS': '0x0', 07:53:01 INFO - 'XPC_SERVICE_NAME': '0', 07:53:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:53:01 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-_XbZXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:53:01 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-LyZ5eW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:53:01 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-sah1uY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:53:02 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-_ef04r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:53:02 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)) 07:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:53:02 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-dzFIju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:53:02 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-vxWjwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:53:02 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-dGoAyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:53:02 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-VZ15MQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:53:02 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-fGFojt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:53:02 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-EwYElT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:53:02 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-QYExPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:53:02 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Hf3bdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:53:02 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)) 07:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:53:02 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-rTEwXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:53:03 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-rD8i6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:53:03 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-s2arZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:53:03 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-iJ2m7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:53:03 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-JDDt67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:53:03 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)) 07:53:03 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)) 07:53:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:06 INFO - Downloading blessings-1.6.tar.gz 07:53:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:53:06 INFO - Installing collected packages: blessings 07:53:06 INFO - Running setup.py install for blessings 07:53:06 INFO - Successfully installed blessings 07:53:06 INFO - Cleaning up... 07:53:06 INFO - Return code: 0 07:53:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:53:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:53:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:53:06 INFO - Reading from file tmpfile_stdout 07:53:06 INFO - Current package versions: 07:53:06 INFO - blessings == 1.6 07:53:06 INFO - blobuploader == 1.2.4 07:53:06 INFO - docopt == 0.6.1 07:53:06 INFO - functools32 == 3.2.3-2 07:53:06 INFO - jsonschema == 2.5.1 07:53:06 INFO - manifestparser == 1.1 07:53:06 INFO - mozInstall == 1.12 07:53:06 INFO - mozcrash == 1.0 07:53:06 INFO - mozdebug == 0.1 07:53:06 INFO - mozdevice == 0.50 07:53:06 INFO - mozfile == 1.2 07:53:06 INFO - mozhttpd == 0.7 07:53:06 INFO - mozinfo == 0.9 07:53:06 INFO - mozleak == 0.1 07:53:06 INFO - mozlog == 3.4 07:53:06 INFO - moznetwork == 0.27 07:53:06 INFO - mozprocess == 0.25 07:53:06 INFO - mozprofile == 0.28 07:53:06 INFO - mozrunner == 6.13 07:53:06 INFO - mozscreenshot == 0.1 07:53:06 INFO - mozsystemmonitor == 0.3 07:53:06 INFO - moztest == 0.8 07:53:06 INFO - mozversion == 1.4 07:53:06 INFO - psutil == 3.1.1 07:53:06 INFO - requests == 1.2.3 07:53:06 INFO - wsgiref == 0.1.2 07:53:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:06 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 0x10a53eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a541768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc568d6a1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a31cd30>, '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 0x10a242db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a311be8>, '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.hDxazQRp9b/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.lKsDU2zsE4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:53:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:53:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:53:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hDxazQRp9b/Render', 07:53:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:06 INFO - 'HOME': '/Users/cltbld', 07:53:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:06 INFO - 'LOGNAME': 'cltbld', 07:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:06 INFO - 'MOZ_NO_REMOTE': '1', 07:53:06 INFO - 'NO_EM_RESTART': '1', 07:53:06 INFO - 'PAGER': '/bin/cat', 07:53:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:06 INFO - 'PWD': '/builds/slave/test', 07:53:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:06 INFO - 'SHELL': '/bin/bash', 07:53:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lKsDU2zsE4/Listeners', 07:53:06 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 07:53:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:06 INFO - 'USER': 'cltbld', 07:53:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:06 INFO - 'XPC_FLAGS': '0x0', 07:53:06 INFO - 'XPC_SERVICE_NAME': '0', 07:53:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:53:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:53:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:53:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:53:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:53:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:53:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:53:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:53:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:53:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:53:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:53:07 INFO - Cleaning up... 07:53:07 INFO - Return code: 0 07:53:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:53:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a53eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a541768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc568d6a1c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a31cd30>, '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 0x10a242db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a311be8>, '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.hDxazQRp9b/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.lKsDU2zsE4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:53:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:53:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:53:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hDxazQRp9b/Render', 07:53:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:07 INFO - 'HOME': '/Users/cltbld', 07:53:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:07 INFO - 'LOGNAME': 'cltbld', 07:53:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:07 INFO - 'MOZ_NO_REMOTE': '1', 07:53:07 INFO - 'NO_EM_RESTART': '1', 07:53:07 INFO - 'PAGER': '/bin/cat', 07:53:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:07 INFO - 'PWD': '/builds/slave/test', 07:53:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:07 INFO - 'SHELL': '/bin/bash', 07:53:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lKsDU2zsE4/Listeners', 07:53:07 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 07:53:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:07 INFO - 'USER': 'cltbld', 07:53:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:07 INFO - 'XPC_FLAGS': '0x0', 07:53:07 INFO - 'XPC_SERVICE_NAME': '0', 07:53:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:53:07 INFO - Cleaning up... 07:53:07 INFO - Return code: 0 07:53:07 INFO - Running post-action listener: _resource_record_post_action 07:53:07 INFO - Running post-action listener: _start_resource_monitoring 07:53:07 INFO - Starting resource monitoring. 07:53:07 INFO - [mozharness: 2017-04-21 14:53:07.356578Z] Finished create-virtualenv step (success) 07:53:07 INFO - [mozharness: 2017-04-21 14:53:07.357537Z] Running install step. 07:53:07 INFO - Running pre-action listener: _resource_record_pre_action 07:53:07 INFO - Running main action method: install 07:53:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:53:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:53:07 INFO - Reading from file tmpfile_stdout 07:53:07 INFO - Detecting whether we're running mozinstall >=1.0... 07:53:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:53:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:53:07 INFO - Reading from file tmpfile_stdout 07:53:07 INFO - Output received: 07:53:07 INFO - Usage: mozinstall [options] installer 07:53:07 INFO - Options: 07:53:07 INFO - -h, --help show this help message and exit 07:53:07 INFO - -d DEST, --destination=DEST 07:53:07 INFO - Directory to install application into. [default: 07:53:07 INFO - "/builds/slave/test"] 07:53:07 INFO - --app=APP Application being installed. [default: firefox] 07:53:07 INFO - mkdir: /builds/slave/test/build/application 07:53:07 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'] 07:53:07 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 07:53:27 INFO - Reading from file tmpfile_stdout 07:53:27 INFO - Output received: 07:53:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:53:27 INFO - Running post-action listener: _resource_record_post_action 07:53:27 INFO - [mozharness: 2017-04-21 14:53:27.584433Z] Finished install step (success) 07:53:27 INFO - [mozharness: 2017-04-21 14:53:27.584586Z] Running run-tests step. 07:53:27 INFO - Running pre-action listener: _resource_record_pre_action 07:53:27 INFO - Running main action method: run_tests 07:53:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:53:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:53:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:53:27 INFO - 2017-04-21 07:53:27.599 screenresolution[1618:7448] starting screenresolution argv=screenresolution get 07:53:27 INFO - 2017-04-21 07:53:27.601 screenresolution[1618:7448] Display 0: 1600x1200x32@60 07:53:27 INFO - 2017-04-21 07:53:27.607 screenresolution[1619:7451] starting screenresolution argv=screenresolution list 07:53:27 INFO - Available Modes on Display 0 07:53:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:53:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:53:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:53:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:53:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:53:27 INFO - Intel Iris: 07:53:27 INFO - Chipset Model: Intel Iris 07:53:27 INFO - Type: GPU 07:53:27 INFO - Bus: Built-In 07:53:27 INFO - VRAM (Dynamic, Max): 1536 MB 07:53:27 INFO - Vendor: Intel (0x8086) 07:53:27 INFO - Device ID: 0x0a2e 07:53:27 INFO - Revision ID: 0x0009 07:53:27 INFO - Displays: 07:53:27 INFO - Display: 07:53:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:53:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:53:27 INFO - Display Serial Number: 1600x1200 60 07:53:27 INFO - Main Display: Yes 07:53:27 INFO - Mirror: Off 07:53:27 INFO - Online: Yes 07:53:27 INFO - Rotation: Supported 07:53:27 INFO - Return code: 0 07:53:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:53:27 INFO - Python 2.7.3 07:53:27 INFO - Return code: 0 07:53:27 INFO - grabbing minidump binary from tooltool 07:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:53:27 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 0x10a31cd30>, '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 0x10a242db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a311be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:53:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:53:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:53:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:53:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:53:27 INFO - Return code: 0 07:53:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:53:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:53:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:53:27 INFO - ENV: RUST_BACKTRACE is now 1 07:53:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:53:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:53:27 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/e3g2k0poT8GbRBZ792rDiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:53:27 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/e3g2k0poT8GbRBZ792rDiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0083 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:53:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hDxazQRp9b/Render', 07:53:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:27 INFO - 'HOME': '/Users/cltbld', 07:53:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:27 INFO - 'LOGNAME': 'cltbld', 07:53:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:53:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:27 INFO - 'MOZ_NO_REMOTE': '1', 07:53:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:53:27 INFO - 'NO_EM_RESTART': '1', 07:53:27 INFO - 'PAGER': '/bin/cat', 07:53:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:27 INFO - 'PWD': '/builds/slave/test', 07:53:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:53:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:27 INFO - 'RUST_BACKTRACE': '1', 07:53:27 INFO - 'SHELL': '/bin/bash', 07:53:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lKsDU2zsE4/Listeners', 07:53:27 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 07:53:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:27 INFO - 'USER': 'cltbld', 07:53:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:27 INFO - 'XPC_FLAGS': '0x0', 07:53:27 INFO - 'XPC_SERVICE_NAME': '0', 07:53:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:27 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/e3g2k0poT8GbRBZ792rDiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:53:28 INFO - mozversion application_buildid: 20170421065627 07:53:28 INFO - mozversion application_changeset: c8198aa6e7677e90cc7f1e2df0a14a5cc2719055 07:53:28 INFO - mozversion application_display_name: Nightly 07:53:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:53:28 INFO - mozversion application_name: Firefox 07:53:28 INFO - mozversion application_remotingname: firefox 07:53:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:53:28 INFO - mozversion application_vendor: Mozilla 07:53:28 INFO - mozversion application_version: 55.0a1 07:53:28 INFO - mozversion platform_buildid: 20170421065627 07:53:28 INFO - mozversion platform_changeset: c8198aa6e7677e90cc7f1e2df0a14a5cc2719055 07:53:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:53:28 INFO - mozversion platform_version: 55.0a1 07:53:28 INFO - using testdate: 1492786408 07:53:28 INFO - actual date: 1492786408 07:53:28 INFO - starting webserver on 'localhost:49248' 07:53:28 INFO - SUITE-START | Running 2 tests 07:53:28 INFO - TEST-START | dromaeo_css 07:53:28 INFO - operating with platform_type : mac_ 07:53:28 INFO - Initialising browser for dromaeo_css test... 07:53:28 INFO - TEST-INFO | started process 1629 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpnzinaf/profile http://localhost:49248/getInfo.html) 07:53:31 INFO - PID 1629 | 2017-04-21 07:53:31.079 plugin-container[1631:7637] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9743, name = 'com.apple.tsm.portname' 07:53:31 INFO - PID 1629 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:53:31 INFO - PID 1629 | 2017-04-21 07:53:31.082 plugin-container[1631:7637] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9d13, name = 'com.apple.CFPasteboardClient' 07:53:31 INFO - PID 1629 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:53:31 INFO - PID 1629 | 2017-04-21 07:53:31.082 plugin-container[1631:7637] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:53:31 INFO - PID 1629 | __metrics Screen width/height:1600/1200 07:53:31 INFO - PID 1629 | colorDepth:24 07:53:31 INFO - PID 1629 | Browser inner width/height: 1024/689 07:53:31 INFO - PID 1629 | __metrics 07:53:31 ERROR - PID 1629 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 07:53:32 INFO - TEST-INFO | 1629: exit 0 07:53:32 INFO - Browser initialized. 07:53:32 INFO - Running cycle 1/1 for dromaeo_css test... 07:53:32 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpnzinaf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:53:34 INFO - PID 1632 | 2017-04-21 07:53:34.476 plugin-container[1633:7772] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 07:53:34 INFO - PID 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:53:34 INFO - PID 1632 | 2017-04-21 07:53:34.477 plugin-container[1633:7772] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x460b, name = 'com.apple.CFPasteboardClient' 07:53:34 INFO - PID 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:53:34 INFO - PID 1632 | 2017-04-21 07:53:34.477 plugin-container[1633:7772] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:53:44 INFO - PID 1632 | RSS: Main: 236285952 07:53:44 INFO - PID 1632 | 07:56:47 INFO - PID 1632 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 07:56:49 INFO - PID 1632 | RSS: Main: 251940864 07:56:49 INFO - PID 1632 | 07:58:32 INFO - PID 1632 | ************************* 07:58:32 INFO - PID 1632 | A coding exception was thrown and uncaught in a Task. 07:58:32 INFO - PID 1632 | 07:58:32 ERROR - PID 1632 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:58:32 INFO - PID 1632 | Full stack: 07:58:32 INFO - PID 1632 | ************************* 07:58:32 INFO - PID 1632 | ************************* 07:58:32 INFO - PID 1632 | A coding exception was thrown and uncaught in a Task. 07:58:32 INFO - PID 1632 | 07:58:32 ERROR - PID 1632 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:58:32 INFO - PID 1632 | Full stack: 07:58:32 INFO - PID 1632 | ************************* 07:58:32 INFO - PID 1632 | ************************* 07:58:32 INFO - PID 1632 | A coding exception was thrown and uncaught in a Task. 07:58:32 INFO - PID 1632 | 07:58:32 ERROR - PID 1632 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:58:32 INFO - PID 1632 | Full stack: 07:58:32 INFO - PID 1632 | ************************* 07:58:32 INFO - PID 1632 | ************************* 07:58:32 INFO - PID 1632 | A coding exception was thrown and uncaught in a Task. 07:58:32 INFO - PID 1632 | 07:58:32 ERROR - PID 1632 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:58:32 INFO - PID 1632 | Full stack: 07:58:32 INFO - PID 1632 | ************************* 07:59:51 INFO - PID 1632 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 07:59:51 INFO - PID 1632 | RSS: Main: 258441216 07:59:51 INFO - PID 1632 | 08:02:53 INFO - PID 1632 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 08:02:54 INFO - PID 1632 | RSS: Main: 267862016 08:02:54 INFO - PID 1632 | 08:05:55 INFO - PID 1632 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 08:05:56 INFO - PID 1632 | RSS: Main: 260313088 08:05:56 INFO - PID 1632 | 08:08:59 INFO - PID 1632 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 08:09:00 INFO - PID 1632 | RSS: Main: 269443072 08:09:00 INFO - PID 1632 | 08:12:01 INFO - PID 1632 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 08:12:02 INFO - PID 1632 | RSS: Main: 264253440 08:12:02 INFO - PID 1632 | 08:12:02 INFO - PID 1632 | __start_tp_report 08:12:02 INFO - PID 1632 | _x_x_mozilla_page_load 08:12:02 INFO - PID 1632 | _x_x_mozilla_page_load_details 08:12:02 INFO - PID 1632 | |i|pagename|runs| 08:12:02 INFO - PID 1632 | |0;dojo.html;3138.3252600690853;3339.8831040913556;3604.729645276604;3617.2403795203004;3641.4901913732065;5819.476247137757;6080.571065799539;6087.817365479032;6132.570720049598;6201.193844800176;5140.665856719311;6160.952638051531;6165.506759459244;6178.752849885999;6224.968875155618;5440.047991601474;5458.235846981426;5483.177523371506;5493.368262649807;5591.552675785948;4594.816207351702;5432.91850622241;5498.615096943216;5572.888542229153;5576.693281869496;5370.57035437168;5437.102878025121;5518.061929471999;5527.889442211173;5551.639143455683;5441.537469315113;5462.726863656841;5497.752601132958;5518.696471694056;5556.9444305556835;5381.784728610851;5421.21392398104;5422.511973922326;5423.701696406696;5494.423085576037;6002.579819412643;6114.480269177126;6157.692115394212;6157.938420615781;6243.157173781527;6688.431483323923;6741.224759152711;6748.7637932672615;6750.696218670171;6755;6808.9659551701925;6817.69320380584;6821.965890170567;6822.3859852613;6844.1444819397575;6156.507479401637;6163.106349579286;6302.968485157545;6326.810195694091;6329.588576742543;5437.782488700408;6354.951433013501;6518.511111666644;6852.588844669236;6908.758193463204;5359.544438722674;6335.366463353628;6345.809625711144;6432.09950606906;6539.836504087436;6594.241662208811;6668.233153187445;6709.630970296583;6781.38967492928;6804.4216241620015;6702.19573651165;6707.899381509281;6730.394264516217;6730.730770769114;6743.35938085881;6441.64570948593;6526.445252153525;6611.537192396582;6643.269240383554;6668.266490686021;5139.974300128551;5327.0411325961695;5331.360236771612;5353.357597088374;5359.410464848864;4714.057188562301;4725.7164570125215;4742.549457801503;4744.122337367598;4761.40482439695;4642.396488456547;5384.434634363335;6156.015037593964;6196.938030619726;6355.809325720235;6125.111858780452;6440.001799721051;6781.932180678229;6785.626790526469;6825.488088393291;6334.208223972004;6410.61536307823;6424.967875160688;6426.550141490145;6427.164468619049;5763.567732420001;5842.737076831553;5848.2689663792025;5961.433663801932;5989.9101513477335;6834.350736680008;6910.654467276717;6979.790606281819;6995.020697102512;7050.647467626495;6788.7284508619105;6790.7623233186605;6798.286179951034;6809.591424514545;6828;6940.6182659952165;6952.965235173791;6990.580565166107;7038.824029399306;7045.612491313027;6421.486281097595;6517.902231466626;6556.967215163893;6613.636250006103;6672.366125218096;6769.323067693192;6784.7964561063245;6797.1843378794865;6797.728090876507;6798.626075565891;6318.336574659595;6407.967960160169;6427.775027874002;6451.580647257913;6503.154589903283;6422.967885160544;6423.582467139621;6433.871322573429;6449.645269510222;6451.54839161273;6131.713108457373;6313.463355614824;6315.368463153648;6362.936370636235;6373.107764913008;5161.974190129025;6500.967495162683;6554.115194448879;6583.572067815577;6619.867602648016;6436.420722134843;6447.2263328400895;6459.450946669398;6463.935360646521;6476.6114033158165 08:12:02 INFO - PID 1632 | |1;ext.html;694.6457306773545;748.5172064018708;822.3996482567724;1111.24435383939;1232.6548566401411;36491.81754091229;37547;37589.81205093974;37645.62354376455;37694;37774.24451510968;37985.24029519408;38169.23661526775;38199.809000954956;38232;6683.198016238058;8056.959715201445;8377.287930525912;8517.53153576553;8588.098249683788;8567.785805354884;8599.828003439927;8633.525156116411;8653.826923461527;8659.48043117415;8583.570821458934;8620.310375170002;8674.175953284428;8681.696140635078;8683.869741953877;7028.437724981989;7385.44905569831;8588.312934965219;8649.783755406103;8650.826983460358;7421.701202289578;8099.987501562305;8405.747827565183;8520.233179013918;8531.829363412697;37937.810310948546;37944.43083353724;38141.427878581846;38177.42733858994;38180.85457436281;3624.257027309395;3656.945145822815;3661.3043521730788;3666.431703086026;3679.4848721179055;30423.783048678026;30637.927672531576;30680;30683.84658076718;30825.383492330253;2667.919962401131;3134.764892633039;3178.1895616617844;3180.093673303121;3181.0456862941023;261828.9999999981;301572;303306;312939;320501;47049.5295047052;47157.52842471531;47211;47234.52765472301;48179.759101204974;49473.75263123661;50359.74820125949;54593.36219913409;55078.97065661347;55394.16908746372;14481.551844815645;14650.267486625626;14650.487232947009;14652;14675.633109172142;11234.831477527843;11526.827097593543;11700.88299116998;11824;11830.408479575986;12029.578964736193;13690.699383558545;14179.645508862155;14182.574522764333;14258.500952466615;5438.048341540215;5956.642601443928;6101.328853826076;6142.907856382158;6151.108089327112;987.5062468765617;1038.8285932821152;1055.9260851740457;1061.4215252687304;1085.847981282621;23733.40666483317;25033.87483062573;25193.62209566858;25203.62194567083;25224.495510089695;953.7234202081319;1145.112537783208;1170.473287020844;1173.4836671864352;1186.1578279421708;12104.697382565506;12385.090509110621;12829.9094576962;12837.293948832717;12858.871411285954;338329;339141;339854.30072849477;340442.2977885144;343637;53597.92804143895;53750;53768.92462150735;53790.73104634452;53819.46180538145;1359.8164247826614;1517.2413793103449;1549.1944189021872;1570.3090640118312;1576.4246050191598;20422.59154816925;24454.14410495624;24512.50974980526;24594.50810983806;24862.254132376056;37270;37552.061198470255;37611.81194094012;37621.62378376291;37735.05662358463;255151;255394;256446;256632;257268;35022.29955400827;35376.64623353836;35532.289354212255;35724.10689732777;35741.28517429585;36414;44856.10287794291;45409.545904541854;45507.54492455166;45564.31653525133;29418.705812941596;29827.85086074556;31009.379812404077;31521.684783151875;31765.68234317627;28412.57381139326;31153.221169470944;31258.843705781324;31584.842075789475;31641.20896977594;36189;36245.91262262136;36683.44974825326;36809.89570312895;36821.81589092038;30834.383312334077;31360.372792544476;31617.20956976094;31737.841310793297;31940;23225.419364515346;24241.393965150306;24478.388040299134;24707.75320162971;24886.875565622056 08:12:02 INFO - PID 1632 | |2;jquery.html;431.0839466134464;435.79517626715443;439.8064851465357;454.13487306680776;458.13184016289114;16681.332746690132;19513.317033903833;21565.784342156574;21693.566128677416;21938.341849744535;19373.4187974361;21105.366838994818;22342.671477982236;22473.887630561865;22767.886160569215;5931.85170370741;6258.718357673893;6292.4966002719675;6301.086342480337;6312.495000399957;5494.011078005958;5896.469317761401;6025.307089684677;6038.849028774293;6128.20333356663;5512.91730624041;5907.113932910055;6111.327753947062;6114.571979961404;6170.2904166021035;5768.163616275638;6055.455009049185;6086.3609321021095;6094.2077529920825;6104.7558097676265;4436.245838207513;5250.7112108834;5395.028894798935;5398.784048638089;5406.486383793534;19029.238830446764;26476.205713828615;27248;27538;27826.443471130464;2179.3353027326657;2246.8764217968005;2269.8865056747095;2276.704028476304;2299.482616411311;17655.5586110347;17808;17905.925644461375;18187.818121818746;18275.543111422186;2126.500272435992;2151.4406254373976;2160.25471212433;2177.0421014753456;2185.311626837557;122541;157509;160738;161157;166782.99999999878;11880.76238475243;12545.372731363395;12549.623511294676;12588.181768185039;12592.622221333375;16084.517464476085;16313.592160195853;16386.93484923476;16387.83612163887;16396.83603163977;8723;8925.464472131693;8957.193852553302;8995.145461181177;9048.321375896834;8425.831483370299;8441.324694024463;8494.575271236414;8613.3109351253;8626.5255410953;7046.295370463015;7196.892046619305;7789.766307010798;7870.055593328722;7912.643931023118;2111.4721319670084;2124.5113623866287;2129.456988467931;2130.9041093150845;2302.9769702303097;992.34009383759;1011.858339832424;1018.7504061504978;1038.1746511523356;1048.219076787798;20310.492237694176;24907.750922490544;26485.940562377287;26741.93032278726;26828.329291767863;1032.9690109296732;1038.200585549123;1043.5336758672893;1053.3153450257394;1063.5905176506947;10877.347359158475;11096.778064438666;11107.05590024857;11114.777704445865;11132.554697812158;502855;508276;513487;516424;522521;106290;115720.42139789247;129348;131984.340078299;133745;1040.921930855189;1246.7880460321585;1260.571405722059;1263.7788387032417;1267.2713189915835;20587.970601470166;21855.890720546297;21920.123195072018;21936.232231871807;21946.341609751733;55436.72281638727;56262.43737562572;56488.71755641195;57335;58182.7090864543;64453;66330.66834665796;72636.09455621715;76322.2229443621;78772;12342.876571234172;12362.3818809061;12409.565665201675;12894.935525322313;12931.5473958411;12636.810447843105;14058.789118163031;14086.098376719012;14325.498607548685;14327.641808954859;11838.526458941546;11981.700457488632;12069.336186509476;12158.392080396121;12268.263904165779;9894.653687120915;10540.841887371542;11062.557497700001;11125.888741112485;11472.369019703996;10664.626738064131;11882.881171188177;12128;12355.073369497504;12459.875401245872;11689.824652630048;11782.234154779911;12834.614961551168;12939.676508087374;12994.610161695164;11819;11855.58505452305;12146.878531214576;12207.511699531919;12247.69380765488 08:12:02 INFO - PID 1632 | |3;mootools.html;1264.8608653048166;1430.1633544376546;1450.2748625687157;1468.2952182952183;1476.8080149580555;11537.192396532235;11817.23187992781;11968.162228643998;11992.220505667137;12318;11990.220635658676;12208.084393670466;12208.511659533608;12213.328266945337;12236.388180590979;2229.3312006398096;2536.885840137189;2564.358910272432;2588.327034970912;2588.6505321781506;2480.355107672009;2520.1935380678096;2535.32813804342;2562.3850275933737;2563.2566555698827;2473.183849329717;2522.9403650466757;2548.362909272682;2557.6291437741515;2561.321249868777;2453.178185307915;2506.1729629222314;2528.4943011397704;2540.796736261095;2552.540542702313;2122.5436531145724;2447.2535876557645;2495;2503.8122140839328;2508.435601989556;11813.527458901634;11815.704607384798;11915.761684766343;11979.28124312544;11983.760324793542;5698.458646428583;6516.804495865132;6698.397144256992;6759.121314229119;6777.966110169467;3857.3442514772555;3954.228925359556;3980.960190398117;4031.8185681644395;4282.914341713179;1065.5205157678997;1229.551213806954;1275.8915492183082;1276.3235485192863;1281.8013207952781;16255;16815.6636867262;16908.83091169085;16914.323427063027;16923.984560926507;5554.055810512223;5608.887822243532;5756.827295181151;5790.94209057904;5822.767089316465;12404.131710780339;12419.875801241871;12535.498580056696;12586.748265034648;12631.684207894692;6667.899981500282;6672.499562532829;6679.56582822115;6683.331666833375;6685.933140668531;6005.459508644156;6184.690765461709;6260.718267677966;6267.435930766253;6278.372162783685;4342.674299427493;4492.505824359318;4504.684672072924;4519.502854685982;4535.251683472256;1309.8362704661918;1315.3226088564397;1327.774278372679;1335.732853429318;1340.785474324123;779.1312686354787;793.5754371411383;805.2672068417712;816.9714060007872;821.708293555791;6144.442176836883;6147.170132032118;6334.018227174795;6368.490520758328;6369.33122022181;561.859535116221;574.2907509226102;578.531389574446;589.4665327878276;590.5482306035886;3578.856845726194;3761.6614504694708;4054.3310353791885;4133.863187623368;4368.4102646143;14747;15435.845641543441;15446.0732356059;15503.457378991907;15505.84494155044;15310.770338444932;15338.846611533965;15371.385144594315;15388.615284617974;15395.692086158439;7579.317861392611;8190.50856948585;8553.187447192508;8707.303415726727;8754.737357879274;6583.63789991555;7113.2175460698245;7133.144022717307;7176.390006849476;7205.459590530836;12776;13107.344632768514;13132.40904159296;13169.275689837152;13182.802257965946;13202.537911173447;13202.603921882359;13319.134256273312;13382.397792099184;13386.330683465592;8575.91424085776;8743.213110820057;8782;8830.161134692195;8840.55797210124;10646.817402432638;10723.571057157626;10732.946335268274;10835.620753273597;10850.131989440984;9206.987231404406;9240.584173712065;9268.58291376903;9309.44143351401;9327.533623318943;9028.548572571477;9035.819283614159;9098.272138228793;9116.680916167903;9271.721848344561;7201.775698131226;7376.815579610338;8210.548419836727;8376.32989360862;8376.664933402595;4962.975185124052;5832.883342333214;6132.264128304632;6179.84550386244;6235.345288744798;4736.3842700450095;6064.241969753781;6067.484263837447;6251.68741562911;6362.395572420613 08:12:02 INFO - PID 1632 | |4;prototype.html;364.35145441114815;374.72832196657424;378.71992664793;388.86972864090535;389.43726315474134;5002.349224755831;5648.983183027049;6024.548158888079;6232.818513520271;6236.688165591725;4958.429780575235;5172.3793144822575;5840.912386314209;6029.216201893759;6069.393060693928;4316.2662347400865;4425.734455932647;4441.88895277619;4453.793268846442;4459.241928872099;3561.305545418644;4438.622717069053;4462.754548499831;4477.731336119843;4505.098980203972;4421.226285400058;4422.181896349186;4433.202023635744;4439.911201775963;4453.153900758862;3814.389697648363;4280.486341638992;4431.889202769957;4435.179491794029;4436.866893993201;3454.240067185215;3790.6967442604528;3793.6775374093236;3800.1829606634706;3820.1404683946166;5875;5921.467067963861;5922.14128951304;5926;5962.970185149046;5078.847634570969;5188.533032027098;5242.7378631068295;5247.947520524784;5311.061462566136;6390.55266131371;6401.807945761635;6441.291457939623;6448.93551064488;6473.676316184172;3763.8332117043806;4292.871213863589;4302.032042790378;4311.741295522247;4343.522212556616;5321.4412486688725;6584.604923704593;6856.965715171442;6915.289452260743;6987.1266091738535;4384.0355121873135;4392.516823149451;4407.73827367752;4413.933790993137;4437.8224871004795;4253.8723838284905;4479.865604031885;4483;4497.662675299365;4513.842015529441;4921.581665558396;5091.032703786343;5255.292030090236;5316.574674026068;5319;5778.87311974161;6560.8359791005605;6567.540272180997;6576;6640.966795165993;1434.3617090394673;1491.246920305239;1509.9431678272715;1533.4402942925751;1544.343653947068;988.5946761827616;1004.5881188712739;1011.2264117949775;1014.7361685961703;1014.822406078948;5648.406917273709;5949.434803693643;6037.577369584087;6264.248290205204;6282.560220784501;6707.731690732316;6758.324167583301;6761.154855643044;6767.661616919233;6785.389314961677;5889.852753681193;6162.383761623802;6288.591241569284;6313.715882785285;6326.841828954313;3284.636875696559;3417.743669224818;3480.686738193575;3507.193345530542;3513.982430087833;6017.879642407215;6790.898136527956;6853.657317134123;7080.327368899946;7089.326513981164;6293.905591416133;6575.934240657628;6622.0929651504875;6814.727410903607;6979.499407627384;5845.766169353264;5891.528677705774;7002.719891204295;7039.225685174627;7071.902671441171;5382.703951282717;5622.353429355513;6778.7288508459105;6814.761483348059;6820.761273355409;6629.204495460575;6679.960617918932;6728.64497425897;6739.224989126314;6745.831354215988;6843.213030501556;7063.1524217094275;7081.7167313308955;7093.290670932865;7217.350438460354;4385.978070109629;4400.779961001873;4425.668074894332;4433.02730285033;4433.512313645432;5619.297587801525;6750.932490675031;6826.351496607815;6826.556273842184;6867.07294515234;5327.573794096541;6341.556091073765;6554.820132376218;6586.8353291168105;6633.005049242653;6564.704588293443;6573.5398522103;6607.339266073354;6607.7356905725155;6667.499937504804;6071.301800293023;6461.253967064073;6489.7404103835315;6492.344452164668;6500.6998600279185;6451.580647257913;6483.967580162258;6513.534454747644;6546.574472659262;6565.901511477236;5569.66582005081;6128.203333566607;6352.428281454691;6366.6180029198395;6392.137061496825 08:12:02 INFO - PID 1632 | |5;yui.html;842.8145807922255;850.8596081646529;863.0377129500607;872.0538216035601;884.7832281091131;14636;15831.366745330188;16640.916795416022;18252.361167359144;19005.239790408366;17734.733978990294;18048.548786280317;18111.72832407515;18294;18308.725369119475;976.9120779129877;991.6578780320777;995.59678330276;995.8107959487675;998.6604554451485;781.8788087846393;968.6609686609701;986.8717066781309;994.5971881388014;1004.5379125602232;1010.1867996263005;1017.9491025448735;1019.6431249062806;1021.918246540275;1022.3712416863613;987.2644879564698;998.0568362897066;1007.944563049032;1010.7473131717107;1013.4122209118693;744.3115118515352;758.4122305213449;758.4539131825132;758.8178837079116;762.4434163060996;16643.251053702614;16897.746533802;17081.48755537336;17085.572860678458;17092.65814683712;16379.91810040954;16827.91586042074;16861.325546978107;16955.915220423944;17240.482785516455;13815.963802714836;13870.514531991434;14007.579772606736;14089.64775880601;14247;2898.5797059426477;3418.9829050854587;3530.3115892400992;3545.7163426925786;3562.8218589070443;131579;132125;132158;132797;133591;12854.485820567259;13262.602121936357;13340.73318533624;13355.532556360675;13566.186028838301;19532.902335488518;24852.136089793337;25946.22161335163;26308.8684556576;26308.947642094485;6299.275583307886;7830.530168189927;7914.169012253746;7922.247386498273;7926.920730792618;3808.27642747877;3914.2171565686976;3972.64246217836;3981.1838573092446;3987.5414327352146;4102.99476628228;4184.225918205142;4218.936715949263;4219.78901054946;4233.724807887477;759.2407592407592;857.3569822633025;898.9235914947303;898.955052247385;902.9503377314179;644.5069521815815;649.9350064993463;652.0740548421253;659.9637019963948;673.7574473189648;10671.25301228922;11199;11918.761624767629;12040.277583344852;12169;630.1083966187792;645.7255666341786;658.8616390557941;660.4782222044627;661.6096503063216;5322.190455245235;5411.215373770781;5429.375621803464;5469.316335458067;5638.887222255532;91741.08258917459;97721.02278977119;99091;99702.00297996927;100103;83130;83702;85413.14586854176;85543;86071.56964215139;65910;74145.25854741491;74635;75333.24666753263;76727;12054.216475929037;12122.151449398458;12230.143889927975;12604.369781510704;12668;40023;41462.96342591339;41838.1632367357;42070.57929420789;42337.57662423459;40224;53843.19235211397;53871.191932120266;54110.18834717404;54619.72690136524;15611.141387223812;15895.920520397323;15951.601209969844;16143.112128833027;16174.757378639095;17503.649927001643;17542.947423154652;17616.735748963518;17787.110644467983;17877;15940.601484962968;16057.518274451784;16150.757738633694;16234;16261;16007.439739609523;16443;16643.91678041602;16774.49676509707;16818.411355602497;15161.848381516043;15184.46854360092;15315.15766632846;15331.846681533041;15819.209039547746;11738.471768770254;11738.530458781554;11925.940370298093;11982.460789264329;12029.578964736193;11196.38419886914;12739.55411560591;13611.455541778218;13636.113652612548;13677.658058548217 08:12:02 INFO - PID 1632 | __end_tp_report 08:12:02 INFO - PID 1632 | __start_cc_report 08:12:02 INFO - PID 1632 | _x_x_mozilla_cycle_collect,420 08:12:02 INFO - PID 1632 | __end_cc_report 08:12:02 INFO - PID 1632 | __startTimestamp1492787522124__endTimestamp 08:12:02 INFO - PID 1632 | 08:12:02 INFO - PID 1632 | ------- Summary: start ------- 08:12:02 INFO - PID 1632 | Number of tests: 6 08:12:02 INFO - PID 1632 | 08:12:02 INFO - PID 1632 | [#0] dojo.html Cycles:165 Average:6120.63 Median:6362.94 stddev:760.68 (12.0%) stddev-sans-first:726.15 08:12:02 INFO - PID 1632 | Values: 3138.3 3339.9 3604.7 3617.2 3641.5 5819.5 6080.6 6087.8 6132.6 6201.2 5140.7 6161.0 6165.5 6178.8 6225.0 5440.0 5458.2 5483.2 5493.4 5591.6 4594.8 5432.9 5498.6 5572.9 5576.7 5370.6 5437.1 5518.1 5527.9 5551.6 5441.5 5462.7 5497.8 5518.7 5556.9 5381.8 5421.2 5422.5 5423.7 5494.4 6002.6 6114.5 6157.7 6157.9 6243.2 6688.4 6741.2 6748.8 6750.7 6755.0 6809.0 6817.7 6822.0 6822.4 6844.1 6156.5 6163.1 6303.0 6326.8 6329.6 5437.8 6355.0 6518.5 6852.6 6908.8 5359.5 6335.4 6345.8 6432.1 6539.8 6594.2 6668.2 6709.6 6781.4 6804.4 6702.2 6707.9 6730.4 6730.7 6743.4 6441.6 6526.4 6611.5 6643.3 6668.3 5140.0 5327.0 5331.4 5353.4 5359.4 4714.1 4725.7 4742.5 4744.1 4761.4 4642.4 5384.4 6156.0 6196.9 6355.8 6125.1 6440.0 6781.9 6785.6 6825.5 6334.2 6410.6 6425.0 6426.6 6427.2 5763.6 5842.7 5848.3 5961.4 5989.9 6834.4 6910.7 6979.8 6995.0 7050.6 6788.7 6790.8 6798.3 6809.6 6828.0 6940.6 6953.0 6990.6 7038.8 7045.6 6421.5 6517.9 6557.0 6613.6 6672.4 6769.3 6784.8 6797.2 6797.7 6798.6 6318.3 6408.0 6427.8 6451.6 6503.2 6423.0 6423.6 6433.9 6449.6 6451.5 6131.7 6313.5 6315.4 6362.9 6373.1 5162.0 6501.0 6554.1 6583.6 6619.9 6436.4 6447.2 6459.5 6463.9 6476.6 08:12:02 INFO - PID 1632 | 08:12:02 INFO - PID 1632 | [#1] ext.html Cycles:180 Average:45146.21 Median:35199.47 stddev:78985.62 (224.4%) stddev-sans-first:79136.68 08:12:02 INFO - PID 1632 | Values: 694.6 748.5 822.4 1111.2 1232.7 36491.8 37547.0 37589.8 37645.6 37694.0 37774.2 37985.2 38169.2 38199.8 38232.0 6683.2 8057.0 8377.3 8517.5 8588.1 8567.8 8599.8 8633.5 8653.8 8659.5 8583.6 8620.3 8674.2 8681.7 8683.9 7028.4 7385.4 8588.3 8649.8 8650.8 7421.7 8100.0 8405.7 8520.2 8531.8 37937.8 37944.4 38141.4 38177.4 38180.9 3624.3 3656.9 3661.3 3666.4 3679.5 30423.8 30637.9 30680.0 30683.8 30825.4 2667.9 3134.8 3178.2 3180.1 3181.0 261829.0 301572.0 303306.0 312939.0 320501.0 47049.5 47157.5 47211.0 47234.5 48179.8 49473.8 50359.7 54593.4 55079.0 55394.2 14481.6 14650.3 14650.5 14652.0 14675.6 11234.8 11526.8 11700.9 11824.0 11830.4 12029.6 13690.7 14179.6 14182.6 14258.5 5438.0 5956.6 6101.3 6142.9 6151.1 987.5 1038.8 1055.9 1061.4 1085.8 23733.4 25033.9 25193.6 25203.6 25224.5 953.7 1145.1 1170.5 1173.5 1186.2 12104.7 12385.1 12829.9 12837.3 12858.9 338329.0 339141.0 339854.3 340442.3 343637.0 53597.9 53750.0 53768.9 53790.7 53819.5 1359.8 1517.2 1549.2 1570.3 1576.4 20422.6 24454.1 24512.5 24594.5 24862.3 37270.0 37552.1 37611.8 37621.6 37735.1 255151.0 255394.0 256446.0 256632.0 257268.0 35022.3 35376.6 35532.3 35724.1 35741.3 36414.0 44856.1 45409.5 45507.5 45564.3 29418.7 29827.9 31009.4 31521.7 31765.7 28412.6 31153.2 31258.8 31584.8 31641.2 36189.0 36245.9 36683.4 36809.9 36821.8 30834.4 31360.4 31617.2 31737.8 31940.0 23225.4 24241.4 24478.4 24707.8 24886.9 08:12:02 INFO - PID 1632 | 08:12:02 INFO - PID 1632 | [#2] jquery.html Cycles:180 Average:34463.59 Median:11858.61 stddev:87288.03 (736.1%) stddev-sans-first:87495.49 08:12:02 INFO - PID 1632 | Values: 431.1 435.8 439.8 454.1 458.1 16681.3 19513.3 21565.8 21693.6 21938.3 19373.4 21105.4 22342.7 22473.9 22767.9 5931.9 6258.7 6292.5 6301.1 6312.5 5494.0 5896.5 6025.3 6038.8 6128.2 5512.9 5907.1 6111.3 6114.6 6170.3 5768.2 6055.5 6086.4 6094.2 6104.8 4436.2 5250.7 5395.0 5398.8 5406.5 19029.2 26476.2 27248.0 27538.0 27826.4 2179.3 2246.9 2269.9 2276.7 2299.5 17655.6 17808.0 17905.9 18187.8 18275.5 2126.5 2151.4 2160.3 2177.0 2185.3 122541.0 157509.0 160738.0 161157.0 166783.0 11880.8 12545.4 12549.6 12588.2 12592.6 16084.5 16313.6 16386.9 16387.8 16396.8 8723.0 8925.5 8957.2 8995.1 9048.3 8425.8 8441.3 8494.6 8613.3 8626.5 7046.3 7196.9 7789.8 7870.1 7912.6 2111.5 2124.5 2129.5 2130.9 2303.0 992.3 1011.9 1018.8 1038.2 1048.2 20310.5 24907.8 26485.9 26741.9 26828.3 1033.0 1038.2 1043.5 1053.3 1063.6 10877.3 11096.8 11107.1 11114.8 11132.6 502855.0 508276.0 513487.0 516424.0 522521.0 106290.0 115720.4 129348.0 131984.3 133745.0 1040.9 1246.8 1260.6 1263.8 1267.3 20588.0 21855.9 21920.1 21936.2 21946.3 55436.7 56262.4 56488.7 57335.0 58182.7 64453.0 66330.7 72636.1 76322.2 78772.0 12342.9 12362.4 12409.6 12894.9 12931.5 12636.8 14058.8 14086.1 14325.5 14327.6 11838.5 11981.7 12069.3 12158.4 12268.3 9894.7 10540.8 11062.6 11125.9 11472.4 10664.6 11882.9 12128.0 12355.1 12459.9 11689.8 11782.2 12834.6 12939.7 12994.6 11819.0 11855.6 12146.9 12207.5 12247.7 08:12:02 INFO - PID 1632 | 08:12:02 INFO - PID 1632 | [#3] mootools.html Cycles:180 Average:7138.39 Median:3670.26 stddev:4591.64 (125.1%) stddev-sans-first:4583.31 08:12:02 INFO - PID 1632 | Values: 1264.9 1430.2 1450.3 1468.3 1476.8 11537.2 11817.2 11968.2 11992.2 12318.0 11990.2 12208.1 12208.5 12213.3 12236.4 2229.3 2536.9 2564.4 2588.3 2588.7 2480.4 2520.2 2535.3 2562.4 2563.3 2473.2 2522.9 2548.4 2557.6 2561.3 2453.2 2506.2 2528.5 2540.8 2552.5 2122.5 2447.3 2495.0 2503.8 2508.4 11813.5 11815.7 11915.8 11979.3 11983.8 5698.5 6516.8 6698.4 6759.1 6778.0 3857.3 3954.2 3981.0 4031.8 4282.9 1065.5 1229.6 1275.9 1276.3 1281.8 16255.0 16815.7 16908.8 16914.3 16924.0 5554.1 5608.9 5756.8 5790.9 5822.8 12404.1 12419.9 12535.5 12586.7 12631.7 6667.9 6672.5 6679.6 6683.3 6685.9 6005.5 6184.7 6260.7 6267.4 6278.4 4342.7 4492.5 4504.7 4519.5 4535.3 1309.8 1315.3 1327.8 1335.7 1340.8 779.1 793.6 805.3 817.0 821.7 6144.4 6147.2 6334.0 6368.5 6369.3 561.9 574.3 578.5 589.5 590.5 3578.9 3761.7 4054.3 4133.9 4368.4 14747.0 15435.8 15446.1 15503.5 15505.8 15310.8 15338.8 15371.4 15388.6 15395.7 7579.3 8190.5 8553.2 8707.3 8754.7 6583.6 7113.2 7133.1 7176.4 7205.5 12776.0 13107.3 13132.4 13169.3 13182.8 13202.5 13202.6 13319.1 13382.4 13386.3 8575.9 8743.2 8782.0 8830.2 8840.6 10646.8 10723.6 10732.9 10835.6 10850.1 9207.0 9240.6 9268.6 9309.4 9327.5 9028.5 9035.8 9098.3 9116.7 9271.7 7201.8 7376.8 8210.5 8376.3 8376.7 4963.0 5832.9 6132.3 6179.8 6235.3 4736.4 6064.2 6067.5 6251.7 6362.4 08:12:02 INFO - PID 1632 | 08:12:02 INFO - PID 1632 | [#4] prototype.html Cycles:180 Average:5268.95 Median:5906.50 stddev:1676.55 (28.4%) stddev-sans-first:1640.34 08:12:02 INFO - PID 1632 | Values: 364.4 374.7 378.7 388.9 389.4 5002.3 5649.0 6024.5 6232.8 6236.7 4958.4 5172.4 5840.9 6029.2 6069.4 4316.3 4425.7 4441.9 4453.8 4459.2 3561.3 4438.6 4462.8 4477.7 4505.1 4421.2 4422.2 4433.2 4439.9 4453.2 3814.4 4280.5 4431.9 4435.2 4436.9 3454.2 3790.7 3793.7 3800.2 3820.1 5875.0 5921.5 5922.1 5926.0 5963.0 5078.8 5188.5 5242.7 5247.9 5311.1 6390.6 6401.8 6441.3 6448.9 6473.7 3763.8 4292.9 4302.0 4311.7 4343.5 5321.4 6584.6 6857.0 6915.3 6987.1 4384.0 4392.5 4407.7 4413.9 4437.8 4253.9 4479.9 4483.0 4497.7 4513.8 4921.6 5091.0 5255.3 5316.6 5319.0 5778.9 6560.8 6567.5 6576.0 6641.0 1434.4 1491.2 1509.9 1533.4 1544.3 988.6 1004.6 1011.2 1014.7 1014.8 5648.4 5949.4 6037.6 6264.2 6282.6 6707.7 6758.3 6761.2 6767.7 6785.4 5889.9 6162.4 6288.6 6313.7 6326.8 3284.6 3417.7 3480.7 3507.2 3514.0 6017.9 6790.9 6853.7 7080.3 7089.3 6293.9 6575.9 6622.1 6814.7 6979.5 5845.8 5891.5 7002.7 7039.2 7071.9 5382.7 5622.4 6778.7 6814.8 6820.8 6629.2 6680.0 6728.6 6739.2 6745.8 6843.2 7063.2 7081.7 7093.3 7217.4 4386.0 4400.8 4425.7 4433.0 4433.5 5619.3 6750.9 6826.4 6826.6 6867.1 5327.6 6341.6 6554.8 6586.8 6633.0 6564.7 6573.5 6607.3 6607.7 6667.5 6071.3 6461.3 6489.7 6492.3 6500.7 6451.6 6484.0 6513.5 6546.6 6565.9 5569.7 6128.2 6352.4 6366.6 6392.1 08:12:02 INFO - PID 1632 | 08:12:02 INFO - PID 1632 | [#5] yui.html Cycles:180 Average:21236.71 Median:22192.52 stddev:29932.69 (134.9%) stddev-sans-first:29977.49 08:12:02 INFO - PID 1632 | Values: 842.8 850.9 863.0 872.1 884.8 14636.0 15831.4 16640.9 18252.4 19005.2 17734.7 18048.5 18111.7 18294.0 18308.7 976.9 991.7 995.6 995.8 998.7 781.9 968.7 986.9 994.6 1004.5 1010.2 1017.9 1019.6 1021.9 1022.4 987.3 998.1 1007.9 1010.7 1013.4 744.3 758.4 758.5 758.8 762.4 16643.3 16897.7 17081.5 17085.6 17092.7 16379.9 16827.9 16861.3 16955.9 17240.5 13816.0 13870.5 14007.6 14089.6 14247.0 2898.6 3419.0 3530.3 3545.7 3562.8 131579.0 132125.0 132158.0 132797.0 133591.0 12854.5 13262.6 13340.7 13355.5 13566.2 19532.9 24852.1 25946.2 26308.9 26308.9 6299.3 7830.5 7914.2 7922.2 7926.9 3808.3 3914.2 3972.6 3981.2 3987.5 4103.0 4184.2 4218.9 4219.8 4233.7 759.2 857.4 898.9 899.0 903.0 644.5 649.9 652.1 660.0 673.8 10671.3 11199.0 11918.8 12040.3 12169.0 630.1 645.7 658.9 660.5 661.6 5322.2 5411.2 5429.4 5469.3 5638.9 91741.1 97721.0 99091.0 99702.0 100103.0 83130.0 83702.0 85413.1 85543.0 86071.6 65910.0 74145.3 74635.0 75333.2 76727.0 12054.2 12122.2 12230.1 12604.4 12668.0 40023.0 41463.0 41838.2 42070.6 42337.6 40224.0 53843.2 53871.2 54110.2 54619.7 15611.1 15895.9 15951.6 16143.1 16174.8 17503.6 17542.9 17616.7 17787.1 17877.0 15940.6 16057.5 16150.8 16234.0 16261.0 16007.4 16443.0 16643.9 16774.5 16818.4 15161.8 15184.5 15315.2 15331.8 15819.2 11738.5 11738.5 11925.9 11982.5 12029.6 11196.4 12739.6 13611.5 13636.1 13677.7 08:12:02 INFO - PID 1632 | -------- Summary: end -------- 08:12:02 INFO - PID 1632 | 08:12:02 INFO - TEST-INFO | 1632: exit 0 08:12:02 INFO - TEST-OK | dromaeo_css | took 1114640ms 08:12:02 INFO - TEST-START | kraken 08:12:02 INFO - operating with platform_type : mac_ 08:12:02 INFO - Initialising browser for kraken test... 08:12:02 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmp0tVchj/profile http://localhost:49248/getInfo.html) 08:12:05 INFO - PID 1644 | 2017-04-21 08:12:05.293 plugin-container[1645:10249] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 08:12:05 INFO - PID 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:12:05 INFO - PID 1644 | 2017-04-21 08:12:05.297 plugin-container[1645:10249] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 08:12:05 INFO - PID 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:12:05 INFO - PID 1644 | 2017-04-21 08:12:05.297 plugin-container[1645:10249] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:12:05 INFO - PID 1644 | __metrics Screen width/height:1600/1200 08:12:05 INFO - PID 1644 | colorDepth:24 08:12:05 INFO - PID 1644 | Browser inner width/height: 1024/689 08:12:05 INFO - PID 1644 | __metrics 08:12:05 ERROR - PID 1644 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 08:12:06 INFO - TEST-INFO | 1644: exit 0 08:12:06 INFO - Browser initialized. 08:12:06 INFO - Running cycle 1/1 for kraken test... 08:12:06 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmp0tVchj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:12:09 INFO - PID 1646 | 2017-04-21 08:12:09.076 plugin-container[1647:10381] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 08:12:09 INFO - PID 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:12:09 INFO - PID 1646 | 2017-04-21 08:12:09.078 plugin-container[1647:10381] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x440f, name = 'com.apple.CFPasteboardClient' 08:12:09 INFO - PID 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:12:09 INFO - PID 1646 | 2017-04-21 08:12:09.078 plugin-container[1647:10381] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:12:18 INFO - PID 1646 | RSS: Main: 236392448 08:12:18 INFO - PID 1646 | 08:12:21 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 08:12:22 INFO - PID 1646 | RSS: Main: 249217024 08:12:22 INFO - PID 1646 | 08:12:25 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 08:12:25 INFO - PID 1646 | RSS: Main: 257437696 08:12:25 INFO - PID 1646 | 08:12:29 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 08:12:29 INFO - PID 1646 | RSS: Main: 259756032 08:12:29 INFO - PID 1646 | 08:12:31 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 08:12:32 INFO - PID 1646 | RSS: Main: 262107136 08:12:32 INFO - PID 1646 | 08:12:34 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:12:34 INFO - PID 1646 | RSS: Main: 262672384 08:12:34 INFO - PID 1646 | 08:12:37 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 08:12:38 INFO - PID 1646 | RSS: Main: 268554240 08:12:38 INFO - PID 1646 | 08:12:41 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 08:12:42 INFO - PID 1646 | RSS: Main: 269807616 08:12:42 INFO - PID 1646 | 08:12:44 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 08:12:45 INFO - PID 1646 | RSS: Main: 269463552 08:12:45 INFO - PID 1646 | 08:12:46 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:12:47 INFO - PID 1646 | RSS: Main: 268775424 08:12:47 INFO - PID 1646 | 08:12:49 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:12:50 INFO - PID 1646 | RSS: Main: 268439552 08:12:50 INFO - PID 1646 | 08:12:52 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:12:52 INFO - PID 1646 | RSS: Main: 268255232 08:12:52 INFO - PID 1646 | 08:12:55 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:12:56 INFO - PID 1646 | RSS: Main: 268496896 08:12:56 INFO - PID 1646 | 08:12:59 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:13:00 INFO - PID 1646 | RSS: Main: 268763136 08:13:00 INFO - PID 1646 | 08:13:01 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 08:13:02 INFO - PID 1646 | RSS: Main: 270516224 08:13:02 INFO - PID 1646 | 08:13:02 INFO - PID 1646 | __start_tp_report 08:13:02 INFO - PID 1646 | _x_x_mozilla_page_load 08:13:02 INFO - PID 1646 | _x_x_mozilla_page_load_details 08:13:02 INFO - PID 1646 | |i|pagename|runs| 08:13:02 INFO - PID 1646 | |0;ai-astar;102;116;114;115;114;120;114;131;165;125 08:13:02 INFO - PID 1646 | |1;audio-beat-detection;139;111;112;143;114;149;142;111;138;110 08:13:02 INFO - PID 1646 | |2;audio-dft;193;206;206;222;213;202;195;198;200;195 08:13:02 INFO - PID 1646 | |3;audio-fft;84;59;61;83;58;63;60;60;85;85 08:13:02 INFO - PID 1646 | |4;audio-oscillator;84;70;101;105;104;104;105;69;70;92 08:13:02 INFO - PID 1646 | |5;imaging-gaussian-blur;89;91;91;89;90;90;90;94;90;90 08:13:02 INFO - PID 1646 | |6;imaging-darkroom;97;99;98;98;107;97;99;97;98;97 08:13:02 INFO - PID 1646 | |7;imaging-desaturate;92;94;90;89;95;90;89;93;92;86 08:13:02 INFO - PID 1646 | |8;json-parse-financial;51;50;50;51;52;53;53;52;51;52 08:13:02 INFO - PID 1646 | |9;json-stringify-tinderbox;61;64;56;58;67;81;62;57;54;58 08:13:02 INFO - PID 1646 | |10;stanford-crypto-aes;85;85;98;105;82;85;84;82;89;79 08:13:02 INFO - PID 1646 | |11;stanford-crypto-ccm;137;136;134;135;140;127;153;126;194;157 08:13:02 INFO - PID 1646 | |12;stanford-crypto-pbkdf2;185;190;185;185;185;224;209;183;181;187 08:13:02 INFO - PID 1646 | |13;stanford-crypto-sha256-iterative;66;66;69;63;86;99;76;67;68;70 08:13:02 INFO - PID 1646 | __end_tp_report 08:13:02 INFO - PID 1646 | __start_cc_report 08:13:02 INFO - PID 1646 | _x_x_mozilla_cycle_collect,1007 08:13:02 INFO - PID 1646 | __end_cc_report 08:13:02 INFO - PID 1646 | __startTimestamp1492787582245__endTimestamp 08:13:02 INFO - PID 1646 | 08:13:02 INFO - PID 1646 | ------- Summary: start ------- 08:13:02 INFO - PID 1646 | Number of tests: 14 08:13:02 INFO - PID 1646 | 08:13:02 INFO - PID 1646 | [#0] ai-astar Cycles:10 Average:121.60 Median:118.00 stddev:17.06 (14.5%) stddev-sans-first:16.55 08:13:02 INFO - PID 1646 | Values: 102.0 116.0 114.0 115.0 114.0 120.0 114.0 131.0 165.0 125.0 08:13:02 INFO - PID 1646 | 08:13:02 INFO - PID 1646 | [#1] audio-beat-detection Cycles:10 Average:126.90 Median:138.50 stddev:16.41 (11.9%) stddev-sans-first:16.82 08:13:02 INFO - PID 1646 | Values: 139.0 111.0 112.0 143.0 114.0 149.0 142.0 111.0 138.0 110.0 08:13:02 INFO - PID 1646 | 08:13:02 INFO - PID 1646 | [#2] audio-dft Cycles:10 Average:203.00 Median:204.00 stddev:9.08 (4.5%) stddev-sans-first:8.88 08:13:02 INFO - PID 1646 | Values: 193.0 206.0 206.0 222.0 213.0 202.0 195.0 198.0 200.0 195.0 08:13:02 INFO - PID 1646 | 08:13:02 INFO - PID 1646 | [#3] audio-fft Cycles:10 Average:69.80 Median:73.00 stddev:12.51 (17.1%) stddev-sans-first:12.17 08:13:02 INFO - PID 1646 | Values: 84.0 59.0 61.0 83.0 58.0 63.0 60.0 60.0 85.0 85.0 08:13:02 INFO - PID 1646 | 08:13:02 INFO - PID 1646 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:69.50 stddev:15.78 (22.7%) stddev-sans-first:16.57 08:13:02 INFO - PID 1646 | Values: 84.0 70.0 101.0 105.0 104.0 104.0 105.0 69.0 70.0 92.0 08:13:02 INFO - PID 1646 | 08:13:02 INFO - PID 1646 | [#5] imaging-gaussian-blur Cycles:10 Average:90.40 Median:90.00 stddev:1.43 (1.6%) stddev-sans-first:1.42 08:13:02 INFO - PID 1646 | Values: 89.0 91.0 91.0 89.0 90.0 90.0 90.0 94.0 90.0 90.0 08:13:02 INFO - PID 1646 | 08:13:02 INFO - PID 1646 | [#6] imaging-darkroom Cycles:10 Average:98.70 Median:98.00 stddev:3.02 (3.1%) stddev-sans-first:3.14 08:13:02 INFO - PID 1646 | Values: 97.0 99.0 98.0 98.0 107.0 97.0 99.0 97.0 98.0 97.0 08:13:02 INFO - PID 1646 | 08:13:02 INFO - PID 1646 | [#7] imaging-desaturate Cycles:10 Average:91.00 Median:92.00 stddev:2.71 (2.9%) stddev-sans-first:2.85 08:13:02 INFO - PID 1646 | Values: 92.0 94.0 90.0 89.0 95.0 90.0 89.0 93.0 92.0 86.0 08:13:02 INFO - PID 1646 | 08:13:02 INFO - PID 1646 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:52.00 stddev:1.08 (2.1%) stddev-sans-first:1.13 08:13:02 INFO - PID 1646 | Values: 51.0 50.0 50.0 51.0 52.0 53.0 53.0 52.0 51.0 52.0 08:13:02 INFO - PID 1646 | 08:13:02 INFO - PID 1646 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:61.50 stddev:7.80 (12.7%) stddev-sans-first:8.27 08:13:02 INFO - PID 1646 | Values: 61.0 64.0 56.0 58.0 67.0 81.0 62.0 57.0 54.0 58.0 08:13:02 INFO - PID 1646 | 08:13:02 INFO - PID 1646 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:85.00 stddev:8.04 (9.5%) stddev-sans-first:8.49 08:13:02 INFO - PID 1646 | Values: 85.0 85.0 98.0 105.0 82.0 85.0 84.0 82.0 89.0 79.0 08:13:02 INFO - PID 1646 | 08:13:02 INFO - PID 1646 | [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:138.50 stddev:20.20 (14.6%) stddev-sans-first:21.27 08:13:02 INFO - PID 1646 | Values: 137.0 136.0 134.0 135.0 140.0 127.0 153.0 126.0 194.0 157.0 08:13:02 INFO - PID 1646 | 08:13:02 INFO - PID 1646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.40 Median:186.00 stddev:13.89 (7.5%) stddev-sans-first:14.54 08:13:02 INFO - PID 1646 | Values: 185.0 190.0 185.0 185.0 185.0 224.0 209.0 183.0 181.0 187.0 08:13:02 INFO - PID 1646 | 08:13:02 INFO - PID 1646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:69.50 stddev:11.24 (16.2%) stddev-sans-first:11.64 08:13:02 INFO - PID 1646 | Values: 66.0 66.0 69.0 63.0 86.0 99.0 76.0 67.0 68.0 70.0 08:13:02 INFO - PID 1646 | -------- Summary: end -------- 08:13:02 INFO - PID 1646 | 08:13:03 INFO - TEST-INFO | 1646: exit 0 08:13:03 INFO - TEST-OK | kraken | took 60507ms 08:13:03 INFO - SUITE-END | took 1175s 08:13:03 INFO - Completed test suite (00:19:35) 08:13:03 INFO - javascript benchmark 08:13:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7863.056697873964, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3138.3252600690853, 3339.8831040913556, 3604.729645276604, 3617.2403795203004, 3641.4901913732065, 5819.476247137757, 6080.571065799539, 6087.817365479032, 6132.570720049598, 6201.193844800176, 5140.665856719311, 6160.952638051531, 6165.506759459244, 6178.752849885999, 6224.968875155618, 5440.047991601474, 5458.235846981426, 5483.177523371506, 5493.368262649807, 5591.552675785948, 4594.816207351702, 5432.91850622241, 5498.615096943216, 5572.888542229153, 5576.693281869496, 5370.57035437168, 5437.102878025121, 5518.061929471999, 5527.889442211173, 5551.639143455683, 5441.537469315113, 5462.726863656841, 5497.752601132958, 5518.696471694056, 5556.9444305556835, 5381.784728610851, 5421.21392398104, 5422.511973922326, 5423.701696406696, 5494.423085576037, 6002.579819412643, 6114.480269177126, 6157.692115394212, 6157.938420615781, 6243.157173781527, 6688.431483323923, 6741.224759152711, 6748.7637932672615, 6750.696218670171, 6755.0, 6808.9659551701925, 6817.69320380584, 6821.965890170567, 6822.3859852613, 6844.1444819397575, 6156.507479401637, 6163.106349579286, 6302.968485157545, 6326.810195694091, 6329.588576742543, 5437.782488700408, 6354.951433013501, 6518.511111666644, 6852.588844669236, 6908.758193463204, 5359.544438722674, 6335.366463353628, 6345.809625711144, 6432.09950606906, 6539.836504087436, 6594.241662208811, 6668.233153187445, 6709.630970296583, 6781.38967492928, 6804.4216241620015, 6702.19573651165, 6707.899381509281, 6730.394264516217, 6730.730770769114, 6743.35938085881, 6441.64570948593, 6526.445252153525, 6611.537192396582, 6643.269240383554, 6668.266490686021, 5139.974300128551, 5327.0411325961695, 5331.360236771612, 5353.357597088374, 5359.410464848864, 4714.057188562301, 4725.7164570125215, 4742.549457801503, 4744.122337367598, 4761.40482439695, 4642.396488456547, 5384.434634363335, 6156.015037593964, 6196.938030619726, 6355.809325720235, 6125.111858780452, 6440.001799721051, 6781.932180678229, 6785.626790526469, 6825.488088393291, 6334.208223972004, 6410.61536307823, 6424.967875160688, 6426.550141490145, 6427.164468619049, 5763.567732420001, 5842.737076831553, 5848.2689663792025, 5961.433663801932, 5989.9101513477335, 6834.350736680008, 6910.654467276717, 6979.790606281819, 6995.020697102512, 7050.647467626495, 6788.7284508619105, 6790.7623233186605, 6798.286179951034, 6809.591424514545, 6828.0, 6940.6182659952165, 6952.965235173791, 6990.580565166107, 7038.824029399306, 7045.612491313027, 6421.486281097595, 6517.902231466626, 6556.967215163893, 6613.636250006103, 6672.366125218096, 6769.323067693192, 6784.7964561063245, 6797.1843378794865, 6797.728090876507, 6798.626075565891, 6318.336574659595, 6407.967960160169, 6427.775027874002, 6451.580647257913, 6503.154589903283, 6422.967885160544, 6423.582467139621, 6433.871322573429, 6449.645269510222, 6451.54839161273, 6131.713108457373, 6313.463355614824, 6315.368463153648, 6362.936370636235, 6373.107764913008, 5161.974190129025, 6500.967495162683, 6554.115194448879, 6583.572067815577, 6619.867602648016, 6436.420722134843, 6447.2263328400895, 6459.450946669398, 6463.935360646521, 6476.6114033158165], "value": 6069.882952049581, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.6457306773545, 748.5172064018708, 822.3996482567724, 1111.24435383939, 1232.6548566401411, 36491.81754091229, 37547.0, 37589.81205093974, 37645.62354376455, 37694.0, 37774.24451510968, 37985.24029519408, 38169.23661526775, 38199.809000954956, 38232.0, 6683.198016238058, 8056.959715201445, 8377.287930525912, 8517.53153576553, 8588.098249683788, 8567.785805354884, 8599.828003439927, 8633.525156116411, 8653.826923461527, 8659.48043117415, 8583.570821458934, 8620.310375170002, 8674.175953284428, 8681.696140635078, 8683.869741953877, 7028.437724981989, 7385.44905569831, 8588.312934965219, 8649.783755406103, 8650.826983460358, 7421.701202289578, 8099.987501562305, 8405.747827565183, 8520.233179013918, 8531.829363412697, 37937.810310948546, 37944.43083353724, 38141.427878581846, 38177.42733858994, 38180.85457436281, 3624.257027309395, 3656.945145822815, 3661.3043521730788, 3666.431703086026, 3679.4848721179055, 30423.783048678026, 30637.927672531576, 30680.0, 30683.84658076718, 30825.383492330253, 2667.919962401131, 3134.764892633039, 3178.1895616617844, 3180.093673303121, 3181.0456862941023, 261828.9999999981, 301572.0, 303306.0, 312939.0, 320501.0, 47049.5295047052, 47157.52842471531, 47211.0, 47234.52765472301, 48179.759101204974, 49473.75263123661, 50359.74820125949, 54593.36219913409, 55078.97065661347, 55394.16908746372, 14481.551844815645, 14650.267486625626, 14650.487232947009, 14652.0, 14675.633109172142, 11234.831477527843, 11526.827097593543, 11700.88299116998, 11824.0, 11830.408479575986, 12029.578964736193, 13690.699383558545, 14179.645508862155, 14182.574522764333, 14258.500952466615, 5438.048341540215, 5956.642601443928, 6101.328853826076, 6142.907856382158, 6151.108089327112, 987.5062468765617, 1038.8285932821152, 1055.9260851740457, 1061.4215252687304, 1085.847981282621, 23733.40666483317, 25033.87483062573, 25193.62209566858, 25203.62194567083, 25224.495510089695, 953.7234202081319, 1145.112537783208, 1170.473287020844, 1173.4836671864352, 1186.1578279421708, 12104.697382565506, 12385.090509110621, 12829.9094576962, 12837.293948832717, 12858.871411285954, 338329.0, 339141.0, 339854.30072849477, 340442.2977885144, 343637.0, 53597.92804143895, 53750.0, 53768.92462150735, 53790.73104634452, 53819.46180538145, 1359.8164247826614, 1517.2413793103449, 1549.1944189021872, 1570.3090640118312, 1576.4246050191598, 20422.59154816925, 24454.14410495624, 24512.50974980526, 24594.50810983806, 24862.254132376056, 37270.0, 37552.061198470255, 37611.81194094012, 37621.62378376291, 37735.05662358463, 255151.0, 255394.0, 256446.0, 256632.0, 257268.0, 35022.29955400827, 35376.64623353836, 35532.289354212255, 35724.10689732777, 35741.28517429585, 36414.0, 44856.10287794291, 45409.545904541854, 45507.54492455166, 45564.31653525133, 29418.705812941596, 29827.85086074556, 31009.379812404077, 31521.684783151875, 31765.68234317627, 28412.57381139326, 31153.221169470944, 31258.843705781324, 31584.842075789475, 31641.20896977594, 36189.0, 36245.91262262136, 36683.44974825326, 36809.89570312895, 36821.81589092038, 30834.383312334077, 31360.372792544476, 31617.20956976094, 31737.841310793297, 31940.0, 23225.419364515346, 24241.393965150306, 24478.388040299134, 24707.75320162971, 24886.875565622056], "value": 17594.64485488519, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.0839466134464, 435.79517626715443, 439.8064851465357, 454.13487306680776, 458.13184016289114, 16681.332746690132, 19513.317033903833, 21565.784342156574, 21693.566128677416, 21938.341849744535, 19373.4187974361, 21105.366838994818, 22342.671477982236, 22473.887630561865, 22767.886160569215, 5931.85170370741, 6258.718357673893, 6292.4966002719675, 6301.086342480337, 6312.495000399957, 5494.011078005958, 5896.469317761401, 6025.307089684677, 6038.849028774293, 6128.20333356663, 5512.91730624041, 5907.113932910055, 6111.327753947062, 6114.571979961404, 6170.2904166021035, 5768.163616275638, 6055.455009049185, 6086.3609321021095, 6094.2077529920825, 6104.7558097676265, 4436.245838207513, 5250.7112108834, 5395.028894798935, 5398.784048638089, 5406.486383793534, 19029.238830446764, 26476.205713828615, 27248.0, 27538.0, 27826.443471130464, 2179.3353027326657, 2246.8764217968005, 2269.8865056747095, 2276.704028476304, 2299.482616411311, 17655.5586110347, 17808.0, 17905.925644461375, 18187.818121818746, 18275.543111422186, 2126.500272435992, 2151.4406254373976, 2160.25471212433, 2177.0421014753456, 2185.311626837557, 122541.0, 157509.0, 160738.0, 161157.0, 166782.99999999878, 11880.76238475243, 12545.372731363395, 12549.623511294676, 12588.181768185039, 12592.622221333375, 16084.517464476085, 16313.592160195853, 16386.93484923476, 16387.83612163887, 16396.83603163977, 8723.0, 8925.464472131693, 8957.193852553302, 8995.145461181177, 9048.321375896834, 8425.831483370299, 8441.324694024463, 8494.575271236414, 8613.3109351253, 8626.5255410953, 7046.295370463015, 7196.892046619305, 7789.766307010798, 7870.055593328722, 7912.643931023118, 2111.4721319670084, 2124.5113623866287, 2129.456988467931, 2130.9041093150845, 2302.9769702303097, 992.34009383759, 1011.858339832424, 1018.7504061504978, 1038.1746511523356, 1048.219076787798, 20310.492237694176, 24907.750922490544, 26485.940562377287, 26741.93032278726, 26828.329291767863, 1032.9690109296732, 1038.200585549123, 1043.5336758672893, 1053.3153450257394, 1063.5905176506947, 10877.347359158475, 11096.778064438666, 11107.05590024857, 11114.777704445865, 11132.554697812158, 502855.0, 508276.0, 513487.0, 516424.0, 522521.0, 106290.0, 115720.42139789247, 129348.0, 131984.340078299, 133745.0, 1040.921930855189, 1246.7880460321585, 1260.571405722059, 1263.7788387032417, 1267.2713189915835, 20587.970601470166, 21855.890720546297, 21920.123195072018, 21936.232231871807, 21946.341609751733, 55436.72281638727, 56262.43737562572, 56488.71755641195, 57335.0, 58182.7090864543, 64453.0, 66330.66834665796, 72636.09455621715, 76322.2229443621, 78772.0, 12342.876571234172, 12362.3818809061, 12409.565665201675, 12894.935525322313, 12931.5473958411, 12636.810447843105, 14058.789118163031, 14086.098376719012, 14325.498607548685, 14327.641808954859, 11838.526458941546, 11981.700457488632, 12069.336186509476, 12158.392080396121, 12268.263904165779, 9894.653687120915, 10540.841887371542, 11062.557497700001, 11125.888741112485, 11472.369019703996, 10664.626738064131, 11882.881171188177, 12128.0, 12355.073369497504, 12459.875401245872, 11689.824652630048, 11782.234154779911, 12834.614961551168, 12939.676508087374, 12994.610161695164, 11819.0, 11855.58505452305, 12146.878531214576, 12207.511699531919, 12247.69380765488], "value": 10645.685857822098, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1264.8608653048166, 1430.1633544376546, 1450.2748625687157, 1468.2952182952183, 1476.8080149580555, 11537.192396532235, 11817.23187992781, 11968.162228643998, 11992.220505667137, 12318.0, 11990.220635658676, 12208.084393670466, 12208.511659533608, 12213.328266945337, 12236.388180590979, 2229.3312006398096, 2536.885840137189, 2564.358910272432, 2588.327034970912, 2588.6505321781506, 2480.355107672009, 2520.1935380678096, 2535.32813804342, 2562.3850275933737, 2563.2566555698827, 2473.183849329717, 2522.9403650466757, 2548.362909272682, 2557.6291437741515, 2561.321249868777, 2453.178185307915, 2506.1729629222314, 2528.4943011397704, 2540.796736261095, 2552.540542702313, 2122.5436531145724, 2447.2535876557645, 2495.0, 2503.8122140839328, 2508.435601989556, 11813.527458901634, 11815.704607384798, 11915.761684766343, 11979.28124312544, 11983.760324793542, 5698.458646428583, 6516.804495865132, 6698.397144256992, 6759.121314229119, 6777.966110169467, 3857.3442514772555, 3954.228925359556, 3980.960190398117, 4031.8185681644395, 4282.914341713179, 1065.5205157678997, 1229.551213806954, 1275.8915492183082, 1276.3235485192863, 1281.8013207952781, 16255.0, 16815.6636867262, 16908.83091169085, 16914.323427063027, 16923.984560926507, 5554.055810512223, 5608.887822243532, 5756.827295181151, 5790.94209057904, 5822.767089316465, 12404.131710780339, 12419.875801241871, 12535.498580056696, 12586.748265034648, 12631.684207894692, 6667.899981500282, 6672.499562532829, 6679.56582822115, 6683.331666833375, 6685.933140668531, 6005.459508644156, 6184.690765461709, 6260.718267677966, 6267.435930766253, 6278.372162783685, 4342.674299427493, 4492.505824359318, 4504.684672072924, 4519.502854685982, 4535.251683472256, 1309.8362704661918, 1315.3226088564397, 1327.774278372679, 1335.732853429318, 1340.785474324123, 779.1312686354787, 793.5754371411383, 805.2672068417712, 816.9714060007872, 821.708293555791, 6144.442176836883, 6147.170132032118, 6334.018227174795, 6368.490520758328, 6369.33122022181, 561.859535116221, 574.2907509226102, 578.531389574446, 589.4665327878276, 590.5482306035886, 3578.856845726194, 3761.6614504694708, 4054.3310353791885, 4133.863187623368, 4368.4102646143, 14747.0, 15435.845641543441, 15446.0732356059, 15503.457378991907, 15505.84494155044, 15310.770338444932, 15338.846611533965, 15371.385144594315, 15388.615284617974, 15395.692086158439, 7579.317861392611, 8190.50856948585, 8553.187447192508, 8707.303415726727, 8754.737357879274, 6583.63789991555, 7113.2175460698245, 7133.144022717307, 7176.390006849476, 7205.459590530836, 12776.0, 13107.344632768514, 13132.40904159296, 13169.275689837152, 13182.802257965946, 13202.537911173447, 13202.603921882359, 13319.134256273312, 13382.397792099184, 13386.330683465592, 8575.91424085776, 8743.213110820057, 8782.0, 8830.161134692195, 8840.55797210124, 10646.817402432638, 10723.571057157626, 10732.946335268274, 10835.620753273597, 10850.131989440984, 9206.987231404406, 9240.584173712065, 9268.58291376903, 9309.44143351401, 9327.533623318943, 9028.548572571477, 9035.819283614159, 9098.272138228793, 9116.680916167903, 9271.721848344561, 7201.775698131226, 7376.815579610338, 8210.548419836727, 8376.32989360862, 8376.664933402595, 4962.975185124052, 5832.883342333214, 6132.264128304632, 6179.84550386244, 6235.345288744798, 4736.3842700450095, 6064.241969753781, 6067.484263837447, 6251.68741562911, 6362.395572420613], "value": 5321.853670675259, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.35145441114815, 374.72832196657424, 378.71992664793, 388.86972864090535, 389.43726315474134, 5002.349224755831, 5648.983183027049, 6024.548158888079, 6232.818513520271, 6236.688165591725, 4958.429780575235, 5172.3793144822575, 5840.912386314209, 6029.216201893759, 6069.393060693928, 4316.2662347400865, 4425.734455932647, 4441.88895277619, 4453.793268846442, 4459.241928872099, 3561.305545418644, 4438.622717069053, 4462.754548499831, 4477.731336119843, 4505.098980203972, 4421.226285400058, 4422.181896349186, 4433.202023635744, 4439.911201775963, 4453.153900758862, 3814.389697648363, 4280.486341638992, 4431.889202769957, 4435.179491794029, 4436.866893993201, 3454.240067185215, 3790.6967442604528, 3793.6775374093236, 3800.1829606634706, 3820.1404683946166, 5875.0, 5921.467067963861, 5922.14128951304, 5926.0, 5962.970185149046, 5078.847634570969, 5188.533032027098, 5242.7378631068295, 5247.947520524784, 5311.061462566136, 6390.55266131371, 6401.807945761635, 6441.291457939623, 6448.93551064488, 6473.676316184172, 3763.8332117043806, 4292.871213863589, 4302.032042790378, 4311.741295522247, 4343.522212556616, 5321.4412486688725, 6584.604923704593, 6856.965715171442, 6915.289452260743, 6987.1266091738535, 4384.0355121873135, 4392.516823149451, 4407.73827367752, 4413.933790993137, 4437.8224871004795, 4253.8723838284905, 4479.865604031885, 4483.0, 4497.662675299365, 4513.842015529441, 4921.581665558396, 5091.032703786343, 5255.292030090236, 5316.574674026068, 5319.0, 5778.87311974161, 6560.8359791005605, 6567.540272180997, 6576.0, 6640.966795165993, 1434.3617090394673, 1491.246920305239, 1509.9431678272715, 1533.4402942925751, 1544.343653947068, 988.5946761827616, 1004.5881188712739, 1011.2264117949775, 1014.7361685961703, 1014.822406078948, 5648.406917273709, 5949.434803693643, 6037.577369584087, 6264.248290205204, 6282.560220784501, 6707.731690732316, 6758.324167583301, 6761.154855643044, 6767.661616919233, 6785.389314961677, 5889.852753681193, 6162.383761623802, 6288.591241569284, 6313.715882785285, 6326.841828954313, 3284.636875696559, 3417.743669224818, 3480.686738193575, 3507.193345530542, 3513.982430087833, 6017.879642407215, 6790.898136527956, 6853.657317134123, 7080.327368899946, 7089.326513981164, 6293.905591416133, 6575.934240657628, 6622.0929651504875, 6814.727410903607, 6979.499407627384, 5845.766169353264, 5891.528677705774, 7002.719891204295, 7039.225685174627, 7071.902671441171, 5382.703951282717, 5622.353429355513, 6778.7288508459105, 6814.761483348059, 6820.761273355409, 6629.204495460575, 6679.960617918932, 6728.64497425897, 6739.224989126314, 6745.831354215988, 6843.213030501556, 7063.1524217094275, 7081.7167313308955, 7093.290670932865, 7217.350438460354, 4385.978070109629, 4400.779961001873, 4425.668074894332, 4433.02730285033, 4433.512313645432, 5619.297587801525, 6750.932490675031, 6826.351496607815, 6826.556273842184, 6867.07294515234, 5327.573794096541, 6341.556091073765, 6554.820132376218, 6586.8353291168105, 6633.005049242653, 6564.704588293443, 6573.5398522103, 6607.339266073354, 6607.7356905725155, 6667.499937504804, 6071.301800293023, 6461.253967064073, 6489.7404103835315, 6492.344452164668, 6500.6998600279185, 6451.580647257913, 6483.967580162258, 6513.534454747644, 6546.574472659262, 6565.901511477236, 5569.66582005081, 6128.203333566607, 6352.428281454691, 6366.6180029198395, 6392.137061496825], "value": 4740.215542035902, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [842.8145807922255, 850.8596081646529, 863.0377129500607, 872.0538216035601, 884.7832281091131, 14636.0, 15831.366745330188, 16640.916795416022, 18252.361167359144, 19005.239790408366, 17734.733978990294, 18048.548786280317, 18111.72832407515, 18294.0, 18308.725369119475, 976.9120779129877, 991.6578780320777, 995.59678330276, 995.8107959487675, 998.6604554451485, 781.8788087846393, 968.6609686609701, 986.8717066781309, 994.5971881388014, 1004.5379125602232, 1010.1867996263005, 1017.9491025448735, 1019.6431249062806, 1021.918246540275, 1022.3712416863613, 987.2644879564698, 998.0568362897066, 1007.944563049032, 1010.7473131717107, 1013.4122209118693, 744.3115118515352, 758.4122305213449, 758.4539131825132, 758.8178837079116, 762.4434163060996, 16643.251053702614, 16897.746533802, 17081.48755537336, 17085.572860678458, 17092.65814683712, 16379.91810040954, 16827.91586042074, 16861.325546978107, 16955.915220423944, 17240.482785516455, 13815.963802714836, 13870.514531991434, 14007.579772606736, 14089.64775880601, 14247.0, 2898.5797059426477, 3418.9829050854587, 3530.3115892400992, 3545.7163426925786, 3562.8218589070443, 131579.0, 132125.0, 132158.0, 132797.0, 133591.0, 12854.485820567259, 13262.602121936357, 13340.73318533624, 13355.532556360675, 13566.186028838301, 19532.902335488518, 24852.136089793337, 25946.22161335163, 26308.8684556576, 26308.947642094485, 6299.275583307886, 7830.530168189927, 7914.169012253746, 7922.247386498273, 7926.920730792618, 3808.27642747877, 3914.2171565686976, 3972.64246217836, 3981.1838573092446, 3987.5414327352146, 4102.99476628228, 4184.225918205142, 4218.936715949263, 4219.78901054946, 4233.724807887477, 759.2407592407592, 857.3569822633025, 898.9235914947303, 898.955052247385, 902.9503377314179, 644.5069521815815, 649.9350064993463, 652.0740548421253, 659.9637019963948, 673.7574473189648, 10671.25301228922, 11199.0, 11918.761624767629, 12040.277583344852, 12169.0, 630.1083966187792, 645.7255666341786, 658.8616390557941, 660.4782222044627, 661.6096503063216, 5322.190455245235, 5411.215373770781, 5429.375621803464, 5469.316335458067, 5638.887222255532, 91741.08258917459, 97721.02278977119, 99091.0, 99702.00297996927, 100103.0, 83130.0, 83702.0, 85413.14586854176, 85543.0, 86071.56964215139, 65910.0, 74145.25854741491, 74635.0, 75333.24666753263, 76727.0, 12054.216475929037, 12122.151449398458, 12230.143889927975, 12604.369781510704, 12668.0, 40023.0, 41462.96342591339, 41838.1632367357, 42070.57929420789, 42337.57662423459, 40224.0, 53843.19235211397, 53871.191932120266, 54110.18834717404, 54619.72690136524, 15611.141387223812, 15895.920520397323, 15951.601209969844, 16143.112128833027, 16174.757378639095, 17503.649927001643, 17542.947423154652, 17616.735748963518, 17787.110644467983, 17877.0, 15940.601484962968, 16057.518274451784, 16150.757738633694, 16234.0, 16261.0, 16007.439739609523, 16443.0, 16643.91678041602, 16774.49676509707, 16818.411355602497, 15161.848381516043, 15184.46854360092, 15315.15766632846, 15331.846681533041, 15819.209039547746, 11738.471768770254, 11738.530458781554, 11925.940370298093, 11982.460789264329, 12029.578964736193, 11196.38419886914, 12739.55411560591, 13611.455541778218, 13636.113652612548, 13677.658058548217], "value": 8239.889711904305, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1500.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 116.0, 114.0, 115.0, 114.0, 120.0, 114.0, 131.0, 165.0, 125.0], "value": 121.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 111.0, 112.0, 143.0, 114.0, 149.0, 142.0, 111.0, 138.0, 110.0], "value": 126.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 206.0, 206.0, 222.0, 213.0, 202.0, 195.0, 198.0, 200.0, 195.0], "value": 203.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 61.0, 83.0, 58.0, 63.0, 60.0, 60.0, 85.0, 85.0], "value": 69.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 101.0, 105.0, 104.0, 104.0, 105.0, 69.0, 70.0, 92.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 91.0, 91.0, 89.0, 90.0, 90.0, 90.0, 94.0, 90.0, 90.0], "value": 90.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 99.0, 98.0, 98.0, 107.0, 97.0, 99.0, 97.0, 98.0, 97.0], "value": 98.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 90.0, 89.0, 95.0, 90.0, 89.0, 93.0, 92.0, 86.0], "value": 91.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 50.0, 51.0, 52.0, 53.0, 53.0, 52.0, 51.0, 52.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 64.0, 56.0, 58.0, 67.0, 81.0, 62.0, 57.0, 54.0, 58.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 98.0, 105.0, 82.0, 85.0, 84.0, 82.0, 89.0, 79.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 134.0, 135.0, 140.0, 127.0, 153.0, 126.0, 194.0, 157.0], "value": 143.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 190.0, 185.0, 185.0, 185.0, 224.0, 209.0, 183.0, 181.0, 187.0], "value": 191.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 69.0, 63.0, 86.0, 99.0, 76.0, 67.0, 68.0, 70.0], "value": 73.0, "unit": "score"}]}]} 08:13:03 INFO - Return code: 0 08:13:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:13:03 ERROR - # TBPL SUCCESS # 08:13:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:13:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:13:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:13:03 INFO - 2017-04-21 08:13:03.577 screenresolution[1651:10769] starting screenresolution argv=screenresolution get 08:13:03 INFO - 2017-04-21 08:13:03.582 screenresolution[1651:10769] Display 0: 1600x1200x32@60 08:13:03 INFO - 2017-04-21 08:13:03.588 screenresolution[1652:10772] starting screenresolution argv=screenresolution list 08:13:03 INFO - Available Modes on Display 0 08:13:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:13:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:13:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:13:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:13:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:13:03 INFO - Intel Iris: 08:13:03 INFO - Chipset Model: Intel Iris 08:13:03 INFO - Type: GPU 08:13:03 INFO - Bus: Built-In 08:13:03 INFO - VRAM (Dynamic, Max): 1536 MB 08:13:03 INFO - Vendor: Intel (0x8086) 08:13:03 INFO - Device ID: 0x0a2e 08:13:03 INFO - Revision ID: 0x0009 08:13:03 INFO - Displays: 08:13:03 INFO - Display: 08:13:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:13:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:13:03 INFO - Display Serial Number: 1600x1200 60 08:13:03 INFO - Main Display: Yes 08:13:03 INFO - Mirror: Off 08:13:03 INFO - Online: Yes 08:13:03 INFO - Rotation: Supported 08:13:03 INFO - Return code: 0 08:13:03 INFO - Running post-action listener: _resource_record_post_action 08:13:03 INFO - [mozharness: 2017-04-21 15:13:03.831312Z] Finished run-tests step (success) 08:13:03 INFO - Running post-run listener: _resource_record_post_run 08:13:03 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 40409600; Write bytes: 519035904; Read time: 393; Write time: 1815 08:13:03 INFO - TinderboxPrint: CPU usage
54.0% 08:13:03 INFO - TinderboxPrint: I/O read bytes / time
40,409,600 / 393 08:13:03 INFO - TinderboxPrint: I/O write bytes / time
519,035,904 / 1,815 08:13:03 INFO - TinderboxPrint: CPU idle
2,200.6 (46.0%) 08:13:03 INFO - TinderboxPrint: CPU system
957.9 (20.0%) 08:13:03 INFO - TinderboxPrint: CPU user
1,627.1 (34.0%) 08:13:03 INFO - TinderboxPrint: Swap in / out
248,520,704 / 0 08:13:03 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207641088; Write bytes: 205350912; Read time: 16076; Write time: 447 08:13:03 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 35416576; Write bytes: 306492416; Read time: 356; Write time: 1339 08:13:04 INFO - Running post-run listener: _upload_blobber_files 08:13:04 INFO - Blob upload gear active. 08:13:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:13:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:13:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:13:04 INFO - (blobuploader) - INFO - Open directory for files ... 08:13:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:13:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:13:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:13:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:13:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:13:05 INFO - (blobuploader) - INFO - Done attempting. 08:13:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:13:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:13:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:13:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:13:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:13:06 INFO - (blobuploader) - INFO - Done attempting. 08:13:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:13:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:13:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:13:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:13:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:13:08 INFO - (blobuploader) - INFO - Done attempting. 08:13:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:13:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:13:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:13:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:13:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:13:10 INFO - (blobuploader) - INFO - Done attempting. 08:13:10 INFO - (blobuploader) - INFO - Iteration through files over. 08:13:10 INFO - Return code: 0 08:13:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:13:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:13:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/383e3bc75bef7cf15292310220093e8e0a7db092691ebf5f546e0f69abb8d1c98e422211ce0264e927b6a8b6b091facca5b2ae2708c94f2dc46c26f54bcd5f33", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13a0d0575c5a1a4090d8ae4fc05ebfc54c2b780404deb256a5465c9c3009371e98ac03bfa0d69cba12a404c091c8571cde356adeadea90c4f40c41fe243a0cc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f88a56008c837d771b87626b02626492f2080be00aa46665d4d1198c8707de3c459321bb5f0809fb5d3360b0f8dd24cc5bd43298e6a85fe8d38b47593563bda", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/431ad50ca375a178de26e389f21548621138d54d4f53d975afceb6baa5fe94ade3c66836ae160b960e31668c9bd30349111851356c3df8600930564d687b0c2a"} 08:13:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:13:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:13:10 INFO - Contents: 08:13:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/383e3bc75bef7cf15292310220093e8e0a7db092691ebf5f546e0f69abb8d1c98e422211ce0264e927b6a8b6b091facca5b2ae2708c94f2dc46c26f54bcd5f33", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13a0d0575c5a1a4090d8ae4fc05ebfc54c2b780404deb256a5465c9c3009371e98ac03bfa0d69cba12a404c091c8571cde356adeadea90c4f40c41fe243a0cc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f88a56008c837d771b87626b02626492f2080be00aa46665d4d1198c8707de3c459321bb5f0809fb5d3360b0f8dd24cc5bd43298e6a85fe8d38b47593563bda", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/431ad50ca375a178de26e389f21548621138d54d4f53d975afceb6baa5fe94ade3c66836ae160b960e31668c9bd30349111851356c3df8600930564d687b0c2a"} 08:13:10 INFO - Running post-run listener: copy_logs_to_upload_dir 08:13:10 INFO - Copying logs to upload dir... 08:13:10 INFO - mkdir: /builds/slave/test/build/upload/logs 08:13:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.887204 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-04-21 08:13:10.126961) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 08:13:10.130401) ========= 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.hDxazQRp9b/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.lKsDU2zsE4/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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/383e3bc75bef7cf15292310220093e8e0a7db092691ebf5f546e0f69abb8d1c98e422211ce0264e927b6a8b6b091facca5b2ae2708c94f2dc46c26f54bcd5f33", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13a0d0575c5a1a4090d8ae4fc05ebfc54c2b780404deb256a5465c9c3009371e98ac03bfa0d69cba12a404c091c8571cde356adeadea90c4f40c41fe243a0cc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f88a56008c837d771b87626b02626492f2080be00aa46665d4d1198c8707de3c459321bb5f0809fb5d3360b0f8dd24cc5bd43298e6a85fe8d38b47593563bda", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/431ad50ca375a178de26e389f21548621138d54d4f53d975afceb6baa5fe94ade3c66836ae160b960e31668c9bd30349111851356c3df8600930564d687b0c2a"} build_url:https://queue.taskcluster.net/v1/task/e3g2k0poT8GbRBZ792rDiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011204 build_url: 'https://queue.taskcluster.net/v1/task/e3g2k0poT8GbRBZ792rDiQ/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/383e3bc75bef7cf15292310220093e8e0a7db092691ebf5f546e0f69abb8d1c98e422211ce0264e927b6a8b6b091facca5b2ae2708c94f2dc46c26f54bcd5f33", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13a0d0575c5a1a4090d8ae4fc05ebfc54c2b780404deb256a5465c9c3009371e98ac03bfa0d69cba12a404c091c8571cde356adeadea90c4f40c41fe243a0cc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f88a56008c837d771b87626b02626492f2080be00aa46665d4d1198c8707de3c459321bb5f0809fb5d3360b0f8dd24cc5bd43298e6a85fe8d38b47593563bda", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/431ad50ca375a178de26e389f21548621138d54d4f53d975afceb6baa5fe94ade3c66836ae160b960e31668c9bd30349111851356c3df8600930564d687b0c2a"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 08:13:10.169908) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 08:13:10.170354) ========= 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.hDxazQRp9b/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.lKsDU2zsE4/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.005258 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 08:13:10.220293) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 08:13:10.220654) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 08:13:10.221142) ========= ========= Total master_lag: 0.19 =========