Why 80% of Paths treated on initial load by DefaultVirtualPathProvider goes through a method where they can't be handled

Topics: Core, Customizing Orchard, Troubleshooting
Aug 6, 2013 at 8:22 AM
I was tracing for a module loading error and I noticed that I get kb of trace as this one:
Orchard.FileSystems.VirtualPath.DefaultVirtualPathProvider - Path '~/Modules/Datwendo.Commerce/../../../../lib/nhibernate/NHibernate.dll' cannot be made app relative: Too many '..'

Is it normal to spend such time in it ?
Coordinator
Aug 6, 2013 at 9:19 AM
No. Where does that come from? A reference in your project?
Aug 6, 2013 at 9:35 AM
Edited Aug 6, 2013 at 9:36 AM
As said I am tracing more info following an NH mapping problem.
I set log4net.config to
<root>
<!-- Value of priority may be ALL, DEBUG, INFO, WARN, ERROR, FATAL, OFF -->
<priority value="INFO" />

<appender-ref ref="error-file" />
<appender-ref ref="debug-file" />
</root>


-> do note there is a setting duplicated in actual log4net (no time to report issue and not major)
  <logger name="NHibernate.AdoNet.AbstractBatcher">
    <!-- Displays failed table statements that are otherwise intercepted and rendered when unexpected -->
    <priority value="OFF" />
  </logger>
Then I get more than 10000 lines as the previous from the 'Probing' phase, here is a small extract, as you will see it starts ok then turns differently
2013-08-06 00:04:10,139 [8] Orchard.Environment.Extensions.Folders.ExtensionHarvester - Done looking for extensions in '~/Modules': Bing.Maps, Contrib.BSCarouselSlide, Contrib.BSNavigation, Contrib.GoogleAnalytics, Contrib.Navigation, Contrib.ProjectionCarousel, Contrib.SecuredSocketsLayer, Datwendo.Bootstrap, Datwendo.ClientConnector, Datwendo.Commerce, Datwendo.ConnectorListener, Datwendo.Connectors, Datwendo.Contact, Datwendo.KendoUI, Datwendo.NGTW, Datwendo.PageMenu, Ipertrade.CultureLayer, LatestTwitter, Lucene, Markdown, NGM.OpenAuthentication, Nwazet.Commerce, Orchard.Alias, Orchard.AntiSpam, Orchard.ArchiveLater, Orchard.Autoroute, Orchard.Blogs, Orchard.CodeGeneration, Orchard.Comments, Orchard.ContentPermissions, Orchard.ContentPicker, Orchard.ContentTypes, Orchard.CulturePicker, Orchard.CustomForms, Orchard.DesignerTools, Orchard.Email, Orchard.Fields, Orchard.Forms, Orchard.ImageEditor, Orchard.ImportExport, Orchard.Indexing, Orchard.jQuery, Orchard.Localization, Orchard.Media, Orchard.MediaLibrary, Orchard.MediaPicker, Orchard.MediaProcessing, Orchard.Messaging, Orchard.Migrations, Orchard.Modules, Orchard.MultiTenancy, Orchard.OutputCache, Orchard.Packaging, Orchard.Pages, Orchard.Projections, Orchard.PublishLater, Orchard.Recipes, Orchard.Roles, Orchard.Scripting, Orchard.Scripting.CSharp, Orchard.Scripting.Dlr, Orchard.Search, Orchard.Setup, Orchard.Tags, Orchard.TaskLease, Orchard.Taxonomies, Orchard.Themes, Orchard.Tokens, Orchard.Users, Orchard.Warmup, Orchard.Widgets, Orchard.Workflows, SH.Robots, SysCache, Upgrade, Vandelay.Industries, WebAdvanced.Sitemap
2013-08-06 00:04:10,167 [7] Orchard.Environment.Extensions.ExtensionLoaderCoordinator - Probing extensions
2013-08-06 00:04:10,403 [13] Orchard.Environment.Extensions.Loaders.PrecompiledExtensionLoader - Probing for module 'Bing.Maps'
2013-08-06 00:04:10,404 [7] Orchard.Environment.Extensions.Loaders.PrecompiledExtensionLoader - Probing for module 'SH.Robots'
2013-08-06 00:04:10,486 [8] Orchard.Environment.Extensions.Loaders.PrecompiledExtensionLoader - Probing for module 'Lucene'
2013-08-06 00:04:10,490 [13] Orchard.Environment.Extensions.Loaders.PrecompiledExtensionLoader - Done probing for module 'Bing.Maps'
2013-08-06 00:04:10,589 [12] Orchard.Environment.Extensions.Loaders.PrecompiledExtensionLoader - Probing for module 'Orchard.jQuery'
2013-08-06 00:04:10,645 [8] Orchard.Environment.Extensions.Loaders.PrecompiledExtensionLoader - Done probing for module 'Lucene'
2013-08-06 00:04:10,669 [13] Orchard.Environment.Extensions.Loaders.DynamicExtensionLoader - Probing for module 'Bing.Maps'
2013-08-06 00:04:10,720 [12] Orchard.Environment.Extensions.Loaders.PrecompiledExtensionLoader - Done probing for module 'Orchard.jQuery'
2013-08-06 00:04:10,668 [14] Orchard.Environment.Extensions.Loaders.PrecompiledExtensionLoader - Probing for module 'Orchard.ContentPermissions'
2013-08-06 00:04:10,816 [8] Orchard.Environment.Extensions.Loaders.DynamicExtensionLoader - Probing for module 'Lucene'
2013-08-06 00:04:10,590 [7] Orchard.Environment.Extensions.Loaders.PrecompiledExtensionLoader - Done probing for module 'SH.Robots'
2013-08-06 00:04:10,763 [10] Orchard.Environment.Extensions.Loaders.PrecompiledExtensionLoader - Probing for module 'Orchard.Pages'
2013-08-06 00:04:10,860 [11] Orchard.Environment.Extensions.Loaders.PrecompiledExtensionLoader - Probing for module 'Orchard.Taxonomies'
2013-08-06 00:04:10,915 [12] Orchard.Environment.Extensions.Loaders.DynamicExtensionLoader - Probing for module 'Orchard.jQuery'
2013-08-06 00:04:10,962 [14] Orchard.Environment.Extensions.Loaders.PrecompiledExtensionLoader - Done probing for module 'Orchard.ContentPermissions'
2013-08-06 00:04:10,960 [9] Orchard.Environment.Extensions.Loaders.PrecompiledExtensionLoader - Probing for module 'Datwendo.Bootstrap'
2013-08-06 00:04:10,975 [7] Orchard.Environment.Extensions.Loaders.DynamicExtensionLoader - Probing for module 'SH.Robots'
2013-08-06 00:04:11,040 [10] Orchard.Environment.Extensions.Loaders.PrecompiledExtensionLoader - Done probing for module 'Orchard.Pages'
2013-08-06 00:04:11,041 [11] Orchard.Environment.Extensions.Loaders.PrecompiledExtensionLoader - Done probing for module 'Orchard.Taxonomies'
2013-08-06 00:04:11,065 [9] Orchard.Environment.Extensions.Loaders.PrecompiledExtensionLoader - Done probing for module 'Datwendo.Bootstrap'
2013-08-06 00:04:11,054 [14] Orchard.Environment.Extensions.Loaders.DynamicExtensionLoader - Probing for module 'Orchard.ContentPermissions'
2013-08-06 00:04:11,134 [9] Orchard.Environment.Extensions.Loaders.DynamicExtensionLoader - Probing for module 'Datwendo.Bootstrap'
2013-08-06 00:04:11,144 [14] Orchard.FileSystems.VirtualPath.DefaultVirtualPathProvider - Path '~/Modules/Orchard.ContentPermissions/../../../../lib/aspnetmvc/System.Web.Mvc.dll' cannot be made app relative: Too many '..'
2013-08-06 00:04:11,135 [13] Orchard.FileSystems.VirtualPath.DefaultVirtualPathProvider - Path '~/Modules/Bing.Maps/../../../../packages/Microsoft.Web.Infrastructure.1.0.0.0/lib/net40/Microsoft.Web.Infrastructure.dll' cannot be made app relative: Too many '..'
2013-08-06 00:04:11,135 [12] Orchard.FileSystems.VirtualPath.DefaultVirtualPathProvider - Path '~/Modules/Orchard.jQuery/../../../../lib/aspnetmvc/System.Web.Mvc.dll' cannot be made app relative: Too many '..'
2013-08-06 00:04:11,111 [11] Orchard.Environment.Extensions.Loaders.DynamicExtensionLoader - Probing for module 'Orchard.Taxonomies'
2013-08-06 00:04:11,086 [10] Orchard.Environment.Extensions.Loaders.DynamicExtensionLoader - Probing for module 'Orchard.Pages'
2013-08-06 00:04:11,135 [7] Orchard.FileSystems.VirtualPath.DefaultVirtualPathProvider - Path '~/Modules/SH.Robots/../../../../lib/aspnetmvc/System.Web.Mvc.dll' cannot be made app relative: Too many '..'
2013-08-06 00:04:11,135 [8] Orchard.FileSystems.VirtualPath.DefaultVirtualPathProvider - Path '~/Modules/Lucene/../../../../lib/lucene.net/Lucene.Net.dll' cannot be made app relative: Too many '..'
2013-08-06 00:04:11,285 [10] Orchard.FileSystems.VirtualPath.DefaultVirtualPathProvider - Path '~/Modules/Orchard.Pages/../../../Orchard/Orchard.Framework.csproj' cannot be made app relative: Too many '..'
2013-08-06 00:04:11,197 [9] Orchard.FileSystems.VirtualPath.DefaultVirtualPathProvider - Path '~/Modules/Datwendo.Bootstrap/../../../../lib/aspnetmvc/System.Web.Mvc.dll' cannot be made app relative: Too many '..'
2013-08-06 00:04:11,226 [14] Orchard.FileSystems.VirtualPath.DefaultVirtualPathProvider - Path '~/Modules/Orchard.ContentPermissions/../../../Orchard/Orchard.Framework.csproj' cannot be made app relative: Too many '..'
2013-08-06 00:04:11,252 [13] Orchard.FileSystems.VirtualPath.DefaultVirtualPathProvider - Path '~/Modules/Bing.Maps/../../../../packages/Microsoft.Net.Http.2.0.20710.0/lib/net40/System.Net.Http.dll' cannot be made app relative: Too many '..'
2013-08-06 00:04:11,275 [12] Orchard.FileSystems.VirtualPath.DefaultVirtualPathProvider - Path '~/Modules/Orchard.jQuery/../../../Orchard/Orchard.Framework.csproj' cannot be made app relative: Too many '..'
2013-08-06 00:04:11,279 [11] Orchard.FileSystems.VirtualPath.DefaultVirtualPathProvider - Path '~/Modules/Orchard.Taxonomies/../../../../lib/aspnetmvc/System.Web.Mvc.dll' cannot be made app relative: Too many '..'
2013-08-06 00:04:11,310 [7] Orchard.FileSystems.VirtualPath.DefaultVirtualPathProvider - Path '~/Modules/SH.Robots/../../../Orchard/Orchard.Framework.csproj' cannot be made app relative: Too many '..'
2013-08-06 00:04:11,335 [8] Orchard.FileSystems.VirtualPath.DefaultVirtualPathProvider - Path '~/Modules/Lucene/../../../../lib/aspnetmvc/System.Web.Mvc.dll' cannot be made app relative: Too many '..'
2013-08-06 00:04:11,349 [10] Orchard.FileSystems.VirtualPath.DefaultVirtualPathProvider - Path '~/Modules/Orchard.ContentPicker/../../../../lib/nhibernate/NHibernate.dll' cannot be made app relative: Too many '..'
Coordinator
Aug 6, 2013 at 7:58 PM
That doesn't look right. Can you please file a bug?
Aug 6, 2013 at 8:47 PM