Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Configuring IntelliJ to use cofoja #45

Open
seglo opened this issue Jul 6, 2015 · 8 comments
Open

Configuring IntelliJ to use cofoja #45

seglo opened this issue Jul 6, 2015 · 8 comments

Comments

@seglo
Copy link

seglo commented Jul 6, 2015

I'm fairly new to IntelliJ. When attempting to use cofoja code annotations I receive the following errors when building.

Error:java: error in contract: package com.google.java.contract.core.agent does not exist
Error:java: error in contract: package com.google.java.contract does not exist

My project is targeting Oracle JDK 1.7. I'm using cofoja 1.1 r-150 and IntelliJ 14.1.4.

Here's a sample cofoja project that compiles fine with maven, but that I cannot build in IntelliJ.

https://github.com/konvergeio/cofoja-example

@nhatminhle
Copy link
Owner

Can you dump the produced javac command line and show me what options are actually passed to the compiler? I think you should be able to invoke maven by hand with a debug flag (-X maybe?).

@seglo
Copy link
Author

seglo commented Jul 6, 2015

I can't figure out how to show the exact javac call with IntelliJ. I have enabled debug level build logging and it produced this (https://intellij-support.jetbrains.com/hc/en-us/articles/206827517-Locating-IDE-log-files). There are some hints on the classpath and other arguments provided to javac. I'm not sure if this is helpful to you.

2015-07-06 10:16:40,069 [      0]   INFO - etbrains.jps.cmdline.BuildMain - Build process started. Classpath: /C:/Program Files (x86)/JetBrains/IntelliJ IDEA 14.1.4/lib/jps-launcher.jar;C:/Java/jdk-7u60-windows-x64/lib/tools.jar;/C:/Program Files (x86)/JetBrains/IntelliJ IDEA 14.1.4/lib/optimizedFileManager.jar;C:/Program Files (x86)/JetBrains/IntelliJ IDEA 14.1.4/lib/ecj-4.4.jar
2015-07-06 10:16:40,114 [     45]  DEBUG - .logging.InternalLoggerFactory - Using Log4J as the default logging framework
2015-07-06 10:16:40,119 [     50]  DEBUG - nnel.MultithreadEventLoopGroup - -Dio.netty.eventLoopThreads: 8
2015-07-06 10:16:40,168 [     99]  DEBUG - il.internal.PlatformDependent0 - java.nio.Buffer.address: available
2015-07-06 10:16:40,168 [     99]  DEBUG - il.internal.PlatformDependent0 - sun.misc.Unsafe.theUnsafe: available
2015-07-06 10:16:40,169 [    100]  DEBUG - il.internal.PlatformDependent0 - sun.misc.Unsafe.copyMemory: available
2015-07-06 10:16:40,169 [    100]  DEBUG - il.internal.PlatformDependent0 - java.nio.Bits.unaligned: true
2015-07-06 10:16:40,169 [    100]  DEBUG - til.internal.PlatformDependent - Platform: Windows
2015-07-06 10:16:40,170 [    101]  DEBUG - til.internal.PlatformDependent - Java version: 7
2015-07-06 10:16:40,170 [    101]  DEBUG - til.internal.PlatformDependent - -Dio.netty.noUnsafe: false
2015-07-06 10:16:40,170 [    101]  DEBUG - til.internal.PlatformDependent - sun.misc.Unsafe: available
2015-07-06 10:16:40,170 [    101]  DEBUG - til.internal.PlatformDependent - -Dio.netty.noJavassist: false
2015-07-06 10:16:40,171 [    102]  DEBUG - til.internal.PlatformDependent - Javassist: unavailable
2015-07-06 10:16:40,171 [    102]  DEBUG - til.internal.PlatformDependent - You don't have Javassist in your class path or you don't have enough permission to load dynamically generated classes.  Please check the configuration for better performance.
2015-07-06 10:16:40,172 [    103]  DEBUG - til.internal.PlatformDependent - -Dio.netty.tmpdir: C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\_temp_ (java.io.tmpdir)
2015-07-06 10:16:40,172 [    103]  DEBUG - til.internal.PlatformDependent - -Dio.netty.bitMode: 64 (sun.arch.data.model)
2015-07-06 10:16:40,172 [    103]  DEBUG - til.internal.PlatformDependent - -Dio.netty.noPreferDirect: false
2015-07-06 10:16:40,172 [    103]  DEBUG - netty.channel.nio.NioEventLoop - -Dio.netty.noKeySetOptimization: false
2015-07-06 10:16:40,172 [    103]  DEBUG - netty.channel.nio.NioEventLoop - -Dio.netty.selectorAutoRebuildThreshold: 512
2015-07-06 10:16:40,232 [    163]  DEBUG - netty.channel.DefaultChannelId - -Dio.netty.processId: 51799 (user-set)
2015-07-06 10:16:40,233 [    164]  DEBUG - netty.channel.DefaultChannelId - -Dio.netty.machineId: 9e43d860 (user-set)
2015-07-06 10:16:40,235 [    166]  DEBUG - til.internal.ThreadLocalRandom - -Dio.netty.initialSeedUniquifier: 0x7303515b0858788f
2015-07-06 10:16:40,261 [    192]  DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.numHeapArenas: 4
2015-07-06 10:16:40,261 [    192]  DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.numDirectArenas: 4
2015-07-06 10:16:40,261 [    192]  DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.pageSize: 8192
2015-07-06 10:16:40,261 [    192]  DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.maxOrder: 11
2015-07-06 10:16:40,261 [    192]  DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.chunkSize: 16777216
2015-07-06 10:16:40,261 [    192]  DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.tinyCacheSize: 512
2015-07-06 10:16:40,261 [    192]  DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.smallCacheSize: 256
2015-07-06 10:16:40,261 [    192]  DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.normalCacheSize: 64
2015-07-06 10:16:40,261 [    192]  DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.maxCachedBufferCapacity: 32768
2015-07-06 10:16:40,261 [    192]  DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.cacheTrimInterval: 8192
2015-07-06 10:16:40,267 [    198]  DEBUG -    io.netty.buffer.ByteBufUtil - -Dio.netty.allocator.type: pooled
2015-07-06 10:16:40,267 [    198]  DEBUG -    io.netty.buffer.ByteBufUtil - -Dio.netty.threadLocalDirectBufferSize: 65536
2015-07-06 10:16:40,341 [    272]   INFO - etbrains.jps.cmdline.BuildMain - Connection to IDE established in 239 ms
2015-07-06 10:16:40,350 [    281]  DEBUG -         io.netty.util.Recycler - -Dio.netty.recycler.maxCapacity: 262144
2015-07-06 10:16:40,367 [    298]  DEBUG - etty.util.ResourceLeakDetector - -Dio.netty.leakDetectionLevel: simple
2015-07-06 10:16:41,457 [   1388]   INFO - jps.cmdline.JpsModelLoaderImpl - Loading model: project path = C:/source/research/cofoja-example, global options path = C:/Users/sean.glover/.IntelliJIdea14/config/options
2015-07-06 10:16:41,538 [   1469]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: path.macros.xml:PathMacrosImpl in 55ms
2015-07-06 10:16:41,544 [   1475]  DEBUG - .serialization.JpsGlobalLoader - Loading config from C:\Users\sean.glover\.IntelliJIdea14\config\options
2015-07-06 10:16:41,544 [   1475]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: applicationLibraries.xml:libraryTable in 0ms
2015-07-06 10:16:41,558 [   1489]  DEBUG - .library.JpsSdkTableSerializer - Loading JavaSDK SDK '1.7'
2015-07-06 10:16:41,658 [   1589]  DEBUG - .library.JpsSdkTableSerializer - 1.7 SDK classpath (19 roots):
2015-07-06 10:16:41,658 [   1589]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\charsets.jar
2015-07-06 10:16:41,658 [   1589]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\deploy.jar
2015-07-06 10:16:41,658 [   1589]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\javaws.jar
2015-07-06 10:16:41,658 [   1589]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\jce.jar
2015-07-06 10:16:41,658 [   1589]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\jfr.jar
2015-07-06 10:16:41,658 [   1589]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\jfxrt.jar
2015-07-06 10:16:41,658 [   1589]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\jsse.jar
2015-07-06 10:16:41,658 [   1589]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\management-agent.jar
2015-07-06 10:16:41,658 [   1589]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\plugin.jar
2015-07-06 10:16:41,658 [   1589]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\resources.jar
2015-07-06 10:16:41,658 [   1589]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\rt.jar
2015-07-06 10:16:41,659 [   1590]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\ext\access-bridge-64.jar
2015-07-06 10:16:41,659 [   1590]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\ext\dnsns.jar
2015-07-06 10:16:41,659 [   1590]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\ext\jaccess.jar
2015-07-06 10:16:41,659 [   1590]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\ext\localedata.jar
2015-07-06 10:16:41,659 [   1590]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\ext\sunec.jar
2015-07-06 10:16:41,659 [   1590]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\ext\sunjce_provider.jar
2015-07-06 10:16:41,659 [   1590]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\ext\sunmscapi.jar
2015-07-06 10:16:41,659 [   1590]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\ext\zipfs.jar
2015-07-06 10:16:41,666 [   1597]  DEBUG - .library.JpsSdkTableSerializer - Loading JavaSDK SDK '1.8'
2015-07-06 10:16:41,667 [   1598]  DEBUG - .library.JpsSdkTableSerializer - 1.8 SDK classpath (23 roots):
2015-07-06 10:16:41,667 [   1598]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\charsets.jar
2015-07-06 10:16:41,667 [   1598]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\deploy.jar
2015-07-06 10:16:41,667 [   1598]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\javaws.jar
2015-07-06 10:16:41,667 [   1598]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\jce.jar
2015-07-06 10:16:41,667 [   1598]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\jfr.jar
2015-07-06 10:16:41,667 [   1598]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\jfxswt.jar
2015-07-06 10:16:41,667 [   1598]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\jsse.jar
2015-07-06 10:16:41,667 [   1598]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\management-agent.jar
2015-07-06 10:16:41,667 [   1598]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\plugin.jar
2015-07-06 10:16:41,667 [   1598]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\resources.jar
2015-07-06 10:16:41,667 [   1598]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\rt.jar
2015-07-06 10:16:41,667 [   1598]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\access-bridge-64.jar
2015-07-06 10:16:41,667 [   1598]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\cldrdata.jar
2015-07-06 10:16:41,667 [   1598]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\dnsns.jar
2015-07-06 10:16:41,667 [   1598]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\jaccess.jar
2015-07-06 10:16:41,667 [   1598]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\jfxrt.jar
2015-07-06 10:16:41,667 [   1598]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\localedata.jar
2015-07-06 10:16:41,667 [   1598]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\nashorn.jar
2015-07-06 10:16:41,667 [   1598]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\sunec.jar
2015-07-06 10:16:41,668 [   1599]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\sunjce_provider.jar
2015-07-06 10:16:41,668 [   1599]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\sunmscapi.jar
2015-07-06 10:16:41,668 [   1599]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\sunpkcs11.jar
2015-07-06 10:16:41,668 [   1599]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\zipfs.jar
2015-07-06 10:16:41,668 [   1599]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: jdk.table.xml:ProjectJdkTable in 124ms
2015-07-06 10:16:41,669 [   1600]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: filetypes.xml:FileTypeManager in 1ms
2015-07-06 10:16:41,671 [   1602]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: encoding.xml:Encoding in 2ms
2015-07-06 10:16:41,676 [   1607]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: other.xml:GlobalAntConfiguration in 3ms
2015-07-06 10:16:41,682 [   1613]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: IntelliLang.xml:LanguageInjectionConfiguration in 4ms
2015-07-06 10:16:41,684 [   1615]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: osmorc.xml:Osmorc in 1ms
2015-07-06 10:16:41,684 [   1615]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: javaeeAppServers.xml:AppserversManager in 0ms
2015-07-06 10:16:41,707 [   1638]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: scala.xml:ScalaSettings in 22ms
2015-07-06 10:16:41,722 [   1653]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: misc.xml:ProjectRootManager in 7ms
2015-07-06 10:16:41,728 [   1659]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: compiler.xml:CompilerConfiguration in 6ms
2015-07-06 10:16:41,785 [   1716]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: workspace.xml:CompilerWorkspaceConfiguration in 57ms
2015-07-06 10:16:41,789 [   1720]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: compiler.xml:JavacSettings in 4ms
2015-07-06 10:16:41,792 [   1723]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: compiler.xml:EclipseCompilerSettings in 3ms
2015-07-06 10:16:41,796 [   1727]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: compiler.xml:RmicSettings in 4ms
2015-07-06 10:16:41,799 [   1730]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: encodings.xml:Encoding in 2ms
2015-07-06 10:16:41,800 [   1731]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: ant.xml:AntConfiguration in 0ms
2015-07-06 10:16:41,836 [   1767]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: workspace.xml:antWorkspaceConfiguration in 36ms
2015-07-06 10:16:41,841 [   1772]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: uiDesigner.xml:uidesigner-configuration in 2ms
2015-07-06 10:16:41,843 [   1774]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: groovyc.xml:GroovyCompilerProjectConfiguration in 0ms
2015-07-06 10:16:41,846 [   1777]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: compiler.xml:GreclipseSettings in 3ms
2015-07-06 10:16:41,849 [   1780]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: misc.xml:Osmorc in 3ms
2015-07-06 10:16:41,852 [   1783]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: compiler.xml:AjcSettings in 3ms
2015-07-06 10:16:41,883 [   1814]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: workspace.xml:FlexCompilerConfiguration in 29ms
2015-07-06 10:16:41,883 [   1814]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: flexCompiler.xml:FlexCompilerConfiguration in 0ms
2015-07-06 10:16:41,913 [   1844]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: workspace.xml:FlexIdeProjectLevelCompilerOptionsHolder in 30ms
2015-07-06 10:16:41,913 [   1844]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: flexCompiler.xml:FlexIdeProjectLevelCompilerOptionsHolder in 0ms
2015-07-06 10:16:41,945 [   1876]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: workspace.xml:GwtCompilerConfiguration in 30ms
2015-07-06 10:16:41,946 [   1877]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: androidDexCompiler.xml:AndroidDexCompilerConfiguration in 0ms
2015-07-06 10:16:41,947 [   1878]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: scala_compiler.xml:ScalaCompilerConfiguration in 0ms
2015-07-06 10:16:41,953 [   1884]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: play2_project_settings.xml:Play2ExcludedModulesSettings in 2ms
2015-07-06 10:16:41,954 [   1885]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: play2_compiler_settings.xml:Play2CompilerConfiguration in 1ms
2015-07-06 10:16:42,010 [   1941]  DEBUG -   #org.jetbrains.jps.TimingLog - loading modules in 55ms
2015-07-06 10:16:42,021 [   1952]  DEBUG -   #org.jetbrains.jps.TimingLog - loading project libraries in 11ms
2015-07-06 10:16:42,022 [   1953]  DEBUG -   #org.jetbrains.jps.TimingLog - loading artifacts in 1ms
2015-07-06 10:16:42,058 [   1989]  DEBUG -   #org.jetbrains.jps.TimingLog - loading run configurations in 33ms
2015-07-06 10:16:42,059 [   1990]   INFO - jps.cmdline.JpsModelLoaderImpl - Model loaded in 601 ms
2015-07-06 10:16:42,059 [   1990]   INFO - jps.cmdline.JpsModelLoaderImpl - Project has 1 modules, 8 libraries
2015-07-06 10:16:42,245 [   2176]   INFO - ellij.util.io.PagedFileStorage - lower=100; upper=200; buffer=10; max=631767040
2015-07-06 10:16:42,323 [   2254]  DEBUG -   #org.jetbrains.jps.TimingLog - Project descriptor loaded
2015-07-06 10:16:42,452 [   2383]   INFO - .incremental.IncProjectBuilder - Building project; isRebuild:true; isMake:false parallel compilation:false
2015-07-06 10:16:42,669 [   2600]  DEBUG - s.incremental.java.JavaBuilder - Java compiler ID: Javac
2015-07-06 10:16:42,704 [   2635]  DEBUG - sFileWithLengthAndSizeTracking - Inst:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\aj\aspect_path.dat.values@92eba22,Thread[pool-1-thread-2,5,main],java.net.URLClassLoader@7377711
2015-07-06 10:16:42,705 [   2636]  DEBUG - sFileWithLengthAndSizeTracking - Seek:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\aj\aspect_path.dat.values@92eba22,Thread[pool-1-thread-2,5,main],0,0,0
2015-07-06 10:16:42,705 [   2636]  DEBUG - sFileWithLengthAndSizeTracking - write:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\aj\aspect_path.dat.values@92eba22,Thread[pool-1-thread-2,5,main],49,0,0
2015-07-06 10:16:42,705 [   2636]  DEBUG - sFileWithLengthAndSizeTracking - after write:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\aj\aspect_path.dat.values@92eba22,Thread[pool-1-thread-2,5,main],49,49
2015-07-06 10:16:42,724 [   2655]   INFO - r.api.ClassFilesIndicesBuilder - class files data index disabled
2015-07-06 10:16:42,732 [   2663]   INFO - .incremental.IncProjectBuilder - Cleaned output directories in 0
2015-07-06 10:16:42,751 [   2682]  DEBUG - sFileWithLengthAndSizeTracking - Inst:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\timestamps\data.values@39e48b4c,Thread[pool-1-thread-2,5,main],java.net.URLClassLoader@7377711
2015-07-06 10:16:42,751 [   2682]  DEBUG - sFileWithLengthAndSizeTracking - Seek:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\timestamps\data.values@39e48b4c,Thread[pool-1-thread-2,5,main],0,0,0
2015-07-06 10:16:42,751 [   2682]  DEBUG - sFileWithLengthAndSizeTracking - write:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\timestamps\data.values@39e48b4c,Thread[pool-1-thread-2,5,main],49,0,0
2015-07-06 10:16:42,751 [   2682]  DEBUG - sFileWithLengthAndSizeTracking - after write:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\timestamps\data.values@39e48b4c,Thread[pool-1-thread-2,5,main],49,49
2015-07-06 10:16:42,770 [   2701]  DEBUG - sFileWithLengthAndSizeTracking - Inst:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\src-form\data.values@7768997e,Thread[pool-1-thread-2,5,main],java.net.URLClassLoader@7377711
2015-07-06 10:16:42,770 [   2701]  DEBUG - sFileWithLengthAndSizeTracking - Seek:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\src-form\data.values@7768997e,Thread[pool-1-thread-2,5,main],0,0,0
2015-07-06 10:16:42,770 [   2701]  DEBUG - sFileWithLengthAndSizeTracking - write:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\src-form\data.values@7768997e,Thread[pool-1-thread-2,5,main],49,0,0
2015-07-06 10:16:42,770 [   2701]  DEBUG - sFileWithLengthAndSizeTracking - after write:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\src-form\data.values@7768997e,Thread[pool-1-thread-2,5,main],49,49
2015-07-06 10:16:42,781 [   2712]  DEBUG - sFileWithLengthAndSizeTracking - Inst:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\out-target\data.values@74355c70,Thread[pool-1-thread-2,5,main],java.net.URLClassLoader@7377711
2015-07-06 10:16:42,781 [   2712]  DEBUG - sFileWithLengthAndSizeTracking - Seek:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\out-target\data.values@74355c70,Thread[pool-1-thread-2,5,main],0,0,0
2015-07-06 10:16:42,781 [   2712]  DEBUG - sFileWithLengthAndSizeTracking - write:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\out-target\data.values@74355c70,Thread[pool-1-thread-2,5,main],49,0,0
2015-07-06 10:16:42,781 [   2712]  DEBUG - sFileWithLengthAndSizeTracking - after write:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\out-target\data.values@74355c70,Thread[pool-1-thread-2,5,main],49,49
2015-07-06 10:16:42,814 [   2745]  DEBUG - sFileWithLengthAndSizeTracking - Inst:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToSubclasses.tab.values@406c5e92,Thread[pool-1-thread-2,5,main],java.net.URLClassLoader@7377711
2015-07-06 10:16:42,814 [   2745]  DEBUG - sFileWithLengthAndSizeTracking - Seek:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToSubclasses.tab.values@406c5e92,Thread[pool-1-thread-2,5,main],0,0,0
2015-07-06 10:16:42,814 [   2745]  DEBUG - sFileWithLengthAndSizeTracking - write:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToSubclasses.tab.values@406c5e92,Thread[pool-1-thread-2,5,main],49,0,0
2015-07-06 10:16:42,815 [   2746]  DEBUG - sFileWithLengthAndSizeTracking - after write:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToSubclasses.tab.values@406c5e92,Thread[pool-1-thread-2,5,main],49,49
2015-07-06 10:16:42,823 [   2754]  DEBUG - sFileWithLengthAndSizeTracking - Inst:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToClass.tab.values@ab4e449,Thread[pool-1-thread-2,5,main],java.net.URLClassLoader@7377711
2015-07-06 10:16:42,823 [   2754]  DEBUG - sFileWithLengthAndSizeTracking - Seek:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToClass.tab.values@ab4e449,Thread[pool-1-thread-2,5,main],0,0,0
2015-07-06 10:16:42,823 [   2754]  DEBUG - sFileWithLengthAndSizeTracking - write:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToClass.tab.values@ab4e449,Thread[pool-1-thread-2,5,main],49,0,0
2015-07-06 10:16:42,823 [   2754]  DEBUG - sFileWithLengthAndSizeTracking - after write:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToClass.tab.values@ab4e449,Thread[pool-1-thread-2,5,main],49,49
2015-07-06 10:16:42,833 [   2764]  DEBUG - sFileWithLengthAndSizeTracking - Inst:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\shortNames.tab.values@69f77a1c,Thread[pool-1-thread-2,5,main],java.net.URLClassLoader@7377711
2015-07-06 10:16:42,833 [   2764]  DEBUG - sFileWithLengthAndSizeTracking - Seek:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\shortNames.tab.values@69f77a1c,Thread[pool-1-thread-2,5,main],0,0,0
2015-07-06 10:16:42,833 [   2764]  DEBUG - sFileWithLengthAndSizeTracking - write:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\shortNames.tab.values@69f77a1c,Thread[pool-1-thread-2,5,main],49,0,0
2015-07-06 10:16:42,833 [   2764]  DEBUG - sFileWithLengthAndSizeTracking - after write:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\shortNames.tab.values@69f77a1c,Thread[pool-1-thread-2,5,main],49,49
2015-07-06 10:16:42,844 [   2775]  DEBUG - sFileWithLengthAndSizeTracking - Inst:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\sourceToClass.tab.values@7671fa9d,Thread[pool-1-thread-2,5,main],java.net.URLClassLoader@7377711
2015-07-06 10:16:42,844 [   2775]  DEBUG - sFileWithLengthAndSizeTracking - Seek:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\sourceToClass.tab.values@7671fa9d,Thread[pool-1-thread-2,5,main],0,0,0
2015-07-06 10:16:42,844 [   2775]  DEBUG - sFileWithLengthAndSizeTracking - write:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\sourceToClass.tab.values@7671fa9d,Thread[pool-1-thread-2,5,main],49,0,0
2015-07-06 10:16:42,844 [   2775]  DEBUG - sFileWithLengthAndSizeTracking - after write:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\sourceToClass.tab.values@7671fa9d,Thread[pool-1-thread-2,5,main],49,49
2015-07-06 10:16:42,851 [   2782]  DEBUG - sFileWithLengthAndSizeTracking - Inst:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToSource.tab.values@34fc962b,Thread[pool-1-thread-2,5,main],java.net.URLClassLoader@7377711
2015-07-06 10:16:42,851 [   2782]  DEBUG - sFileWithLengthAndSizeTracking - Seek:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToSource.tab.values@34fc962b,Thread[pool-1-thread-2,5,main],0,0,0
2015-07-06 10:16:42,851 [   2782]  DEBUG - sFileWithLengthAndSizeTracking - write:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToSource.tab.values@34fc962b,Thread[pool-1-thread-2,5,main],49,0,0
2015-07-06 10:16:42,851 [   2782]  DEBUG - sFileWithLengthAndSizeTracking - after write:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToSource.tab.values@34fc962b,Thread[pool-1-thread-2,5,main],49,49
2015-07-06 10:16:42,864 [   2795]  DEBUG -   #org.jetbrains.jps.TimingLog - 'before' tasks finished
2015-07-06 10:16:42,909 [   2840]  DEBUG - ps.incremental.fs.BuildFSState - Module 'cofoja-example' production: MARKED DIRTY: C:\source\research\cofoja-example\src\main\java\com\example\Example.java
2015-07-06 10:16:42,973 [   2904]   INFO - s.incremental.java.JavaBuilder - Using javac 1.7.0_60 to compile java sources
2015-07-06 10:16:42,974 [   2905]   INFO - s.incremental.java.JavaBuilder - Compiling 1 java files; module: cofoja-example
2015-07-06 10:16:42,974 [   2905]  DEBUG - s.incremental.java.JavaBuilder - Compiling C:\source\research\cofoja-example\src\main\java\com\example\Example.java
2015-07-06 10:16:42,974 [   2905]  DEBUG - s.incremental.java.JavaBuilder -  classpath for cofoja-example:
2015-07-06 10:16:42,974 [   2905]  DEBUG - s.incremental.java.JavaBuilder -   C:\source\research\cofoja-example\target\classes
2015-07-06 10:16:42,974 [   2905]  DEBUG - s.incremental.java.JavaBuilder -   C:\Users\sean.glover\.m2\repository\io\konverge\cofoja\2.0.0\cofoja-2.0.0.jar
2015-07-06 10:16:42,974 [   2905]  DEBUG - s.incremental.java.JavaBuilder -   C:\Users\sean.glover\.m2\repository\org\ow2\asm\asm-all\4.1\asm-all-4.1.jar
2015-07-06 10:16:42,975 [   2906]  DEBUG - s.incremental.java.JavaBuilder -   C:\Java\jdk-7u60-windows-x64\lib\tools.jar
2015-07-06 10:16:42,975 [   2906]  DEBUG - s.incremental.java.JavaBuilder -  platform classpath for cofoja-example:
2015-07-06 10:16:42,975 [   2906]  DEBUG - s.incremental.java.JavaBuilder -   C:\Java\jdk-7u60-windows-x64\jre\lib\charsets.jar
2015-07-06 10:16:42,975 [   2906]  DEBUG - s.incremental.java.JavaBuilder -   C:\Java\jdk-7u60-windows-x64\jre\lib\deploy.jar
2015-07-06 10:16:42,975 [   2906]  DEBUG - s.incremental.java.JavaBuilder -   C:\Java\jdk-7u60-windows-x64\jre\lib\javaws.jar
2015-07-06 10:16:42,975 [   2906]  DEBUG - s.incremental.java.JavaBuilder -   C:\Java\jdk-7u60-windows-x64\jre\lib\jce.jar
2015-07-06 10:16:42,975 [   2906]  DEBUG - s.incremental.java.JavaBuilder -   C:\Java\jdk-7u60-windows-x64\jre\lib\jfr.jar
2015-07-06 10:16:42,975 [   2906]  DEBUG - s.incremental.java.JavaBuilder -   C:\Java\jdk-7u60-windows-x64\jre\lib\jfxrt.jar
2015-07-06 10:16:42,975 [   2906]  DEBUG - s.incremental.java.JavaBuilder -   C:\Java\jdk-7u60-windows-x64\jre\lib\jsse.jar
2015-07-06 10:16:42,975 [   2906]  DEBUG - s.incremental.java.JavaBuilder -   C:\Java\jdk-7u60-windows-x64\jre\lib\management-agent.jar
2015-07-06 10:16:42,975 [   2906]  DEBUG - s.incremental.java.JavaBuilder -   C:\Java\jdk-7u60-windows-x64\jre\lib\plugin.jar
2015-07-06 10:16:42,975 [   2906]  DEBUG - s.incremental.java.JavaBuilder -   C:\Java\jdk-7u60-windows-x64\jre\lib\resources.jar
2015-07-06 10:16:42,975 [   2906]  DEBUG - s.incremental.java.JavaBuilder -   C:\Java\jdk-7u60-windows-x64\jre\lib\rt.jar
2015-07-06 10:16:42,975 [   2906]  DEBUG - s.incremental.java.JavaBuilder -   C:\Java\jdk-7u60-windows-x64\jre\lib\ext\access-bridge-64.jar
2015-07-06 10:16:42,975 [   2906]  DEBUG - s.incremental.java.JavaBuilder -   C:\Java\jdk-7u60-windows-x64\jre\lib\ext\dnsns.jar
2015-07-06 10:16:42,975 [   2906]  DEBUG - s.incremental.java.JavaBuilder -   C:\Java\jdk-7u60-windows-x64\jre\lib\ext\jaccess.jar
2015-07-06 10:16:42,975 [   2906]  DEBUG - s.incremental.java.JavaBuilder -   C:\Java\jdk-7u60-windows-x64\jre\lib\ext\localedata.jar
2015-07-06 10:16:42,975 [   2906]  DEBUG - s.incremental.java.JavaBuilder -   C:\Java\jdk-7u60-windows-x64\jre\lib\ext\sunec.jar
2015-07-06 10:16:42,975 [   2906]  DEBUG - s.incremental.java.JavaBuilder -   C:\Java\jdk-7u60-windows-x64\jre\lib\ext\sunjce_provider.jar
2015-07-06 10:16:42,975 [   2906]  DEBUG - s.incremental.java.JavaBuilder -   C:\Java\jdk-7u60-windows-x64\jre\lib\ext\sunmscapi.jar
2015-07-06 10:16:42,975 [   2906]  DEBUG - s.incremental.java.JavaBuilder -   C:\Java\jdk-7u60-windows-x64\jre\lib\ext\zipfs.jar
2015-07-06 10:16:42,978 [   2909]  DEBUG - s.incremental.java.JavaBuilder - Compiling chunk [cofoja-example] with options: "-g -deprecation -X -encoding UTF-8 -source 1.7 -target 1.7 -s C:\source\research\cofoja-example\target\generated-sources\annotations"
2015-07-06 10:16:43,048 [   2979]  DEBUG - sFileWithLengthAndSizeTracking - Closed:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\aj\aspect_path.dat.values@92eba22,Thread[pool-1-thread-2,5,main]
2015-07-06 10:16:43,095 [   3026]  DEBUG -   #org.jetbrains.jps.TimingLog - Build finished
2015-07-06 10:16:43,097 [   3028]  DEBUG - sFileWithLengthAndSizeTracking - Closed:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\timestamps\data.values@39e48b4c,Thread[pool-1-thread-2,5,main]
2015-07-06 10:16:43,104 [   3035]  DEBUG - sFileWithLengthAndSizeTracking - Closed:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\out-target\data.values@74355c70,Thread[pool-1-thread-2,5,main]
2015-07-06 10:16:43,105 [   3036]  DEBUG - sFileWithLengthAndSizeTracking - Closed:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\src-form\data.values@7768997e,Thread[pool-1-thread-2,5,main]
2015-07-06 10:16:43,106 [   3037]  DEBUG - sFileWithLengthAndSizeTracking - Closed:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToSubclasses.tab.values@406c5e92,Thread[pool-1-thread-2,5,main]
2015-07-06 10:16:43,106 [   3037]  DEBUG - sFileWithLengthAndSizeTracking - Closed:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToClass.tab.values@ab4e449,Thread[pool-1-thread-2,5,main]
2015-07-06 10:16:43,107 [   3038]  DEBUG - sFileWithLengthAndSizeTracking - Closed:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\sourceToClass.tab.values@7671fa9d,Thread[pool-1-thread-2,5,main]
2015-07-06 10:16:43,107 [   3038]  DEBUG - sFileWithLengthAndSizeTracking - Closed:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToSource.tab.values@34fc962b,Thread[pool-1-thread-2,5,main]
2015-07-06 10:16:43,107 [   3038]  DEBUG - sFileWithLengthAndSizeTracking - Closed:C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\shortNames.tab.values@69f77a1c,Thread[pool-1-thread-2,5,main]
2015-07-06 10:16:43,626 [      0]   INFO - etbrains.jps.cmdline.BuildMain - Build process started. Classpath: /C:/Program Files (x86)/JetBrains/IntelliJ IDEA 14.1.4/lib/jps-launcher.jar;C:/Java/jdk-7u60-windows-x64/lib/tools.jar;/C:/Program Files (x86)/JetBrains/IntelliJ IDEA 14.1.4/lib/optimizedFileManager.jar;C:/Program Files (x86)/JetBrains/IntelliJ IDEA 14.1.4/lib/ecj-4.4.jar
2015-07-06 10:16:43,660 [     34]  DEBUG - .logging.InternalLoggerFactory - Using Log4J as the default logging framework
2015-07-06 10:16:43,663 [     37]  DEBUG - nnel.MultithreadEventLoopGroup - -Dio.netty.eventLoopThreads: 8
2015-07-06 10:16:43,701 [     75]  DEBUG - il.internal.PlatformDependent0 - java.nio.Buffer.address: available
2015-07-06 10:16:43,701 [     75]  DEBUG - il.internal.PlatformDependent0 - sun.misc.Unsafe.theUnsafe: available
2015-07-06 10:16:43,701 [     75]  DEBUG - il.internal.PlatformDependent0 - sun.misc.Unsafe.copyMemory: available
2015-07-06 10:16:43,701 [     75]  DEBUG - il.internal.PlatformDependent0 - java.nio.Bits.unaligned: true
2015-07-06 10:16:43,702 [     76]  DEBUG - til.internal.PlatformDependent - Platform: Windows
2015-07-06 10:16:43,702 [     76]  DEBUG - til.internal.PlatformDependent - Java version: 7
2015-07-06 10:16:43,702 [     76]  DEBUG - til.internal.PlatformDependent - -Dio.netty.noUnsafe: false
2015-07-06 10:16:43,702 [     76]  DEBUG - til.internal.PlatformDependent - sun.misc.Unsafe: available
2015-07-06 10:16:43,702 [     76]  DEBUG - til.internal.PlatformDependent - -Dio.netty.noJavassist: false
2015-07-06 10:16:43,704 [     78]  DEBUG - til.internal.PlatformDependent - Javassist: unavailable
2015-07-06 10:16:43,704 [     78]  DEBUG - til.internal.PlatformDependent - You don't have Javassist in your class path or you don't have enough permission to load dynamically generated classes.  Please check the configuration for better performance.
2015-07-06 10:16:43,704 [     78]  DEBUG - til.internal.PlatformDependent - -Dio.netty.tmpdir: C:\Users\sean.glover\.IntelliJIdea14\system\compile-server\_temp_ (java.io.tmpdir)
2015-07-06 10:16:43,704 [     78]  DEBUG - til.internal.PlatformDependent - -Dio.netty.bitMode: 64 (sun.arch.data.model)
2015-07-06 10:16:43,704 [     78]  DEBUG - til.internal.PlatformDependent - -Dio.netty.noPreferDirect: false
2015-07-06 10:16:43,705 [     79]  DEBUG - netty.channel.nio.NioEventLoop - -Dio.netty.noKeySetOptimization: false
2015-07-06 10:16:43,705 [     79]  DEBUG - netty.channel.nio.NioEventLoop - -Dio.netty.selectorAutoRebuildThreshold: 512
2015-07-06 10:16:43,766 [    140]  DEBUG - netty.channel.DefaultChannelId - -Dio.netty.processId: 39795 (user-set)
2015-07-06 10:16:43,767 [    141]  DEBUG - netty.channel.DefaultChannelId - -Dio.netty.machineId: 9e43d860 (user-set)
2015-07-06 10:16:43,769 [    143]  DEBUG - til.internal.ThreadLocalRandom - -Dio.netty.initialSeedUniquifier: 0x7303515b0858788f
2015-07-06 10:16:43,801 [    175]  DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.numHeapArenas: 4
2015-07-06 10:16:43,801 [    175]  DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.numDirectArenas: 4
2015-07-06 10:16:43,801 [    175]  DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.pageSize: 8192
2015-07-06 10:16:43,801 [    175]  DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.maxOrder: 11
2015-07-06 10:16:43,802 [    176]  DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.chunkSize: 16777216
2015-07-06 10:16:43,802 [    176]  DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.tinyCacheSize: 512
2015-07-06 10:16:43,802 [    176]  DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.smallCacheSize: 256
2015-07-06 10:16:43,802 [    176]  DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.normalCacheSize: 64
2015-07-06 10:16:43,802 [    176]  DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.maxCachedBufferCapacity: 32768
2015-07-06 10:16:43,802 [    176]  DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.cacheTrimInterval: 8192
2015-07-06 10:16:43,809 [    183]  DEBUG -    io.netty.buffer.ByteBufUtil - -Dio.netty.allocator.type: pooled
2015-07-06 10:16:43,809 [    183]  DEBUG -    io.netty.buffer.ByteBufUtil - -Dio.netty.threadLocalDirectBufferSize: 65536
2015-07-06 10:16:43,898 [    272]   INFO - etbrains.jps.cmdline.BuildMain - Connection to IDE established in 246 ms
2015-07-06 10:16:43,910 [    284]   INFO - penapi.util.io.win32.IdeaWin32 - Native filesystem for Windows is operational
2015-07-06 10:16:43,910 [    284]  DEBUG - penapi.util.io.win32.IdeaWin32 - getInfo(C:\)
2015-07-06 10:16:43,911 [    285]  DEBUG - penapi.util.io.win32.IdeaWin32 -   93 mks
2015-07-06 10:16:43,913 [    287]  DEBUG - penapi.util.io.win32.IdeaWin32 - getInfo(C:\source\research\cofoja-example)
2015-07-06 10:16:43,913 [    287]  DEBUG - penapi.util.io.win32.IdeaWin32 -   88 mks
2015-07-06 10:16:43,937 [    311]   INFO - jps.cmdline.JpsModelLoaderImpl - Loading model: project path = C:/source/research/cofoja-example, global options path = C:/Users/sean.glover/.IntelliJIdea14/config/options
2015-07-06 10:16:44,018 [    392]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: path.macros.xml:PathMacrosImpl in 48ms
2015-07-06 10:16:44,022 [    396]  DEBUG - .serialization.JpsGlobalLoader - Loading config from C:\Users\sean.glover\.IntelliJIdea14\config\options
2015-07-06 10:16:44,022 [    396]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: applicationLibraries.xml:libraryTable in 0ms
2015-07-06 10:16:44,034 [    408]  DEBUG - .library.JpsSdkTableSerializer - Loading JavaSDK SDK '1.7'
2015-07-06 10:16:44,099 [    473]  DEBUG - .library.JpsSdkTableSerializer - 1.7 SDK classpath (19 roots):
2015-07-06 10:16:44,099 [    473]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\charsets.jar
2015-07-06 10:16:44,100 [    474]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\deploy.jar
2015-07-06 10:16:44,100 [    474]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\javaws.jar
2015-07-06 10:16:44,100 [    474]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\jce.jar
2015-07-06 10:16:44,100 [    474]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\jfr.jar
2015-07-06 10:16:44,100 [    474]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\jfxrt.jar
2015-07-06 10:16:44,100 [    474]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\jsse.jar
2015-07-06 10:16:44,100 [    474]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\management-agent.jar
2015-07-06 10:16:44,100 [    474]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\plugin.jar
2015-07-06 10:16:44,100 [    474]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\resources.jar
2015-07-06 10:16:44,100 [    474]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\rt.jar
2015-07-06 10:16:44,100 [    474]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\ext\access-bridge-64.jar
2015-07-06 10:16:44,100 [    474]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\ext\dnsns.jar
2015-07-06 10:16:44,100 [    474]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\ext\jaccess.jar
2015-07-06 10:16:44,100 [    474]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\ext\localedata.jar
2015-07-06 10:16:44,100 [    474]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\ext\sunec.jar
2015-07-06 10:16:44,100 [    474]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\ext\sunjce_provider.jar
2015-07-06 10:16:44,100 [    474]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\ext\sunmscapi.jar
2015-07-06 10:16:44,100 [    474]  DEBUG - .library.JpsSdkTableSerializer -  C:\Java\jdk-7u60-windows-x64\jre\lib\ext\zipfs.jar
2015-07-06 10:16:44,108 [    482]  DEBUG - .library.JpsSdkTableSerializer - Loading JavaSDK SDK '1.8'
2015-07-06 10:16:44,108 [    482]  DEBUG - .library.JpsSdkTableSerializer - 1.8 SDK classpath (23 roots):
2015-07-06 10:16:44,108 [    482]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\charsets.jar
2015-07-06 10:16:44,108 [    482]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\deploy.jar
2015-07-06 10:16:44,108 [    482]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\javaws.jar
2015-07-06 10:16:44,108 [    482]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\jce.jar
2015-07-06 10:16:44,108 [    482]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\jfr.jar
2015-07-06 10:16:44,109 [    483]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\jfxswt.jar
2015-07-06 10:16:44,109 [    483]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\jsse.jar
2015-07-06 10:16:44,109 [    483]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\management-agent.jar
2015-07-06 10:16:44,109 [    483]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\plugin.jar
2015-07-06 10:16:44,109 [    483]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\resources.jar
2015-07-06 10:16:44,109 [    483]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\rt.jar
2015-07-06 10:16:44,109 [    483]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\access-bridge-64.jar
2015-07-06 10:16:44,109 [    483]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\cldrdata.jar
2015-07-06 10:16:44,109 [    483]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\dnsns.jar
2015-07-06 10:16:44,109 [    483]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\jaccess.jar
2015-07-06 10:16:44,109 [    483]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\jfxrt.jar
2015-07-06 10:16:44,109 [    483]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\localedata.jar
2015-07-06 10:16:44,109 [    483]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\nashorn.jar
2015-07-06 10:16:44,109 [    483]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\sunec.jar
2015-07-06 10:16:44,109 [    483]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\sunjce_provider.jar
2015-07-06 10:16:44,109 [    483]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\sunmscapi.jar
2015-07-06 10:16:44,110 [    484]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\sunpkcs11.jar
2015-07-06 10:16:44,110 [    484]  DEBUG - .library.JpsSdkTableSerializer -  C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\zipfs.jar
2015-07-06 10:16:44,110 [    484]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: jdk.table.xml:ProjectJdkTable in 88ms
2015-07-06 10:16:44,111 [    485]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: filetypes.xml:FileTypeManager in 1ms
2015-07-06 10:16:44,113 [    487]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: encoding.xml:Encoding in 2ms
2015-07-06 10:16:44,117 [    491]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: other.xml:GlobalAntConfiguration in 3ms
2015-07-06 10:16:44,122 [    496]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: IntelliLang.xml:LanguageInjectionConfiguration in 4ms
2015-07-06 10:16:44,124 [    498]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: osmorc.xml:Osmorc in 1ms
2015-07-06 10:16:44,125 [    499]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: javaeeAppServers.xml:AppserversManager in 0ms
2015-07-06 10:16:44,147 [    521]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: scala.xml:ScalaSettings in 21ms
2015-07-06 10:16:44,171 [    545]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: misc.xml:ProjectRootManager in 15ms
2015-07-06 10:16:44,177 [    551]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: compiler.xml:CompilerConfiguration in 6ms
2015-07-06 10:16:44,216 [    590]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: workspace.xml:CompilerWorkspaceConfiguration in 39ms
2015-07-06 10:16:44,222 [    596]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: compiler.xml:JavacSettings in 6ms
2015-07-06 10:16:44,225 [    599]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: compiler.xml:EclipseCompilerSettings in 3ms
2015-07-06 10:16:44,228 [    602]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: compiler.xml:RmicSettings in 3ms
2015-07-06 10:16:44,231 [    605]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: encodings.xml:Encoding in 2ms
2015-07-06 10:16:44,233 [    607]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: ant.xml:AntConfiguration in 0ms
2015-07-06 10:16:44,283 [    657]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: workspace.xml:antWorkspaceConfiguration in 50ms
2015-07-06 10:16:44,286 [    660]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: uiDesigner.xml:uidesigner-configuration in 2ms
2015-07-06 10:16:44,287 [    661]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: groovyc.xml:GroovyCompilerProjectConfiguration in 0ms
2015-07-06 10:16:44,290 [    664]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: compiler.xml:GreclipseSettings in 3ms
2015-07-06 10:16:44,293 [    667]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: misc.xml:Osmorc in 3ms
2015-07-06 10:16:44,297 [    671]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: compiler.xml:AjcSettings in 3ms
2015-07-06 10:16:44,330 [    704]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: workspace.xml:FlexCompilerConfiguration in 31ms
2015-07-06 10:16:44,330 [    704]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: flexCompiler.xml:FlexCompilerConfiguration in 0ms
2015-07-06 10:16:44,362 [    736]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: workspace.xml:FlexIdeProjectLevelCompilerOptionsHolder in 31ms
2015-07-06 10:16:44,362 [    736]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: flexCompiler.xml:FlexIdeProjectLevelCompilerOptionsHolder in 0ms
2015-07-06 10:16:44,393 [    767]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: workspace.xml:GwtCompilerConfiguration in 30ms
2015-07-06 10:16:44,394 [    768]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: androidDexCompiler.xml:AndroidDexCompilerConfiguration in 0ms
2015-07-06 10:16:44,395 [    769]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: scala_compiler.xml:ScalaCompilerConfiguration in 0ms
2015-07-06 10:16:44,401 [    775]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: play2_project_settings.xml:Play2ExcludedModulesSettings in 2ms
2015-07-06 10:16:44,401 [    775]  DEBUG -   #org.jetbrains.jps.TimingLog - loading: play2_compiler_settings.xml:Play2CompilerConfiguration in 0ms
2015-07-06 10:16:44,445 [    819]  DEBUG -   #org.jetbrains.jps.TimingLog - loading modules in 43ms
2015-07-06 10:16:44,457 [    831]  DEBUG -   #org.jetbrains.jps.TimingLog - loading project libraries in 12ms
2015-07-06 10:16:44,457 [    831]  DEBUG -   #org.jetbrains.jps.TimingLog - loading artifacts in 0ms
2015-07-06 10:16:44,486 [    860]  DEBUG -   #org.jetbrains.jps.TimingLog - loading run configurations in 26ms
2015-07-06 10:16:44,486 [    860]   INFO - jps.cmdline.JpsModelLoaderImpl - Model loaded in 549 ms
2015-07-06 10:16:44,486 [    860]   INFO - jps.cmdline.JpsModelLoaderImpl - Project has 1 modules, 8 libraries
2015-07-06 10:16:44,649 [   1023]   INFO - ellij.util.io.PagedFileStorage - lower=100; upper=200; buffer=10; max=631767040
2015-07-06 10:16:44,851 [   1225]   INFO - etbrains.jps.cmdline.BuildMain - Pre-loaded process ready in 1226 ms
2015-07-06 10:16:44,860 [   1234]  DEBUG -         io.netty.util.Recycler - -Dio.netty.recycler.maxCapacity: 262144
2015-07-06 10:16:44,876 [   1250]  DEBUG - etty.util.ResourceLeakDetector - -Dio.netty.leakDetectionLevel: simple
2015-07-06 10:17:08,061 [  24435]   INFO - etbrains.jps.cmdline.BuildMain - Build canceled, but no build session is running. Exiting.

@nhatminhle
Copy link
Owner

Hum, so if I understand correctly, the problem seems to be that you don't
define the com.google.java.contract.classpath annotation processor option
properly? I'm pretty sure you can set it to the same classpath as you are
using for your project through a dialog (something like this:
https://www.jetbrains.com/idea/help/configuring-annotation-processing.html
) but I don't know a simple way to insert the whole project classpath as
the value of the annotation processing variable (as we do with $-variable
substitutions in Ant or Maven).

You may want to write a script or something that syncs the Cofoja classpath
with your project classpath. I haven't looked at the API or format of
IntelliJ projects but I'm guessing it can be done.

Hope that helps,
Nhat

On Mon, Jul 6, 2015 at 4:22 PM, Sean Glover notifications@github.com
wrote:

I can't figure out how to show the exact javac call with IntelliJ. I have
enabled debug level build logging and it produced this (
https://intellij-support.jetbrains.com/hc/en-us/articles/206827517-Locating-IDE-log-files).
There are some hints on the classpath and other arguments provided to
javac. I'm not sure if this is helpful to you.

2015-07-06 10:16:34,289 [ 224739] INFO - etbrains.jps.cmdline.BuildMain - Build canceled, but no build session is running. Exiting.
2015-07-06 10:16:40,069 [ 0] INFO - etbrains.jps.cmdline.BuildMain - Build process started. Classpath: /C:/Program Files (x86)/JetBrains/IntelliJ IDEA 14.1.4/lib/jps-launcher.jar;C:/Java/jdk-7u60-windows-x64/lib/tools.jar;/C:/Program Files (x86)/JetBrains/IntelliJ IDEA 14.1.4/lib/optimizedFileManager.jar;C:/Program Files (x86)/JetBrains/IntelliJ IDEA 14.1.4/lib/ecj-4.4.jar
2015-07-06 10:16:40,114 [ 45] DEBUG - .logging.InternalLoggerFactory - Using Log4J as the default logging framework
2015-07-06 10:16:40,119 [ 50] DEBUG - nnel.MultithreadEventLoopGroup - -Dio.netty.eventLoopThreads: 8
2015-07-06 10:16:40,168 [ 99] DEBUG - il.internal.PlatformDependent0 - java.nio.Buffer.address: available
2015-07-06 10:16:40,168 [ 99] DEBUG - il.internal.PlatformDependent0 - sun.misc.Unsafe.theUnsafe: available
2015-07-06 10:16:40,169 [ 100] DEBUG - il.internal.PlatformDependent0 - sun.misc.Unsafe.copyMemory: available
2015-07-06 10:16:40,169 [ 100] DEBUG - il.internal.PlatformDependent0 - java.nio.Bits.unaligned: true
2015-07-06 10:16:40,169 [ 100] DEBUG - til.internal.PlatformDependent - Platform: Windows
2015-07-06 10:16:40,170 [ 101] DEBUG - til.internal.PlatformDependent - Java version: 7
2015-07-06 10:16:40,170 [ 101] DEBUG - til.internal.PlatformDependent - -Dio.netty.noUnsafe: false
2015-07-06 10:16:40,170 [ 101] DEBUG - til.internal.PlatformDependent - sun.misc.Unsafe: available
2015-07-06 10:16:40,170 [ 101] DEBUG - til.internal.PlatformDependent - -Dio.netty.noJavassist: false
2015-07-06 10:16:40,171 [ 102] DEBUG - til.internal.PlatformDependent - Javassist: unavailable
2015-07-06 10:16:40,171 [ 102] DEBUG - til.internal.PlatformDependent - You don't have Javassist in your class path or you don't have enough permission to load dynamically generated classes. Please check the configuration for better performance.
2015-07-06 10:16:40,172 [ 103] DEBUG - til.internal.PlatformDependent - -Dio.netty.tmpdir: C:\Users\sean.glover.IntelliJIdea14\system\compile-server_temp_ (java.io.tmpdir)
2015-07-06 10:16:40,172 [ 103] DEBUG - til.internal.PlatformDependent - -Dio.netty.bitMode: 64 (sun.arch.data.model)
2015-07-06 10:16:40,172 [ 103] DEBUG - til.internal.PlatformDependent - -Dio.netty.noPreferDirect: false
2015-07-06 10:16:40,172 [ 103] DEBUG - netty.channel.nio.NioEventLoop - -Dio.netty.noKeySetOptimization: false
2015-07-06 10:16:40,172 [ 103] DEBUG - netty.channel.nio.NioEventLoop - -Dio.netty.selectorAutoRebuildThreshold: 512
2015-07-06 10:16:40,232 [ 163] DEBUG - netty.channel.DefaultChannelId - -Dio.netty.processId: 51799 (user-set)
2015-07-06 10:16:40,233 [ 164] DEBUG - netty.channel.DefaultChannelId - -Dio.netty.machineId: 9e43d860 (user-set)
2015-07-06 10:16:40,235 [ 166] DEBUG - til.internal.ThreadLocalRandom - -Dio.netty.initialSeedUniquifier: 0x7303515b0858788f
2015-07-06 10:16:40,261 [ 192] DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.numHeapArenas: 4
2015-07-06 10:16:40,261 [ 192] DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.numDirectArenas: 4
2015-07-06 10:16:40,261 [ 192] DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.pageSize: 8192
2015-07-06 10:16:40,261 [ 192] DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.maxOrder: 11
2015-07-06 10:16:40,261 [ 192] DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.chunkSize: 16777216
2015-07-06 10:16:40,261 [ 192] DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.tinyCacheSize: 512
2015-07-06 10:16:40,261 [ 192] DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.smallCacheSize: 256
2015-07-06 10:16:40,261 [ 192] DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.normalCacheSize: 64
2015-07-06 10:16:40,261 [ 192] DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.maxCachedBufferCapacity: 32768
2015-07-06 10:16:40,261 [ 192] DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.cacheTrimInterval: 8192
2015-07-06 10:16:40,267 [ 198] DEBUG - io.netty.buffer.ByteBufUtil - -Dio.netty.allocator.type: pooled
2015-07-06 10:16:40,267 [ 198] DEBUG - io.netty.buffer.ByteBufUtil - -Dio.netty.threadLocalDirectBufferSize: 65536
2015-07-06 10:16:40,341 [ 272] INFO - etbrains.jps.cmdline.BuildMain - Connection to IDE established in 239 ms
2015-07-06 10:16:40,350 [ 281] DEBUG - io.netty.util.Recycler - -Dio.netty.recycler.maxCapacity: 262144
2015-07-06 10:16:40,367 [ 298] DEBUG - etty.util.ResourceLeakDetector - -Dio.netty.leakDetectionLevel: simple
2015-07-06 10:16:41,457 [ 1388] INFO - jps.cmdline.JpsModelLoaderImpl - Loading model: project path = C:/source/research/cofoja-example, global options path = C:/Users/sean.glover/.IntelliJIdea14/config/options
2015-07-06 10:16:41,538 [ 1469] DEBUG - #org.jetbrains.jps.TimingLog - loading: path.macros.xml:PathMacrosImpl in 55ms
2015-07-06 10:16:41,544 [ 1475] DEBUG - .serialization.JpsGlobalLoader - Loading config from C:\Users\sean.glover.IntelliJIdea14\config\options
2015-07-06 10:16:41,544 [ 1475] DEBUG - #org.jetbrains.jps.TimingLog - loading: applicationLibraries.xml:libraryTable in 0ms
2015-07-06 10:16:41,558 [ 1489] DEBUG - .library.JpsSdkTableSerializer - Loading JavaSDK SDK '1.7'
2015-07-06 10:16:41,658 [ 1589] DEBUG - .library.JpsSdkTableSerializer - 1.7 SDK classpath (19 roots):
2015-07-06 10:16:41,658 [ 1589] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\charsets.jar
2015-07-06 10:16:41,658 [ 1589] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\deploy.jar
2015-07-06 10:16:41,658 [ 1589] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\javaws.jar
2015-07-06 10:16:41,658 [ 1589] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\jce.jar
2015-07-06 10:16:41,658 [ 1589] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\jfr.jar
2015-07-06 10:16:41,658 [ 1589] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\jfxrt.jar
2015-07-06 10:16:41,658 [ 1589] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\jsse.jar
2015-07-06 10:16:41,658 [ 1589] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\management-agent.jar
2015-07-06 10:16:41,658 [ 1589] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\plugin.jar
2015-07-06 10:16:41,658 [ 1589] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\resources.jar
2015-07-06 10:16:41,658 [ 1589] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\rt.jar
2015-07-06 10:16:41,659 [ 1590] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\ext\access-bridge-64.jar
2015-07-06 10:16:41,659 [ 1590] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\ext\dnsns.jar
2015-07-06 10:16:41,659 [ 1590] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\ext\jaccess.jar
2015-07-06 10:16:41,659 [ 1590] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\ext\localedata.jar
2015-07-06 10:16:41,659 [ 1590] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\ext\sunec.jar
2015-07-06 10:16:41,659 [ 1590] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\ext\sunjce_provider.jar
2015-07-06 10:16:41,659 [ 1590] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\ext\sunmscapi.jar
2015-07-06 10:16:41,659 [ 1590] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\ext\zipfs.jar
2015-07-06 10:16:41,666 [ 1597] DEBUG - .library.JpsSdkTableSerializer - Loading JavaSDK SDK '1.8'
2015-07-06 10:16:41,667 [ 1598] DEBUG - .library.JpsSdkTableSerializer - 1.8 SDK classpath (23 roots):
2015-07-06 10:16:41,667 [ 1598] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\charsets.jar
2015-07-06 10:16:41,667 [ 1598] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\deploy.jar
2015-07-06 10:16:41,667 [ 1598] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\javaws.jar
2015-07-06 10:16:41,667 [ 1598] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\jce.jar
2015-07-06 10:16:41,667 [ 1598] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\jfr.jar
2015-07-06 10:16:41,667 [ 1598] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\jfxswt.jar
2015-07-06 10:16:41,667 [ 1598] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\jsse.jar
2015-07-06 10:16:41,667 [ 1598] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\management-agent.jar
2015-07-06 10:16:41,667 [ 1598] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\plugin.jar
2015-07-06 10:16:41,667 [ 1598] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\resources.jar
2015-07-06 10:16:41,667 [ 1598] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\rt.jar
2015-07-06 10:16:41,667 [ 1598] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\access-bridge-64.jar
2015-07-06 10:16:41,667 [ 1598] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\cldrdata.jar
2015-07-06 10:16:41,667 [ 1598] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\dnsns.jar
2015-07-06 10:16:41,667 [ 1598] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\jaccess.jar
2015-07-06 10:16:41,667 [ 1598] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\jfxrt.jar
2015-07-06 10:16:41,667 [ 1598] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\localedata.jar
2015-07-06 10:16:41,667 [ 1598] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\nashorn.jar
2015-07-06 10:16:41,667 [ 1598] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\sunec.jar
2015-07-06 10:16:41,668 [ 1599] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\sunjce_provider.jar
2015-07-06 10:16:41,668 [ 1599] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\sunmscapi.jar
2015-07-06 10:16:41,668 [ 1599] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\sunpkcs11.jar
2015-07-06 10:16:41,668 [ 1599] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\zipfs.jar
2015-07-06 10:16:41,668 [ 1599] DEBUG - #org.jetbrains.jps.TimingLog - loading: jdk.table.xml:ProjectJdkTable in 124ms
2015-07-06 10:16:41,669 [ 1600] DEBUG - #org.jetbrains.jps.TimingLog - loading: filetypes.xml:FileTypeManager in 1ms
2015-07-06 10:16:41,671 [ 1602] DEBUG - #org.jetbrains.jps.TimingLog - loading: encoding.xml:Encoding in 2ms
2015-07-06 10:16:41,676 [ 1607] DEBUG - #org.jetbrains.jps.TimingLog - loading: other.xml:GlobalAntConfiguration in 3ms
2015-07-06 10:16:41,682 [ 1613] DEBUG - #org.jetbrains.jps.TimingLog - loading: IntelliLang.xml:LanguageInjectionConfiguration in 4ms
2015-07-06 10:16:41,684 [ 1615] DEBUG - #org.jetbrains.jps.TimingLog - loading: osmorc.xml:Osmorc in 1ms
2015-07-06 10:16:41,684 [ 1615] DEBUG - #org.jetbrains.jps.TimingLog - loading: javaeeAppServers.xml:AppserversManager in 0ms
2015-07-06 10:16:41,707 [ 1638] DEBUG - #org.jetbrains.jps.TimingLog - loading: scala.xml:ScalaSettings in 22ms
2015-07-06 10:16:41,722 [ 1653] DEBUG - #org.jetbrains.jps.TimingLog - loading: misc.xml:ProjectRootManager in 7ms
2015-07-06 10:16:41,728 [ 1659] DEBUG - #org.jetbrains.jps.TimingLog - loading: compiler.xml:CompilerConfiguration in 6ms
2015-07-06 10:16:41,785 [ 1716] DEBUG - #org.jetbrains.jps.TimingLog - loading: workspace.xml:CompilerWorkspaceConfiguration in 57ms
2015-07-06 10:16:41,789 [ 1720] DEBUG - #org.jetbrains.jps.TimingLog - loading: compiler.xml:JavacSettings in 4ms
2015-07-06 10:16:41,792 [ 1723] DEBUG - #org.jetbrains.jps.TimingLog - loading: compiler.xml:EclipseCompilerSettings in 3ms
2015-07-06 10:16:41,796 [ 1727] DEBUG - #org.jetbrains.jps.TimingLog - loading: compiler.xml:RmicSettings in 4ms
2015-07-06 10:16:41,799 [ 1730] DEBUG - #org.jetbrains.jps.TimingLog - loading: encodings.xml:Encoding in 2ms
2015-07-06 10:16:41,800 [ 1731] DEBUG - #org.jetbrains.jps.TimingLog - loading: ant.xml:AntConfiguration in 0ms
2015-07-06 10:16:41,836 [ 1767] DEBUG - #org.jetbrains.jps.TimingLog - loading: workspace.xml:antWorkspaceConfiguration in 36ms
2015-07-06 10:16:41,841 [ 1772] DEBUG - #org.jetbrains.jps.TimingLog - loading: uiDesigner.xml:uidesigner-configuration in 2ms
2015-07-06 10:16:41,843 [ 1774] DEBUG - #org.jetbrains.jps.TimingLog - loading: groovyc.xml:GroovyCompilerProjectConfiguration in 0ms
2015-07-06 10:16:41,846 [ 1777] DEBUG - #org.jetbrains.jps.TimingLog - loading: compiler.xml:GreclipseSettings in 3ms
2015-07-06 10:16:41,849 [ 1780] DEBUG - #org.jetbrains.jps.TimingLog - loading: misc.xml:Osmorc in 3ms
2015-07-06 10:16:41,852 [ 1783] DEBUG - #org.jetbrains.jps.TimingLog - loading: compiler.xml:AjcSettings in 3ms
2015-07-06 10:16:41,883 [ 1814] DEBUG - #org.jetbrains.jps.TimingLog - loading: workspace.xml:FlexCompilerConfiguration in 29ms
2015-07-06 10:16:41,883 [ 1814] DEBUG - #org.jetbrains.jps.TimingLog - loading: flexCompiler.xml:FlexCompilerConfiguration in 0ms
2015-07-06 10:16:41,913 [ 1844] DEBUG - #org.jetbrains.jps.TimingLog - loading: workspace.xml:FlexIdeProjectLevelCompilerOptionsHolder in 30ms
2015-07-06 10:16:41,913 [ 1844] DEBUG - #org.jetbrains.jps.TimingLog - loading: flexCompiler.xml:FlexIdeProjectLevelCompilerOptionsHolder in 0ms
2015-07-06 10:16:41,945 [ 1876] DEBUG - #org.jetbrains.jps.TimingLog - loading: workspace.xml:GwtCompilerConfiguration in 30ms
2015-07-06 10:16:41,946 [ 1877] DEBUG - #org.jetbrains.jps.TimingLog - loading: androidDexCompiler.xml:AndroidDexCompilerConfiguration in 0ms
2015-07-06 10:16:41,947 [ 1878] DEBUG - #org.jetbrains.jps.TimingLog - loading: scala_compiler.xml:ScalaCompilerConfiguration in 0ms
2015-07-06 10:16:41,953 [ 1884] DEBUG - #org.jetbrains.jps.TimingLog - loading: play2_project_settings.xml:Play2ExcludedModulesSettings in 2ms
2015-07-06 10:16:41,954 [ 1885] DEBUG - #org.jetbrains.jps.TimingLog - loading: play2_compiler_settings.xml:Play2CompilerConfiguration in 1ms
2015-07-06 10:16:42,010 [ 1941] DEBUG - #org.jetbrains.jps.TimingLog - loading modules in 55ms
2015-07-06 10:16:42,021 [ 1952] DEBUG - #org.jetbrains.jps.TimingLog - loading project libraries in 11ms
2015-07-06 10:16:42,022 [ 1953] DEBUG - #org.jetbrains.jps.TimingLog - loading artifacts in 1ms
2015-07-06 10:16:42,058 [ 1989] DEBUG - #org.jetbrains.jps.TimingLog - loading run configurations in 33ms
2015-07-06 10:16:42,059 [ 1990] INFO - jps.cmdline.JpsModelLoaderImpl - Model loaded in 601 ms
2015-07-06 10:16:42,059 [ 1990] INFO - jps.cmdline.JpsModelLoaderImpl - Project has 1 modules, 8 libraries
2015-07-06 10:16:42,245 [ 2176] INFO - ellij.util.io.PagedFileStorage - lower=100; upper=200; buffer=10; max=631767040
2015-07-06 10:16:42,323 [ 2254] DEBUG - #org.jetbrains.jps.TimingLog - Project descriptor loaded
2015-07-06 10:16:42,452 [ 2383] INFO - .incremental.IncProjectBuilder - Building project; isRebuild:true; isMake:false parallel compilation:false
2015-07-06 10:16:42,669 [ 2600] DEBUG - s.incremental.java.JavaBuilder - Java compiler ID: Javac
2015-07-06 10:16:42,704 [ 2635] DEBUG - sFileWithLengthAndSizeTracking - Inst:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\aj\aspect_path.dat.values@92eba22,Thread[pool-1-thread-2,5,main],java.net.URLClassLoader@7377711
2015-07-06 10:16:42,705 [ 2636] DEBUG - sFileWithLengthAndSizeTracking - Seek:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\aj\aspect_path.dat.values@92eba22,Thread[pool-1-thread-2,5,main],0,0,0
2015-07-06 10:16:42,705 [ 2636] DEBUG - sFileWithLengthAndSizeTracking - write:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\aj\aspect_path.dat.values@92eba22,Thread[pool-1-thread-2,5,main],49,0,0
2015-07-06 10:16:42,705 [ 2636] DEBUG - sFileWithLengthAndSizeTracking - after write:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\aj\aspect_path.dat.values@92eba22,Thread[pool-1-thread-2,5,main],49,49
2015-07-06 10:16:42,724 [ 2655] INFO - r.api.ClassFilesIndicesBuilder - class files data index disabled
2015-07-06 10:16:42,732 [ 2663] INFO - .incremental.IncProjectBuilder - Cleaned output directories in 0
2015-07-06 10:16:42,751 [ 2682] DEBUG - sFileWithLengthAndSizeTracking - Inst:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\timestamps\data.values@39e48b4c,Thread[pool-1-thread-2,5,main],java.net.URLClassLoader@7377711
2015-07-06 10:16:42,751 [ 2682] DEBUG - sFileWithLengthAndSizeTracking - Seek:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\timestamps\data.values@39e48b4c,Thread[pool-1-thread-2,5,main],0,0,0
2015-07-06 10:16:42,751 [ 2682] DEBUG - sFileWithLengthAndSizeTracking - write:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\timestamps\data.values@39e48b4c,Thread[pool-1-thread-2,5,main],49,0,0
2015-07-06 10:16:42,751 [ 2682] DEBUG - sFileWithLengthAndSizeTracking - after write:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\timestamps\data.values@39e48b4c,Thread[pool-1-thread-2,5,main],49,49
2015-07-06 10:16:42,770 [ 2701] DEBUG - sFileWithLengthAndSizeTracking - Inst:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\src-form\data.values@7768997e,Thread[pool-1-thread-2,5,main],java.net.URLClassLoader@7377711
2015-07-06 10:16:42,770 [ 2701] DEBUG - sFileWithLengthAndSizeTracking - Seek:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\src-form\data.values@7768997e,Thread[pool-1-thread-2,5,main],0,0,0
2015-07-06 10:16:42,770 [ 2701] DEBUG - sFileWithLengthAndSizeTracking - write:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\src-form\data.values@7768997e,Thread[pool-1-thread-2,5,main],49,0,0
2015-07-06 10:16:42,770 [ 2701] DEBUG - sFileWithLengthAndSizeTracking - after write:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\src-form\data.values@7768997e,Thread[pool-1-thread-2,5,main],49,49
2015-07-06 10:16:42,781 [ 2712] DEBUG - sFileWithLengthAndSizeTracking - Inst:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\out-target\data.values@74355c70,Thread[pool-1-thread-2,5,main],java.net.URLClassLoader@7377711
2015-07-06 10:16:42,781 [ 2712] DEBUG - sFileWithLengthAndSizeTracking - Seek:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\out-target\data.values@74355c70,Thread[pool-1-thread-2,5,main],0,0,0
2015-07-06 10:16:42,781 [ 2712] DEBUG - sFileWithLengthAndSizeTracking - write:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\out-target\data.values@74355c70,Thread[pool-1-thread-2,5,main],49,0,0
2015-07-06 10:16:42,781 [ 2712] DEBUG - sFileWithLengthAndSizeTracking - after write:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\out-target\data.values@74355c70,Thread[pool-1-thread-2,5,main],49,49
2015-07-06 10:16:42,814 [ 2745] DEBUG - sFileWithLengthAndSizeTracking - Inst:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToSubclasses.tab.values@406c5e92,Thread[pool-1-thread-2,5,main],java.net.URLClassLoader@7377711
2015-07-06 10:16:42,814 [ 2745] DEBUG - sFileWithLengthAndSizeTracking - Seek:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToSubclasses.tab.values@406c5e92,Thread[pool-1-thread-2,5,main],0,0,0
2015-07-06 10:16:42,814 [ 2745] DEBUG - sFileWithLengthAndSizeTracking - write:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToSubclasses.tab.values@406c5e92,Thread[pool-1-thread-2,5,main],49,0,0
2015-07-06 10:16:42,815 [ 2746] DEBUG - sFileWithLengthAndSizeTracking - after write:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToSubclasses.tab.values@406c5e92,Thread[pool-1-thread-2,5,main],49,49
2015-07-06 10:16:42,823 [ 2754] DEBUG - sFileWithLengthAndSizeTracking - Inst:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToClass.tab.values@ab4e449,Thread[pool-1-thread-2,5,main],java.net.URLClassLoader@7377711
2015-07-06 10:16:42,823 [ 2754] DEBUG - sFileWithLengthAndSizeTracking - Seek:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToClass.tab.values@ab4e449,Thread[pool-1-thread-2,5,main],0,0,0
2015-07-06 10:16:42,823 [ 2754] DEBUG - sFileWithLengthAndSizeTracking - write:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToClass.tab.values@ab4e449,Thread[pool-1-thread-2,5,main],49,0,0
2015-07-06 10:16:42,823 [ 2754] DEBUG - sFileWithLengthAndSizeTracking - after write:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToClass.tab.values@ab4e449,Thread[pool-1-thread-2,5,main],49,49
2015-07-06 10:16:42,833 [ 2764] DEBUG - sFileWithLengthAndSizeTracking - Inst:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\shortNames.tab.values@69f77a1c,Thread[pool-1-thread-2,5,main],java.net.URLClassLoader@7377711
2015-07-06 10:16:42,833 [ 2764] DEBUG - sFileWithLengthAndSizeTracking - Seek:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\shortNames.tab.values@69f77a1c,Thread[pool-1-thread-2,5,main],0,0,0
2015-07-06 10:16:42,833 [ 2764] DEBUG - sFileWithLengthAndSizeTracking - write:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\shortNames.tab.values@69f77a1c,Thread[pool-1-thread-2,5,main],49,0,0
2015-07-06 10:16:42,833 [ 2764] DEBUG - sFileWithLengthAndSizeTracking - after write:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\shortNames.tab.values@69f77a1c,Thread[pool-1-thread-2,5,main],49,49
2015-07-06 10:16:42,844 [ 2775] DEBUG - sFileWithLengthAndSizeTracking - Inst:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\sourceToClass.tab.values@7671fa9d,Thread[pool-1-thread-2,5,main],java.net.URLClassLoader@7377711
2015-07-06 10:16:42,844 [ 2775] DEBUG - sFileWithLengthAndSizeTracking - Seek:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\sourceToClass.tab.values@7671fa9d,Thread[pool-1-thread-2,5,main],0,0,0
2015-07-06 10:16:42,844 [ 2775] DEBUG - sFileWithLengthAndSizeTracking - write:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\sourceToClass.tab.values@7671fa9d,Thread[pool-1-thread-2,5,main],49,0,0
2015-07-06 10:16:42,844 [ 2775] DEBUG - sFileWithLengthAndSizeTracking - after write:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\sourceToClass.tab.values@7671fa9d,Thread[pool-1-thread-2,5,main],49,49
2015-07-06 10:16:42,851 [ 2782] DEBUG - sFileWithLengthAndSizeTracking - Inst:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToSource.tab.values@34fc962b,Thread[pool-1-thread-2,5,main],java.net.URLClassLoader@7377711
2015-07-06 10:16:42,851 [ 2782] DEBUG - sFileWithLengthAndSizeTracking - Seek:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToSource.tab.values@34fc962b,Thread[pool-1-thread-2,5,main],0,0,0
2015-07-06 10:16:42,851 [ 2782] DEBUG - sFileWithLengthAndSizeTracking - write:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToSource.tab.values@34fc962b,Thread[pool-1-thread-2,5,main],49,0,0
2015-07-06 10:16:42,851 [ 2782] DEBUG - sFileWithLengthAndSizeTracking - after write:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToSource.tab.values@34fc962b,Thread[pool-1-thread-2,5,main],49,49
2015-07-06 10:16:42,864 [ 2795] DEBUG - #org.jetbrains.jps.TimingLog - 'before' tasks finished
2015-07-06 10:16:42,909 [ 2840] DEBUG - ps.incremental.fs.BuildFSState - Module 'cofoja-example' production: MARKED DIRTY: C:\source\research\cofoja-example\src\main\java\com\example\Example.java
2015-07-06 10:16:42,973 [ 2904] INFO - s.incremental.java.JavaBuilder - Using javac 1.7.0_60 to compile java sources
2015-07-06 10:16:42,974 [ 2905] INFO - s.incremental.java.JavaBuilder - Compiling 1 java files; module: cofoja-example
2015-07-06 10:16:42,974 [ 2905] DEBUG - s.incremental.java.JavaBuilder - Compiling C:\source\research\cofoja-example\src\main\java\com\example\Example.java
2015-07-06 10:16:42,974 [ 2905] DEBUG - s.incremental.java.JavaBuilder - classpath for cofoja-example:
2015-07-06 10:16:42,974 [ 2905] DEBUG - s.incremental.java.JavaBuilder - C:\source\research\cofoja-example\target\classes
2015-07-06 10:16:42,974 [ 2905] DEBUG - s.incremental.java.JavaBuilder - C:\Users\sean.glover.m2\repository\io\konverge\cofoja\2.0.0\cofoja-2.0.0.jar
2015-07-06 10:16:42,974 [ 2905] DEBUG - s.incremental.java.JavaBuilder - C:\Users\sean.glover.m2\repository\org\ow2\asm\asm-all\4.1\asm-all-4.1.jar
2015-07-06 10:16:42,975 [ 2906] DEBUG - s.incremental.java.JavaBuilder - C:\Java\jdk-7u60-windows-x64\lib\tools.jar
2015-07-06 10:16:42,975 [ 2906] DEBUG - s.incremental.java.JavaBuilder - platform classpath for cofoja-example:
2015-07-06 10:16:42,975 [ 2906] DEBUG - s.incremental.java.JavaBuilder - C:\Java\jdk-7u60-windows-x64\jre\lib\charsets.jar
2015-07-06 10:16:42,975 [ 2906] DEBUG - s.incremental.java.JavaBuilder - C:\Java\jdk-7u60-windows-x64\jre\lib\deploy.jar
2015-07-06 10:16:42,975 [ 2906] DEBUG - s.incremental.java.JavaBuilder - C:\Java\jdk-7u60-windows-x64\jre\lib\javaws.jar
2015-07-06 10:16:42,975 [ 2906] DEBUG - s.incremental.java.JavaBuilder - C:\Java\jdk-7u60-windows-x64\jre\lib\jce.jar
2015-07-06 10:16:42,975 [ 2906] DEBUG - s.incremental.java.JavaBuilder - C:\Java\jdk-7u60-windows-x64\jre\lib\jfr.jar
2015-07-06 10:16:42,975 [ 2906] DEBUG - s.incremental.java.JavaBuilder - C:\Java\jdk-7u60-windows-x64\jre\lib\jfxrt.jar
2015-07-06 10:16:42,975 [ 2906] DEBUG - s.incremental.java.JavaBuilder - C:\Java\jdk-7u60-windows-x64\jre\lib\jsse.jar
2015-07-06 10:16:42,975 [ 2906] DEBUG - s.incremental.java.JavaBuilder - C:\Java\jdk-7u60-windows-x64\jre\lib\management-agent.jar
2015-07-06 10:16:42,975 [ 2906] DEBUG - s.incremental.java.JavaBuilder - C:\Java\jdk-7u60-windows-x64\jre\lib\plugin.jar
2015-07-06 10:16:42,975 [ 2906] DEBUG - s.incremental.java.JavaBuilder - C:\Java\jdk-7u60-windows-x64\jre\lib\resources.jar
2015-07-06 10:16:42,975 [ 2906] DEBUG - s.incremental.java.JavaBuilder - C:\Java\jdk-7u60-windows-x64\jre\lib\rt.jar
2015-07-06 10:16:42,975 [ 2906] DEBUG - s.incremental.java.JavaBuilder - C:\Java\jdk-7u60-windows-x64\jre\lib\ext\access-bridge-64.jar
2015-07-06 10:16:42,975 [ 2906] DEBUG - s.incremental.java.JavaBuilder - C:\Java\jdk-7u60-windows-x64\jre\lib\ext\dnsns.jar
2015-07-06 10:16:42,975 [ 2906] DEBUG - s.incremental.java.JavaBuilder - C:\Java\jdk-7u60-windows-x64\jre\lib\ext\jaccess.jar
2015-07-06 10:16:42,975 [ 2906] DEBUG - s.incremental.java.JavaBuilder - C:\Java\jdk-7u60-windows-x64\jre\lib\ext\localedata.jar
2015-07-06 10:16:42,975 [ 2906] DEBUG - s.incremental.java.JavaBuilder - C:\Java\jdk-7u60-windows-x64\jre\lib\ext\sunec.jar
2015-07-06 10:16:42,975 [ 2906] DEBUG - s.incremental.java.JavaBuilder - C:\Java\jdk-7u60-windows-x64\jre\lib\ext\sunjce_provider.jar
2015-07-06 10:16:42,975 [ 2906] DEBUG - s.incremental.java.JavaBuilder - C:\Java\jdk-7u60-windows-x64\jre\lib\ext\sunmscapi.jar
2015-07-06 10:16:42,975 [ 2906] DEBUG - s.incremental.java.JavaBuilder - C:\Java\jdk-7u60-windows-x64\jre\lib\ext\zipfs.jar
2015-07-06 10:16:42,978 [ 2909] DEBUG - s.incremental.java.JavaBuilder - Compiling chunk [cofoja-example] with options: "-g -deprecation -X -encoding UTF-8 -source 1.7 -target 1.7 -s C:\source\research\cofoja-example\target\generated-sources\annotations"
2015-07-06 10:16:43,048 [ 2979] DEBUG - sFileWithLengthAndSizeTracking - Closed:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\aj\aspect_path.dat.values@92eba22,Thread[pool-1-thread-2,5,main]
2015-07-06 10:16:43,095 [ 3026] DEBUG - #org.jetbrains.jps.TimingLog - Build finished
2015-07-06 10:16:43,097 [ 3028] DEBUG - sFileWithLengthAndSizeTracking - Closed:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\timestamps\data.values@39e48b4c,Thread[pool-1-thread-2,5,main]
2015-07-06 10:16:43,104 [ 3035] DEBUG - sFileWithLengthAndSizeTracking - Closed:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\out-target\data.values@74355c70,Thread[pool-1-thread-2,5,main]
2015-07-06 10:16:43,105 [ 3036] DEBUG - sFileWithLengthAndSizeTracking - Closed:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\src-form\data.values@7768997e,Thread[pool-1-thread-2,5,main]
2015-07-06 10:16:43,106 [ 3037] DEBUG - sFileWithLengthAndSizeTracking - Closed:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToSubclasses.tab.values@406c5e92,Thread[pool-1-thread-2,5,main]
2015-07-06 10:16:43,106 [ 3037] DEBUG - sFileWithLengthAndSizeTracking - Closed:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToClass.tab.values@ab4e449,Thread[pool-1-thread-2,5,main]
2015-07-06 10:16:43,107 [ 3038] DEBUG - sFileWithLengthAndSizeTracking - Closed:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\sourceToClass.tab.values@7671fa9d,Thread[pool-1-thread-2,5,main]
2015-07-06 10:16:43,107 [ 3038] DEBUG - sFileWithLengthAndSizeTracking - Closed:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\classToSource.tab.values@34fc962b,Thread[pool-1-thread-2,5,main]
2015-07-06 10:16:43,107 [ 3038] DEBUG - sFileWithLengthAndSizeTracking - Closed:C:\Users\sean.glover.IntelliJIdea14\system\compile-server\cofoja-example_3f9de157\mappings\shortNames.tab.values@69f77a1c,Thread[pool-1-thread-2,5,main]
2015-07-06 10:16:43,626 [ 0] INFO - etbrains.jps.cmdline.BuildMain - Build process started. Classpath: /C:/Program Files (x86)/JetBrains/IntelliJ IDEA 14.1.4/lib/jps-launcher.jar;C:/Java/jdk-7u60-windows-x64/lib/tools.jar;/C:/Program Files (x86)/JetBrains/IntelliJ IDEA 14.1.4/lib/optimizedFileManager.jar;C:/Program Files (x86)/JetBrains/IntelliJ IDEA 14.1.4/lib/ecj-4.4.jar
2015-07-06 10:16:43,660 [ 34] DEBUG - .logging.InternalLoggerFactory - Using Log4J as the default logging framework
2015-07-06 10:16:43,663 [ 37] DEBUG - nnel.MultithreadEventLoopGroup - -Dio.netty.eventLoopThreads: 8
2015-07-06 10:16:43,701 [ 75] DEBUG - il.internal.PlatformDependent0 - java.nio.Buffer.address: available
2015-07-06 10:16:43,701 [ 75] DEBUG - il.internal.PlatformDependent0 - sun.misc.Unsafe.theUnsafe: available
2015-07-06 10:16:43,701 [ 75] DEBUG - il.internal.PlatformDependent0 - sun.misc.Unsafe.copyMemory: available
2015-07-06 10:16:43,701 [ 75] DEBUG - il.internal.PlatformDependent0 - java.nio.Bits.unaligned: true
2015-07-06 10:16:43,702 [ 76] DEBUG - til.internal.PlatformDependent - Platform: Windows
2015-07-06 10:16:43,702 [ 76] DEBUG - til.internal.PlatformDependent - Java version: 7
2015-07-06 10:16:43,702 [ 76] DEBUG - til.internal.PlatformDependent - -Dio.netty.noUnsafe: false
2015-07-06 10:16:43,702 [ 76] DEBUG - til.internal.PlatformDependent - sun.misc.Unsafe: available
2015-07-06 10:16:43,702 [ 76] DEBUG - til.internal.PlatformDependent - -Dio.netty.noJavassist: false
2015-07-06 10:16:43,704 [ 78] DEBUG - til.internal.PlatformDependent - Javassist: unavailable
2015-07-06 10:16:43,704 [ 78] DEBUG - til.internal.PlatformDependent - You don't have Javassist in your class path or you don't have enough permission to load dynamically generated classes. Please check the configuration for better performance.
2015-07-06 10:16:43,704 [ 78] DEBUG - til.internal.PlatformDependent - -Dio.netty.tmpdir: C:\Users\sean.glover.IntelliJIdea14\system\compile-server_temp_ (java.io.tmpdir)
2015-07-06 10:16:43,704 [ 78] DEBUG - til.internal.PlatformDependent - -Dio.netty.bitMode: 64 (sun.arch.data.model)
2015-07-06 10:16:43,704 [ 78] DEBUG - til.internal.PlatformDependent - -Dio.netty.noPreferDirect: false
2015-07-06 10:16:43,705 [ 79] DEBUG - netty.channel.nio.NioEventLoop - -Dio.netty.noKeySetOptimization: false
2015-07-06 10:16:43,705 [ 79] DEBUG - netty.channel.nio.NioEventLoop - -Dio.netty.selectorAutoRebuildThreshold: 512
2015-07-06 10:16:43,766 [ 140] DEBUG - netty.channel.DefaultChannelId - -Dio.netty.processId: 39795 (user-set)
2015-07-06 10:16:43,767 [ 141] DEBUG - netty.channel.DefaultChannelId - -Dio.netty.machineId: 9e43d860 (user-set)
2015-07-06 10:16:43,769 [ 143] DEBUG - til.internal.ThreadLocalRandom - -Dio.netty.initialSeedUniquifier: 0x7303515b0858788f
2015-07-06 10:16:43,801 [ 175] DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.numHeapArenas: 4
2015-07-06 10:16:43,801 [ 175] DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.numDirectArenas: 4
2015-07-06 10:16:43,801 [ 175] DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.pageSize: 8192
2015-07-06 10:16:43,801 [ 175] DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.maxOrder: 11
2015-07-06 10:16:43,802 [ 176] DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.chunkSize: 16777216
2015-07-06 10:16:43,802 [ 176] DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.tinyCacheSize: 512
2015-07-06 10:16:43,802 [ 176] DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.smallCacheSize: 256
2015-07-06 10:16:43,802 [ 176] DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.normalCacheSize: 64
2015-07-06 10:16:43,802 [ 176] DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.maxCachedBufferCapacity: 32768
2015-07-06 10:16:43,802 [ 176] DEBUG - .buffer.PooledByteBufAllocator - -Dio.netty.allocator.cacheTrimInterval: 8192
2015-07-06 10:16:43,809 [ 183] DEBUG - io.netty.buffer.ByteBufUtil - -Dio.netty.allocator.type: pooled
2015-07-06 10:16:43,809 [ 183] DEBUG - io.netty.buffer.ByteBufUtil - -Dio.netty.threadLocalDirectBufferSize: 65536
2015-07-06 10:16:43,898 [ 272] INFO - etbrains.jps.cmdline.BuildMain - Connection to IDE established in 246 ms
2015-07-06 10:16:43,910 [ 284] INFO - penapi.util.io.win32.IdeaWin32 - Native filesystem for Windows is operational
2015-07-06 10:16:43,910 [ 284] DEBUG - penapi.util.io.win32.IdeaWin32 - getInfo(C:)
2015-07-06 10:16:43,911 [ 285] DEBUG - penapi.util.io.win32.IdeaWin32 - 93 mks
2015-07-06 10:16:43,913 [ 287] DEBUG - penapi.util.io.win32.IdeaWin32 - getInfo(C:\source\research\cofoja-example)
2015-07-06 10:16:43,913 [ 287] DEBUG - penapi.util.io.win32.IdeaWin32 - 88 mks
2015-07-06 10:16:43,937 [ 311] INFO - jps.cmdline.JpsModelLoaderImpl - Loading model: project path = C:/source/research/cofoja-example, global options path = C:/Users/sean.glover/.IntelliJIdea14/config/options
2015-07-06 10:16:44,018 [ 392] DEBUG - #org.jetbrains.jps.TimingLog - loading: path.macros.xml:PathMacrosImpl in 48ms
2015-07-06 10:16:44,022 [ 396] DEBUG - .serialization.JpsGlobalLoader - Loading config from C:\Users\sean.glover.IntelliJIdea14\config\options
2015-07-06 10:16:44,022 [ 396] DEBUG - #org.jetbrains.jps.TimingLog - loading: applicationLibraries.xml:libraryTable in 0ms
2015-07-06 10:16:44,034 [ 408] DEBUG - .library.JpsSdkTableSerializer - Loading JavaSDK SDK '1.7'
2015-07-06 10:16:44,099 [ 473] DEBUG - .library.JpsSdkTableSerializer - 1.7 SDK classpath (19 roots):
2015-07-06 10:16:44,099 [ 473] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\charsets.jar
2015-07-06 10:16:44,100 [ 474] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\deploy.jar
2015-07-06 10:16:44,100 [ 474] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\javaws.jar
2015-07-06 10:16:44,100 [ 474] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\jce.jar
2015-07-06 10:16:44,100 [ 474] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\jfr.jar
2015-07-06 10:16:44,100 [ 474] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\jfxrt.jar
2015-07-06 10:16:44,100 [ 474] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\jsse.jar
2015-07-06 10:16:44,100 [ 474] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\management-agent.jar
2015-07-06 10:16:44,100 [ 474] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\plugin.jar
2015-07-06 10:16:44,100 [ 474] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\resources.jar
2015-07-06 10:16:44,100 [ 474] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\rt.jar
2015-07-06 10:16:44,100 [ 474] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\ext\access-bridge-64.jar
2015-07-06 10:16:44,100 [ 474] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\ext\dnsns.jar
2015-07-06 10:16:44,100 [ 474] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\ext\jaccess.jar
2015-07-06 10:16:44,100 [ 474] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\ext\localedata.jar
2015-07-06 10:16:44,100 [ 474] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\ext\sunec.jar
2015-07-06 10:16:44,100 [ 474] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\ext\sunjce_provider.jar
2015-07-06 10:16:44,100 [ 474] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\ext\sunmscapi.jar
2015-07-06 10:16:44,100 [ 474] DEBUG - .library.JpsSdkTableSerializer - C:\Java\jdk-7u60-windows-x64\jre\lib\ext\zipfs.jar
2015-07-06 10:16:44,108 [ 482] DEBUG - .library.JpsSdkTableSerializer - Loading JavaSDK SDK '1.8'
2015-07-06 10:16:44,108 [ 482] DEBUG - .library.JpsSdkTableSerializer - 1.8 SDK classpath (23 roots):
2015-07-06 10:16:44,108 [ 482] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\charsets.jar
2015-07-06 10:16:44,108 [ 482] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\deploy.jar
2015-07-06 10:16:44,108 [ 482] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\javaws.jar
2015-07-06 10:16:44,108 [ 482] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\jce.jar
2015-07-06 10:16:44,108 [ 482] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\jfr.jar
2015-07-06 10:16:44,109 [ 483] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\jfxswt.jar
2015-07-06 10:16:44,109 [ 483] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\jsse.jar
2015-07-06 10:16:44,109 [ 483] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\management-agent.jar
2015-07-06 10:16:44,109 [ 483] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\plugin.jar
2015-07-06 10:16:44,109 [ 483] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\resources.jar
2015-07-06 10:16:44,109 [ 483] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\rt.jar
2015-07-06 10:16:44,109 [ 483] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\access-bridge-64.jar
2015-07-06 10:16:44,109 [ 483] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\cldrdata.jar
2015-07-06 10:16:44,109 [ 483] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\dnsns.jar
2015-07-06 10:16:44,109 [ 483] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\jaccess.jar
2015-07-06 10:16:44,109 [ 483] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\jfxrt.jar
2015-07-06 10:16:44,109 [ 483] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\localedata.jar
2015-07-06 10:16:44,109 [ 483] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\nashorn.jar
2015-07-06 10:16:44,109 [ 483] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\sunec.jar
2015-07-06 10:16:44,109 [ 483] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\sunjce_provider.jar
2015-07-06 10:16:44,109 [ 483] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\sunmscapi.jar
2015-07-06 10:16:44,110 [ 484] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\sunpkcs11.jar
2015-07-06 10:16:44,110 [ 484] DEBUG - .library.JpsSdkTableSerializer - C:\Program Files\Java\jdk1.8.0_45\jre\lib\ext\zipfs.jar
2015-07-06 10:16:44,110 [ 484] DEBUG - #org.jetbrains.jps.TimingLog - loading: jdk.table.xml:ProjectJdkTable in 88ms
2015-07-06 10:16:44,111 [ 485] DEBUG - #org.jetbrains.jps.TimingLog - loading: filetypes.xml:FileTypeManager in 1ms
2015-07-06 10:16:44,113 [ 487] DEBUG - #org.jetbrains.jps.TimingLog - loading: encoding.xml:Encoding in 2ms
2015-07-06 10:16:44,117 [ 491] DEBUG - #org.jetbrains.jps.TimingLog - loading: other.xml:GlobalAntConfiguration in 3ms
2015-07-06 10:16:44,122 [ 496] DEBUG - #org.jetbrains.jps.TimingLog - loading: IntelliLang.xml:LanguageInjectionConfiguration in 4ms
2015-07-06 10:16:44,124 [ 498] DEBUG - #org.jetbrains.jps.TimingLog - loading: osmorc.xml:Osmorc in 1ms
2015-07-06 10:16:44,125 [ 499] DEBUG - #org.jetbrains.jps.TimingLog - loading: javaeeAppServers.xml:AppserversManager in 0ms
2015-07-06 10:16:44,147 [ 521] DEBUG - #org.jetbrains.jps.TimingLog - loading: scala.xml:ScalaSettings in 21ms
2015-07-06 10:16:44,171 [ 545] DEBUG - #org.jetbrains.jps.TimingLog - loading: misc.xml:ProjectRootManager in 15ms
2015-07-06 10:16:44,177 [ 551] DEBUG - #org.jetbrains.jps.TimingLog - loading: compiler.xml:CompilerConfiguration in 6ms
2015-07-06 10:16:44,216 [ 590] DEBUG - #org.jetbrains.jps.TimingLog - loading: workspace.xml:CompilerWorkspaceConfiguration in 39ms
2015-07-06 10:16:44,222 [ 596] DEBUG - #org.jetbrains.jps.TimingLog - loading: compiler.xml:JavacSettings in 6ms
2015-07-06 10:16:44,225 [ 599] DEBUG - #org.jetbrains.jps.TimingLog - loading: compiler.xml:EclipseCompilerSettings in 3ms
2015-07-06 10:16:44,228 [ 602] DEBUG - #org.jetbrains.jps.TimingLog - loading: compiler.xml:RmicSettings in 3ms
2015-07-06 10:16:44,231 [ 605] DEBUG - #org.jetbrains.jps.TimingLog - loading: encodings.xml:Encoding in 2ms
2015-07-06 10:16:44,233 [ 607] DEBUG - #org.jetbrains.jps.TimingLog - loading: ant.xml:AntConfiguration in 0ms
2015-07-06 10:16:44,283 [ 657] DEBUG - #org.jetbrains.jps.TimingLog - loading: workspace.xml:antWorkspaceConfiguration in 50ms
2015-07-06 10:16:44,286 [ 660] DEBUG - #org.jetbrains.jps.TimingLog - loading: uiDesigner.xml:uidesigner-configuration in 2ms
2015-07-06 10:16:44,287 [ 661] DEBUG - #org.jetbrains.jps.TimingLog - loading: groovyc.xml:GroovyCompilerProjectConfiguration in 0ms
2015-07-06 10:16:44,290 [ 664] DEBUG - #org.jetbrains.jps.TimingLog - loading: compiler.xml:GreclipseSettings in 3ms
2015-07-06 10:16:44,293 [ 667] DEBUG - #org.jetbrains.jps.TimingLog - loading: misc.xml:Osmorc in 3ms
2015-07-06 10:16:44,297 [ 671] DEBUG - #org.jetbrains.jps.TimingLog - loading: compiler.xml:AjcSettings in 3ms
2015-07-06 10:16:44,330 [ 704] DEBUG - #org.jetbrains.jps.TimingLog - loading: workspace.xml:FlexCompilerConfiguration in 31ms
2015-07-06 10:16:44,330 [ 704] DEBUG - #org.jetbrains.jps.TimingLog - loading: flexCompiler.xml:FlexCompilerConfiguration in 0ms
2015-07-06 10:16:44,362 [ 736] DEBUG - #org.jetbrains.jps.TimingLog - loading: workspace.xml:FlexIdeProjectLevelCompilerOptionsHolder in 31ms
2015-07-06 10:16:44,362 [ 736] DEBUG - #org.jetbrains.jps.TimingLog - loading: flexCompiler.xml:FlexIdeProjectLevelCompilerOptionsHolder in 0ms
2015-07-06 10:16:44,393 [ 767] DEBUG - #org.jetbrains.jps.TimingLog - loading: workspace.xml:GwtCompilerConfiguration in 30ms
2015-07-06 10:16:44,394 [ 768] DEBUG - #org.jetbrains.jps.TimingLog - loading: androidDexCompiler.xml:AndroidDexCompilerConfiguration in 0ms
2015-07-06 10:16:44,395 [ 769] DEBUG - #org.jetbrains.jps.TimingLog - loading: scala_compiler.xml:ScalaCompilerConfiguration in 0ms
2015-07-06 10:16:44,401 [ 775] DEBUG - #org.jetbrains.jps.TimingLog - loading: play2_project_settings.xml:Play2ExcludedModulesSettings in 2ms
2015-07-06 10:16:44,401 [ 775] DEBUG - #org.jetbrains.jps.TimingLog - loading: play2_compiler_settings.xml:Play2CompilerConfiguration in 0ms
2015-07-06 10:16:44,445 [ 819] DEBUG - #org.jetbrains.jps.TimingLog - loading modules in 43ms
2015-07-06 10:16:44,457 [ 831] DEBUG - #org.jetbrains.jps.TimingLog - loading project libraries in 12ms
2015-07-06 10:16:44,457 [ 831] DEBUG - #org.jetbrains.jps.TimingLog - loading artifacts in 0ms
2015-07-06 10:16:44,486 [ 860] DEBUG - #org.jetbrains.jps.TimingLog - loading run configurations in 26ms
2015-07-06 10:16:44,486 [ 860] INFO - jps.cmdline.JpsModelLoaderImpl - Model loaded in 549 ms
2015-07-06 10:16:44,486 [ 860] INFO - jps.cmdline.JpsModelLoaderImpl - Project has 1 modules, 8 libraries
2015-07-06 10:16:44,649 [ 1023] INFO - ellij.util.io.PagedFileStorage - lower=100; upper=200; buffer=10; max=631767040
2015-07-06 10:16:44,851 [ 1225] INFO - etbrains.jps.cmdline.BuildMain - Pre-loaded process ready in 1226 ms
2015-07-06 10:16:44,860 [ 1234] DEBUG - io.netty.util.Recycler - -Dio.netty.recycler.maxCapacity: 262144
2015-07-06 10:16:44,876 [ 1250] DEBUG - etty.util.ResourceLeakDetector - -Dio.netty.leakDetectionLevel: simple
2015-07-06 10:17:08,061 [ 24435] INFO - etbrains.jps.cmdline.BuildMain - Build canceled, but no build session is running. Exiting.


Reply to this email directly or view it on GitHub
#45 (comment).

@nkavian
Copy link

nkavian commented Jul 11, 2015

For some reason IntelliJ doesn't like the classoutput path being set. I'd recommend sticking with Eclipse.

Aside from that, another overall problem is that cofoja won't work with Java 8 since some things are now missing in the tools.jar. i.e. Make sure to configure IntelliJ to Java 7 and you'll see the below stack trace.

This is a great library compared to other DBC frameworks, sucks that certain things don't work..

Error: java.lang.RuntimeException: java.io.FileNotFoundException: /Users/NasK/Dropbox/Source/tmep/cofoja-example/target/classes -Acom.google.java.contract.classpath=/Users/NasK/Dropbox/Source/tmep/cofoja-example/cofoja-2.0.0.jar -Acom.google.java.contract.sourcepath=/Users/NasK/Dropbox/Source/tmep/cofoja-example/src/main/java: does not exist
java.lang.RuntimeException: java.lang.RuntimeException: java.io.FileNotFoundException: /Users/NasK/Dropbox/Source/tmep/cofoja-example/target/classes -Acom.google.java.contract.classpath=/Users/NasK/Dropbox/Source/tmep/cofoja-example/cofoja-2.0.0.jar -Acom.google.java.contract.sourcepath=/Users/NasK/Dropbox/Source/tmep/cofoja-example/src/main/java: does not exist
    at com.sun.tools.javac.main.Main.compile(Main.java:469)
    at com.sun.tools.javac.api.JavacTaskImpl.call(JavacTaskImpl.java:132)
    at org.jetbrains.jps.javac.JavacMain.compile(JavacMain.java:167)
    at org.jetbrains.jps.incremental.java.JavaBuilder.compileJava(JavaBuilder.java:364)
    at org.jetbrains.jps.incremental.java.JavaBuilder.compile(JavaBuilder.java:276)
    at org.jetbrains.jps.incremental.java.JavaBuilder.doBuild(JavaBuilder.java:190)
    at org.jetbrains.jps.incremental.java.JavaBuilder.build(JavaBuilder.java:162)
    at org.jetbrains.jps.incremental.IncProjectBuilder.runModuleLevelBuilders(IncProjectBuilder.java:1018)
    at org.jetbrains.jps.incremental.IncProjectBuilder.runBuildersForChunk(IncProjectBuilder.java:742)
    at org.jetbrains.jps.incremental.IncProjectBuilder.buildTargetsChunk(IncProjectBuilder.java:790)
    at org.jetbrains.jps.incremental.IncProjectBuilder.buildChunkIfAffected(IncProjectBuilder.java:705)
    at org.jetbrains.jps.incremental.IncProjectBuilder.buildChunks(IncProjectBuilder.java:526)
    at org.jetbrains.jps.incremental.IncProjectBuilder.runBuild(IncProjectBuilder.java:314)
    at org.jetbrains.jps.incremental.IncProjectBuilder.build(IncProjectBuilder.java:179)
    at org.jetbrains.jps.cmdline.BuildRunner.runBuild(BuildRunner.java:129)
    at org.jetbrains.jps.cmdline.BuildSession.runBuild(BuildSession.java:220)
    at org.jetbrains.jps.cmdline.BuildSession.run(BuildSession.java:112)
    at org.jetbrains.jps.cmdline.BuildMain$MyMessageHandler$1.run(BuildMain.java:132)
    at org.jetbrains.jps.service.impl.SharedThreadPoolImpl$1.run(SharedThreadPoolImpl.java:41)
    at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
    at java.util.concurrent.FutureTask.run(FutureTask.java:262)
    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
    at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.RuntimeException: java.io.FileNotFoundException: /Users/NasK/Dropbox/Source/tmep/cofoja-example/target/classes -Acom.google.java.contract.classpath=/Users/NasK/Dropbox/Source/tmep/cofoja-example/cofoja-2.0.0.jar -Acom.google.java.contract.sourcepath=/Users/NasK/Dropbox/Source/tmep/cofoja-example/src/main/java: does not exist
    at com.google.java.contract.core.apt.AnnotationProcessor.process(AnnotationProcessor.java:189)
    at com.sun.tools.javac.processing.JavacProcessingEnvironment.callProcessor(JavacProcessingEnvironment.java:793)
    at com.sun.tools.javac.processing.JavacProcessingEnvironment.discoverAndRunProcs(JavacProcessingEnvironment.java:722)
    at com.sun.tools.javac.processing.JavacProcessingEnvironment.access$1700(JavacProcessingEnvironment.java:97)
    at com.sun.tools.javac.processing.JavacProcessingEnvironment$Round.run(JavacProcessingEnvironment.java:1029)
    at com.sun.tools.javac.processing.JavacProcessingEnvironment.doProcessing(JavacProcessingEnvironment.java:1163)
    at com.sun.tools.javac.main.JavaCompiler.processAnnotations(JavaCompiler.java:1108)
    at com.sun.tools.javac.main.JavaCompiler.compile(JavaCompiler.java:824)
    at com.sun.tools.javac.main.Main.compile(Main.java:439)
    ... 23 more
Caused by: java.io.FileNotFoundException: /Users/NasK/Dropbox/Source/tmep/cofoja-example/target/classes -Acom.google.java.contract.classpath=/Users/NasK/Dropbox/Source/tmep/cofoja-example/cofoja-2.0.0.jar -Acom.google.java.contract.sourcepath=/Users/NasK/Dropbox/Source/tmep/cofoja-example/src/main/java: does not exist
    at com.sun.tools.javac.file.JavacFileManager.getOutputDirectory(JavacFileManager.java:840)
    at com.sun.tools.javac.file.JavacFileManager.setLocation(JavacFileManager.java:820)
    at com.google.java.contract.core.apt.ContractJavaFileManager.setLocation(ContractJavaFileManager.java:124)
    at com.google.java.contract.core.apt.ContractJavaCompiler.setClassOutputDirectory(ContractJavaCompiler.java:120)
    at com.google.java.contract.core.apt.ContractJavaCompiler.<init>(ContractJavaCompiler.java:86)
    at com.google.java.contract.core.apt.AnnotationProcessor.process(AnnotationProcessor.java:184)
    ... 31 more

@seglo
Copy link
Author

seglo commented Jul 12, 2015

I was able to successfully configure IntelliJ. Thanks for both your help.

I had to configure Annotation Processors for the current project. It was enabled by default, but without the appropriate configuration required for classoutput, classpath, and sourcepath settings. I discovered the $PROJECT_DIR$ macro to make relative paths to appropriate project directories. IntelliJ had a pre-configured macro/variable to my local maven repository, so I used that to refer to konvergeio's published version of cofoja.

I took a screenshot of my configuration:

intellij-cofoja-annotation-processor

IntelliJ's resulting build log:

2015-07-12 14:04:11,448 [   1223]  DEBUG - s.incremental.java.JavaBuilder - Compiling chunk [cofoja-example] with options: "-g -deprecation -encoding UTF-8 -source 1.7 -target 1.7 -Acom.google.java.contract.sourcepath=/home/seglo/source/cofoja-example/src/main/java -Acom.google.java.contract.classpath=/home/seglo/.m2/repository/io/konverge/cofoja/2.0.0/cofoja-2.0.0.jar -Acom.google.java.contract.classoutput=/home/seglo/source/cofoja-example/target/classes -s /home/seglo/source/cofoja-example/target/generated-sources/annotations" 

I pushed the fork of Nas's cofoja-example project to my github. I included the IntelliJ project settings.

https://github.com/seglo/cofoja-example

One question for @nkavian: Why does cofoja-example configure maven <compilerArgs> and <compilerArgument>? A maven build runs fine, but the <compilerArgument> config makes IntelliJ complain, so I commented it out. Is this redundant config?

EDIT: My project's .idea/compiler.xml:

<?xml version="1.0" encoding="UTF-8"?>
<project version="4">
  <component name="CompilerConfiguration">
    <option name="DEFAULT_COMPILER" value="Javac" />
    <resourceExtensions />
    <wildcardResourcePatterns>
      <entry name="!?*.java" />
      <entry name="!?*.form" />
      <entry name="!?*.class" />
      <entry name="!?*.groovy" />
      <entry name="!?*.scala" />
      <entry name="!?*.flex" />
      <entry name="!?*.kt" />
      <entry name="!?*.clj" />
      <entry name="!?*.aj" />
    </wildcardResourcePatterns>
    <annotationProcessing>
      <profile default="true" name="Default" enabled="false">
        <processorPath useClasspath="true" />
      </profile>
      <profile default="false" name="Maven default annotation processors profile" enabled="true">
        <sourceOutputDir name="target/generated-sources/annotations" />
        <sourceTestOutputDir name="target/generated-test-sources/test-annotations" />
        <outputRelativeToContentRoot value="true" />
        <option name="com.google.java.contract.classoutput" value="$PROJECT_DIR$/target/classes" />
        <option name="com.google.java.contract.classpath" value="$MAVEN_REPOSITORY$/io/konverge/cofoja/2.0.0/cofoja-2.0.0.jar" />
        <option name="com.google.java.contract.sourcepath" value="$PROJECT_DIR$/src/main/java" />
        <processorPath useClasspath="true" />
        <module name="cofoja-example" />
      </profile>
    </annotationProcessing>
    <bytecodeTargetLevel>
      <module name="cofoja-example" target="1.7" />
    </bytecodeTargetLevel>
  </component>
</project>

@i-oliva
Copy link

i-oliva commented Jan 25, 2018

If I clone your project in my intellij will it work? Because I cloned it and I am still getting the same...
Error:java: error in contract: package com.google.java.contract.core.agent does not exist Error:java: error in contract: package com.google.java.contract does not exist

@darvid7
Copy link

darvid7 commented Mar 18, 2018

+1

@i-oliva
Copy link

i-oliva commented Mar 18, 2018

Hey @darvid7 please check this. I managed it to work. If you have any questions please let me know.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

No branches or pull requests

5 participants