Hi,
I’m trying to integrate the storage classes and I’m hitting another issue when
running terasort and just
using the crail-shuffle with HDFS as the tmp storage. The program just sits,
after the following
message:
19/06/27 15:59:20 DEBUG Client: IPC Client (1998371610) connection to
NameNode-1/192.168.3.7:54310 from hduser: closed
19/06/27 15:59:20 DEBUG Client: IPC Client (1998371610) connection to
NameNode-1/192.168.3.7:54310 from hduser: stopped, remaining connections 0
During this run, I’ve removed the two crail nvmf (class 1 and 2) containers
from the server, and I’m only running
the namenode and a rdma storage class 1 datanode. My spark configuration is
also now only looking at
the rdma class. It looks as though it’s picking up the NVMf IP and port in the
INFO messages seen below.
I must be configuring something wrong, but I’ve not been able to track it down.
Any thoughts?
************************************
TeraSort
************************************
SLF4J: Class path contains multiple SLF4J bindings.
SLF4J: Found binding in
[jar:file:/crail/jars/slf4j-log4j12-1.7.12.jar!/org/slf4j/impl/StaticLoggerBinder.class]
SLF4J: Found binding in
[jar:file:/crail/jars/jnvmf-1.6-jar-with-dependencies.jar!/org/slf4j/impl/StaticLoggerBinder.class]
SLF4J: Found binding in
[jar:file:/crail/jars/disni-2.1-jar-with-dependencies.jar!/org/slf4j/impl/StaticLoggerBinder.class]
SLF4J: Found binding in
[jar:file:/usr/spark-2.4.2/jars/slf4j-log4j12-1.7.16.jar!/org/slf4j/impl/StaticLoggerBinder.class]
SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation.
SLF4J: Actual binding is of type [org.slf4j.impl.Log4jLoggerFactory]
19/06/27 15:59:07 WARN NativeCodeLoader: Unable to load native-hadoop library
for your platform... using builtin-java classes where applicable
19/06/27 15:59:07 INFO SparkContext: Running Spark version 2.4.2
19/06/27 15:59:07 INFO SparkContext: Submitted application: TeraSort
19/06/27 15:59:07 INFO SecurityManager: Changing view acls to: hduser
19/06/27 15:59:07 INFO SecurityManager: Changing modify acls to: hduser
19/06/27 15:59:07 INFO SecurityManager: Changing view acls groups to:
19/06/27 15:59:07 INFO SecurityManager: Changing modify acls groups to:
19/06/27 15:59:07 INFO SecurityManager: SecurityManager: authentication
disabled; ui acls disabled; users with view permissions: Set(hduser); groups
with view permissions: Set(); users with modify permissions: Set(hduser);
groups with modify permissions: Set()
19/06/27 15:59:08 DEBUG InternalLoggerFactory: Using SLF4J as the default
logging framework
19/06/27 15:59:08 DEBUG InternalThreadLocalMap:
-Dio.netty.threadLocalMap.stringBuilder.initialSize: 1024
19/06/27 15:59:08 DEBUG InternalThreadLocalMap:
-Dio.netty.threadLocalMap.stringBuilder.maxSize: 4096
19/06/27 15:59:08 DEBUG MultithreadEventLoopGroup: -Dio.netty.eventLoopThreads:
112
19/06/27 15:59:08 DEBUG PlatformDependent0: -Dio.netty.noUnsafe: false
19/06/27 15:59:08 DEBUG PlatformDependent0: Java version: 8
19/06/27 15:59:08 DEBUG PlatformDependent0: sun.misc.Unsafe.theUnsafe: available
19/06/27 15:59:08 DEBUG PlatformDependent0: sun.misc.Unsafe.copyMemory:
available
19/06/27 15:59:08 DEBUG PlatformDependent0: java.nio.Buffer.address: available
19/06/27 15:59:08 DEBUG PlatformDependent0: direct buffer constructor: available
19/06/27 15:59:08 DEBUG PlatformDependent0: java.nio.Bits.unaligned: available,
true
19/06/27 15:59:08 DEBUG PlatformDependent0:
jdk.internal.misc.Unsafe.allocateUninitializedArray(int): unavailable prior to
Java9
19/06/27 15:59:08 DEBUG PlatformDependent0:
java.nio.DirectByteBuffer.<init>(long, int): available
19/06/27 15:59:08 DEBUG PlatformDependent: sun.misc.Unsafe: available
19/06/27 15:59:08 DEBUG PlatformDependent: -Dio.netty.tmpdir: /tmp
(java.io.tmpdir)
19/06/27 15:59:08 DEBUG PlatformDependent: -Dio.netty.bitMode: 64
(sun.arch.data.model)
19/06/27 15:59:08 DEBUG PlatformDependent: -Dio.netty.noPreferDirect: false
19/06/27 15:59:08 DEBUG PlatformDependent: -Dio.netty.maxDirectMemory:
1029177344 bytes
19/06/27 15:59:08 DEBUG PlatformDependent:
-Dio.netty.uninitializedArrayAllocationThreshold: -1
19/06/27 15:59:08 DEBUG CleanerJava6: java.nio.ByteBuffer.cleaner(): available
19/06/27 15:59:08 DEBUG NioEventLoop: -Dio.netty.noKeySetOptimization: false
19/06/27 15:59:08 DEBUG NioEventLoop: -Dio.netty.selectorAutoRebuildThreshold:
512
19/06/27 15:59:08 DEBUG PlatformDependent:
org.jctools-core.MpscChunkedArrayQueue: available
19/06/27 15:59:08 DEBUG ResourceLeakDetector: -Dio.netty.leakDetection.level:
simple
19/06/27 15:59:08 DEBUG ResourceLeakDetector:
-Dio.netty.leakDetection.targetRecords: 4
19/06/27 15:59:08 DEBUG PooledByteBufAllocator:
-Dio.netty.allocator.numHeapArenas: 9
19/06/27 15:59:08 DEBUG PooledByteBufAllocator:
-Dio.netty.allocator.numDirectArenas: 10
19/06/27 15:59:08 DEBUG PooledByteBufAllocator: -Dio.netty.allocator.pageSize:
8192
19/06/27 15:59:08 DEBUG PooledByteBufAllocator: -Dio.netty.allocator.maxOrder:
11
19/06/27 15:59:08 DEBUG PooledByteBufAllocator: -Dio.netty.allocator.chunkSize:
16777216
19/06/27 15:59:08 DEBUG PooledByteBufAllocator:
-Dio.netty.allocator.tinyCacheSize: 512
19/06/27 15:59:08 DEBUG PooledByteBufAllocator:
-Dio.netty.allocator.smallCacheSize: 256
19/06/27 15:59:08 DEBUG PooledByteBufAllocator:
-Dio.netty.allocator.normalCacheSize: 64
19/06/27 15:59:08 DEBUG PooledByteBufAllocator:
-Dio.netty.allocator.maxCachedBufferCapacity: 32768
19/06/27 15:59:08 DEBUG PooledByteBufAllocator:
-Dio.netty.allocator.cacheTrimInterval: 8192
19/06/27 15:59:08 DEBUG PooledByteBufAllocator:
-Dio.netty.allocator.useCacheForAllThreads: true
19/06/27 15:59:08 DEBUG DefaultChannelId: -Dio.netty.processId: 2236
(auto-detected)
19/06/27 15:59:08 DEBUG NetUtil: -Djava.net.preferIPv4Stack: false
19/06/27 15:59:08 DEBUG NetUtil: -Djava.net.preferIPv6Addresses: false
19/06/27 15:59:08 DEBUG NetUtil: Loopback interface: lo (lo, 127.0.0.1)
19/06/27 15:59:08 DEBUG NetUtil: /proc/sys/net/core/somaxconn: 128
19/06/27 15:59:08 DEBUG DefaultChannelId: -Dio.netty.machineId:
02:42:ac:ff:fe:1b:00:02 (auto-detected)
19/06/27 15:59:08 DEBUG ByteBufUtil: -Dio.netty.allocator.type: pooled
19/06/27 15:59:08 DEBUG ByteBufUtil: -Dio.netty.threadLocalDirectBufferSize:
65536
19/06/27 15:59:08 DEBUG ByteBufUtil: -Dio.netty.maxThreadLocalCharBufferSize:
16384
19/06/27 15:59:08 DEBUG TransportServer: Shuffle server started on port: 36915
19/06/27 15:59:08 INFO Utils: Successfully started service 'sparkDriver' on
port 36915.
19/06/27 15:59:08 DEBUG SparkEnv: Using serializer: class
org.apache.spark.serializer.KryoSerializer
19/06/27 15:59:08 INFO SparkEnv: Registering MapOutputTracker
19/06/27 15:59:08 DEBUG MapOutputTrackerMasterEndpoint: init
19/06/27 15:59:08 INFO CrailShuffleManager: crail shuffle started
19/06/27 15:59:08 INFO SparkEnv: Registering BlockManagerMaster
19/06/27 15:59:08 INFO BlockManagerMasterEndpoint: Using
org.apache.spark.storage.DefaultTopologyMapper for getting topology information
19/06/27 15:59:08 INFO BlockManagerMasterEndpoint: BlockManagerMasterEndpoint up
19/06/27 15:59:08 INFO DiskBlockManager: Created local directory at
/tmp/blockmgr-15237510-f459-40e3-8390-10f4742930a5
19/06/27 15:59:08 DEBUG DiskBlockManager: Adding shutdown hook
19/06/27 15:59:08 INFO MemoryStore: MemoryStore started with capacity 366.3 MB
19/06/27 15:59:08 INFO SparkEnv: Registering OutputCommitCoordinator
19/06/27 15:59:08 DEBUG
OutputCommitCoordinator$OutputCommitCoordinatorEndpoint: init
19/06/27 15:59:08 DEBUG SecurityManager: Created SSL options for ui:
SSLOptions{enabled=false, port=None, keyStore=None, keyStorePassword=None,
trustStore=None, trustStorePassword=None, protocol=None,
enabledAlgorithms=Set()}
19/06/27 15:59:08 INFO Utils: Successfully started service 'SparkUI' on port
4040.
19/06/27 15:59:08 INFO SparkUI: Bound SparkUI to 0.0.0.0, and started at
http://192.168.1.161:4040
19/06/27 15:59:08 INFO SparkContext: Added JAR
file:/spark-terasort/target/spark-terasort-1.1-SNAPSHOT-jar-with-dependencies.jar
at
spark://master:36915/jars/spark-terasort-1.1-SNAPSHOT-jar-with-dependencies.jar
with timestamp 1561676348562
19/06/27 15:59:08 INFO StandaloneAppClient$ClientEndpoint: Connecting to master
spark://master:7077...
19/06/27 15:59:08 DEBUG TransportClientFactory: Creating new connection to
master/192.168.3.13:7077
19/06/27 15:59:08 DEBUG AbstractByteBuf:
-Dio.netty.buffer.bytebuf.checkAccessible: true
19/06/27 15:59:08 DEBUG ResourceLeakDetectorFactory: Loaded default
ResourceLeakDetector: io.netty.util.ResourceLeakDetector@5b1bb5d2
19/06/27 15:59:08 DEBUG TransportClientFactory: Connection to
master/192.168.3.13:7077 successful, running bootstraps...
19/06/27 15:59:08 INFO TransportClientFactory: Successfully created connection
to master/192.168.3.13:7077 after 41 ms (0 ms spent in bootstraps)
19/06/27 15:59:08 DEBUG Recycler: -Dio.netty.recycler.maxCapacityPerThread:
32768
19/06/27 15:59:08 DEBUG Recycler: -Dio.netty.recycler.maxSharedCapacityFactor: 2
19/06/27 15:59:08 DEBUG Recycler: -Dio.netty.recycler.linkCapacity: 16
19/06/27 15:59:08 DEBUG Recycler: -Dio.netty.recycler.ratio: 8
19/06/27 15:59:08 INFO StandaloneSchedulerBackend: Connected to Spark cluster
with app ID app-20190627155908-0005
19/06/27 15:59:08 INFO StandaloneAppClient$ClientEndpoint: Executor added:
app-20190627155908-0005/0 on worker-20190627152154-192.168.3.11-8882
(192.168.3.11:8882) with 2 core(s)
19/06/27 15:59:08 INFO StandaloneSchedulerBackend: Granted executor ID
app-20190627155908-0005/0 on hostPort 192.168.3.11:8882 with 2 core(s), 1024.0
MB RAM
19/06/27 15:59:08 INFO StandaloneAppClient$ClientEndpoint: Executor added:
app-20190627155908-0005/1 on worker-20190627152150-192.168.3.12-8881
(192.168.3.12:8881) with 2 core(s)
19/06/27 15:59:08 INFO StandaloneSchedulerBackend: Granted executor ID
app-20190627155908-0005/1 on hostPort 192.168.3.12:8881 with 2 core(s), 1024.0
MB RAM
19/06/27 15:59:08 DEBUG TransportServer: Shuffle server started on port: 39189
19/06/27 15:59:08 INFO Utils: Successfully started service
'org.apache.spark.network.netty.NettyBlockTransferService' on port 39189.
19/06/27 15:59:08 INFO StandaloneAppClient$ClientEndpoint: Executor added:
app-20190627155908-0005/2 on worker-20190627152203-192.168.3.9-8884
(192.168.3.9:8884) with 2 core(s)
19/06/27 15:59:08 INFO NettyBlockTransferService: Server created on master:39189
19/06/27 15:59:08 INFO StandaloneSchedulerBackend: Granted executor ID
app-20190627155908-0005/2 on hostPort 192.168.3.9:8884 with 2 core(s), 1024.0
MB RAM
19/06/27 15:59:08 INFO StandaloneAppClient$ClientEndpoint: Executor added:
app-20190627155908-0005/3 on worker-20190627152158-192.168.3.10-8883
(192.168.3.10:8883) with 2 core(s)
19/06/27 15:59:08 INFO StandaloneSchedulerBackend: Granted executor ID
app-20190627155908-0005/3 on hostPort 192.168.3.10:8883 with 2 core(s), 1024.0
MB RAM
19/06/27 15:59:08 INFO StandaloneAppClient$ClientEndpoint: Executor added:
app-20190627155908-0005/4 on worker-20190627152207-192.168.3.8-8885
(192.168.3.8:8885) with 2 core(s)
19/06/27 15:59:08 INFO BlockManager: Using
org.apache.spark.storage.RandomBlockReplicationPolicy for block replication
policy
19/06/27 15:59:08 INFO StandaloneSchedulerBackend: Granted executor ID
app-20190627155908-0005/4 on hostPort 192.168.3.8:8885 with 2 core(s), 1024.0
MB RAM
19/06/27 15:59:08 INFO StandaloneAppClient$ClientEndpoint: Executor updated:
app-20190627155908-0005/0 is now RUNNING
19/06/27 15:59:08 INFO StandaloneAppClient$ClientEndpoint: Executor updated:
app-20190627155908-0005/3 is now RUNNING
19/06/27 15:59:08 INFO StandaloneAppClient$ClientEndpoint: Executor updated:
app-20190627155908-0005/4 is now RUNNING
19/06/27 15:59:08 INFO StandaloneAppClient$ClientEndpoint: Executor updated:
app-20190627155908-0005/1 is now RUNNING
19/06/27 15:59:08 INFO StandaloneAppClient$ClientEndpoint: Executor updated:
app-20190627155908-0005/2 is now RUNNING
19/06/27 15:59:08 INFO BlockManagerMaster: Registering BlockManager
BlockManagerId(driver, master, 39189, None)
19/06/27 15:59:08 DEBUG DefaultTopologyMapper: Got a request for master
19/06/27 15:59:08 INFO BlockManagerMasterEndpoint: Registering block manager
master:39189 with 366.3 MB RAM, BlockManagerId(driver, master, 39189, None)
19/06/27 15:59:08 INFO BlockManagerMaster: Registered BlockManager
BlockManagerId(driver, master, 39189, None)
19/06/27 15:59:08 INFO BlockManager: Initialized BlockManager:
BlockManagerId(driver, master, 39189, None)
19/06/27 15:59:09 INFO StandaloneSchedulerBackend: SchedulerBackend is ready
for scheduling beginning after reached minRegisteredResourcesRatio: 0.0
19/06/27 15:59:09 DEBUG SparkContext: Adding shutdown hook
19/06/27 15:59:09 DEBUG BlockReaderLocal:
dfs.client.use.legacy.blockreader.local = false
19/06/27 15:59:09 DEBUG BlockReaderLocal: dfs.client.read.shortcircuit = false
19/06/27 15:59:09 DEBUG BlockReaderLocal: dfs.client.domain.socket.data.traffic
= false
19/06/27 15:59:09 DEBUG BlockReaderLocal: dfs.domain.socket.path =
19/06/27 15:59:09 DEBUG RetryUtils: multipleLinearRandomRetry = null
19/06/27 15:59:09 DEBUG Server: rpcKind=RPC_PROTOCOL_BUFFER,
rpcRequestWrapperClass=class
org.apache.hadoop.ipc.ProtobufRpcEngine$RpcRequestWrapper,
rpcInvoker=org.apache.hadoop.ipc.ProtobufRpcEngine$Server$ProtoBufRpcInvoker@23f3dbf0
19/06/27 15:59:09 DEBUG Client: getting client out of cache:
org.apache.hadoop.ipc.Client@3ed03652
19/06/27 15:59:09 DEBUG PerformanceAdvisory: Both short-circuit local reads and
UNIX domain socket are disabled.
19/06/27 15:59:09 DEBUG DataTransferSaslUtil: DataTransferProtocol not using
SaslPropertiesResolver, no QOP found in configuration for
dfs.data.transfer.protection
19/06/27 15:59:10 INFO MemoryStore: Block broadcast_0 stored as values in
memory (estimated size 288.9 KB, free 366.0 MB)
19/06/27 15:59:10 DEBUG BlockManager: Put block broadcast_0 locally took 115 ms
19/06/27 15:59:10 DEBUG BlockManager: Putting block broadcast_0 without
replication took 117 ms
19/06/27 15:59:10 INFO MemoryStore: Block broadcast_0_piece0 stored as bytes in
memory (estimated size 23.8 KB, free 366.0 MB)
19/06/27 15:59:10 INFO BlockManagerInfo: Added broadcast_0_piece0 in memory on
master:39189 (size: 23.8 KB, free: 366.3 MB)
19/06/27 15:59:10 DEBUG BlockManagerMaster: Updated info of block
broadcast_0_piece0
19/06/27 15:59:10 DEBUG BlockManager: Told master about block broadcast_0_piece0
19/06/27 15:59:10 DEBUG BlockManager: Put block broadcast_0_piece0 locally took
6 ms
19/06/27 15:59:10 DEBUG BlockManager: Putting block broadcast_0_piece0 without
replication took 6 ms
19/06/27 15:59:10 INFO SparkContext: Created broadcast 0 from newAPIHadoopFile
at TeraSort.scala:60
19/06/27 15:59:10 DEBUG Client: The ping interval is 60000 ms.
19/06/27 15:59:10 DEBUG Client: Connecting to NameNode-1/192.168.3.7:54310
19/06/27 15:59:10 DEBUG Client: IPC Client (1998371610) connection to
NameNode-1/192.168.3.7:54310 from hduser: starting, having connections 1
19/06/27 15:59:10 DEBUG Client: IPC Client (1998371610) connection to
NameNode-1/192.168.3.7:54310 from hduser sending #0
19/06/27 15:59:10 DEBUG Client: IPC Client (1998371610) connection to
NameNode-1/192.168.3.7:54310 from hduser got value #0
19/06/27 15:59:10 DEBUG ProtobufRpcEngine: Call: getFileInfo took 31ms
19/06/27 15:59:10 DEBUG Client: IPC Client (1998371610) connection to
NameNode-1/192.168.3.7:54310 from hduser sending #1
19/06/27 15:59:10 DEBUG Client: IPC Client (1998371610) connection to
NameNode-1/192.168.3.7:54310 from hduser got value #1
19/06/27 15:59:10 DEBUG ProtobufRpcEngine: Call: getListing took 5ms
19/06/27 15:59:10 DEBUG FileInputFormat: Time taken to get FileStatuses: 134
19/06/27 15:59:10 INFO FileInputFormat: Total input paths to process : 2
19/06/27 15:59:10 DEBUG FileInputFormat: Total # of splits generated by
getSplits: 2, TimeTaken: 139
19/06/27 15:59:10 DEBUG FileCommitProtocol: Creating committer
org.apache.spark.internal.io.HadoopMapReduceCommitProtocol; job 1;
output=hdfs://NameNode-1:54310/tmp/data_sort; dynamic=false
19/06/27 15:59:10 DEBUG FileCommitProtocol: Using (String, String, Boolean)
constructor
19/06/27 15:59:10 INFO FileOutputCommitter: File Output Committer Algorithm
version is 1
19/06/27 15:59:10 DEBUG DFSClient: /tmp/data_sort/_temporary/0: masked=rwxr-xr-x
19/06/27 15:59:10 DEBUG Client: IPC Client (1998371610) connection to
NameNode-1/192.168.3.7:54310 from hduser sending #2
19/06/27 15:59:10 DEBUG Client: IPC Client (1998371610) connection to
NameNode-1/192.168.3.7:54310 from hduser got value #2
19/06/27 15:59:10 DEBUG ProtobufRpcEngine: Call: mkdirs took 3ms
19/06/27 15:59:10 DEBUG ClosureCleaner: Cleaning lambda: $anonfun$write$1
19/06/27 15:59:10 DEBUG ClosureCleaner: +++ Lambda closure ($anonfun$write$1)
is now cleaned +++
19/06/27 15:59:10 INFO SparkContext: Starting job: runJob at
SparkHadoopWriter.scala:78
19/06/27 15:59:10 INFO CrailDispatcher: CrailStore starting version 400
19/06/27 15:59:10 INFO CrailDispatcher: spark.crail.deleteonclose false
19/06/27 15:59:10 INFO CrailDispatcher: spark.crail.deleteOnStart true
19/06/27 15:59:10 INFO CrailDispatcher: spark.crail.preallocate 0
19/06/27 15:59:10 INFO CrailDispatcher: spark.crail.writeAhead 0
19/06/27 15:59:10 INFO CrailDispatcher: spark.crail.debug false
19/06/27 15:59:10 INFO CrailDispatcher: spark.crail.serializer
org.apache.spark.serializer.CrailSparkSerializer
19/06/27 15:59:10 INFO CrailDispatcher: spark.crail.shuffle.affinity true
19/06/27 15:59:10 INFO CrailDispatcher: spark.crail.shuffle.outstanding 1
19/06/27 15:59:10 INFO CrailDispatcher: spark.crail.shuffle.storageclass 0
19/06/27 15:59:10 INFO CrailDispatcher: spark.crail.broadcast.storageclass 0
19/06/27 15:59:10 INFO crail: creating singleton crail file system
19/06/27 15:59:10 INFO crail: crail.version 3101
19/06/27 15:59:10 INFO crail: crail.directorydepth 16
19/06/27 15:59:10 INFO crail: crail.tokenexpiration 10
19/06/27 15:59:10 INFO crail: crail.blocksize 1048576
19/06/27 15:59:10 INFO crail: crail.cachelimit 0
19/06/27 15:59:10 INFO crail: crail.cachepath /dev/hugepages/cache
19/06/27 15:59:10 INFO crail: crail.user crail
19/06/27 15:59:10 INFO crail: crail.shadowreplication 1
19/06/27 15:59:10 INFO crail: crail.debug true
19/06/27 15:59:10 INFO crail: crail.statistics true
19/06/27 15:59:10 INFO crail: crail.rpctimeout 1000
19/06/27 15:59:10 INFO crail: crail.datatimeout 1000
19/06/27 15:59:10 INFO crail: crail.buffersize 1048576
19/06/27 15:59:10 INFO crail: crail.slicesize 65536
19/06/27 15:59:10 INFO crail: crail.singleton true
19/06/27 15:59:10 INFO crail: crail.regionsize 1073741824
19/06/27 15:59:10 INFO crail: crail.directoryrecord 512
19/06/27 15:59:10 INFO crail: crail.directoryrandomize true
19/06/27 15:59:10 INFO crail: crail.cacheimpl
org.apache.crail.memory.MappedBufferCache
19/06/27 15:59:10 INFO crail: crail.locationmap
19/06/27 15:59:10 INFO crail: crail.namenode.address crail://192.168.1.164:9060
19/06/27 15:59:10 INFO crail: crail.namenode.blockselection roundrobin
19/06/27 15:59:10 INFO crail: crail.namenode.fileblocks 16
19/06/27 15:59:10 INFO crail: crail.namenode.rpctype
org.apache.crail.namenode.rpc.tcp.TcpNameNode
19/06/27 15:59:10 INFO crail: crail.namenode.log
19/06/27 15:59:10 INFO crail: crail.storage.types
org.apache.crail.storage.rdma.RdmaStorageTier
19/06/27 15:59:10 INFO crail: crail.storage.classes 1
19/06/27 15:59:10 INFO crail: crail.storage.rootclass 0
19/06/27 15:59:10 INFO crail: crail.storage.keepalive 2
19/06/27 15:59:10 INFO crail: buffer cache, allocationCount 0, bufferCount 1024
19/06/27 15:59:10 INFO crail: crail.storage.rdma.interface eth0
19/06/27 15:59:10 INFO crail: crail.storage.rdma.port 50020
19/06/27 15:59:10 INFO crail: crail.storage.rdma.storagelimit 4294967296
19/06/27 15:59:10 INFO crail: crail.storage.rdma.allocationsize 1073741824
19/06/27 15:59:10 INFO crail: crail.storage.rdma.datapath /dev/hugepages/rdma
19/06/27 15:59:10 INFO crail: crail.storage.rdma.localmap true
19/06/27 15:59:10 INFO crail: crail.storage.rdma.queuesize 32
19/06/27 15:59:10 INFO crail: crail.storage.rdma.type passive
19/06/27 15:59:10 INFO crail: crail.storage.rdma.backlog 100
19/06/27 15:59:10 INFO crail: crail.storage.rdma.connecttimeout 1000
19/06/27 15:59:10 INFO narpc: new NaRPC server group v1.0, queueDepth 32,
messageSize 512, nodealy true
19/06/27 15:59:10 INFO crail: crail.namenode.tcp.queueDepth 32
19/06/27 15:59:10 INFO crail: crail.namenode.tcp.messageSize 512
19/06/27 15:59:10 INFO crail: crail.namenode.tcp.cores 1
19/06/27 15:59:10 INFO crail: connected to namenode(s) /192.168.1.164:9060
19/06/27 15:59:10 INFO CrailDispatcher: creating main dir /spark
19/06/27 15:59:10 INFO crail: lookupDirectory: path /spark
19/06/27 15:59:10 INFO CrailDispatcher: creating main dir /spark
19/06/27 15:59:10 INFO crail: createNode: name /spark, type DIRECTORY,
storageAffinity 0, locationAffinity 0
19/06/27 15:59:10 INFO crail: CoreOutputStream, open, path /, fd 0, streamId 1,
isDir true, writeHint 0
19/06/27 15:59:10 INFO crail: passive data client
19/06/27 15:59:10 INFO disni: creating RdmaProvider of type 'nat'
19/06/27 15:59:10 INFO disni: jverbs jni version 32
19/06/27 15:59:10 INFO disni: sock_addr_in size mismatch, jverbs size 28,
native size 16
19/06/27 15:59:10 INFO disni: IbvRecvWR size match, jverbs size 32, native size
32
19/06/27 15:59:10 INFO disni: IbvSendWR size mismatch, jverbs size 72, native
size 128
19/06/27 15:59:10 INFO disni: IbvWC size match, jverbs size 48, native size 48
19/06/27 15:59:10 INFO disni: IbvSge size match, jverbs size 16, native size 16
19/06/27 15:59:10 INFO disni: Remote addr offset match, jverbs size 40, native
size 40
19/06/27 15:59:10 INFO disni: Rkey offset match, jverbs size 48, native size 48
19/06/27 15:59:10 INFO disni: createEventChannel, objId 139811924587312
19/06/27 15:59:10 INFO disni: passive endpoint group, maxWR 32, maxSge 4,
cqSize 64
19/06/27 15:59:10 INFO disni: launching cm processor, cmChannel 0
19/06/27 15:59:10 INFO disni: createId, id 139811924676432
19/06/27 15:59:10 INFO disni: new client endpoint, id 0, idPriv 0
19/06/27 15:59:10 INFO disni: resolveAddr, addres /192.168.3.100:4420
19/06/27 15:59:10 INFO disni: resolveRoute, id 0
19/06/27 15:59:10 INFO disni: allocPd, objId 139811924679808
19/06/27 15:59:10 INFO disni: setting up protection domain, context 467, pd 1
19/06/27 15:59:10 INFO disni: setting up cq processor
19/06/27 15:59:10 INFO disni: new endpoint CQ processor
19/06/27 15:59:10 INFO disni: createCompChannel, context 139810647883744
19/06/27 15:59:10 INFO disni: createCQ, objId 139811924680688, ncqe 64
19/06/27 15:59:10 INFO disni: createQP, objId 139811924691192, send_wr size 32,
recv_wr_size 32
19/06/27 15:59:10 INFO disni: connect, id 0
19/06/27 15:59:10 INFO disni: got event type + UNKNOWN, srcAddress
/192.168.3.13:43273, dstAddress /192.168.3.100:4420
19/06/27 15:59:11 INFO CoarseGrainedSchedulerBackend$DriverEndpoint: Registered
executor NettyRpcEndpointRef(spark-client://Executor) (192.168.3.11:35854) with
ID 0
19/06/27 15:59:11 INFO CoarseGrainedSchedulerBackend$DriverEndpoint: Registered
executor NettyRpcEndpointRef(spark-client://Executor) (192.168.3.12:44312) with
ID 1
19/06/27 15:59:11 INFO CoarseGrainedSchedulerBackend$DriverEndpoint: Registered
executor NettyRpcEndpointRef(spark-client://Executor) (192.168.3.8:34774) with
ID 4
19/06/27 15:59:11 INFO CoarseGrainedSchedulerBackend$DriverEndpoint: Registered
executor NettyRpcEndpointRef(spark-client://Executor) (192.168.3.9:58808) with
ID 2
19/06/27 15:59:11 DEBUG DefaultTopologyMapper: Got a request for 192.168.3.11
19/06/27 15:59:11 INFO BlockManagerMasterEndpoint: Registering block manager
192.168.3.11:41919 with 366.3 MB RAM, BlockManagerId(0, 192.168.3.11, 41919,
None)
19/06/27 15:59:11 DEBUG DefaultTopologyMapper: Got a request for 192.168.3.12
19/06/27 15:59:11 INFO BlockManagerMasterEndpoint: Registering block manager
192.168.3.12:46697 with 366.3 MB RAM, BlockManagerId(1, 192.168.3.12, 46697,
None)
19/06/27 15:59:11 DEBUG DefaultTopologyMapper: Got a request for 192.168.3.8
19/06/27 15:59:11 INFO BlockManagerMasterEndpoint: Registering block manager
192.168.3.8:37281 with 366.3 MB RAM, BlockManagerId(4, 192.168.3.8, 37281, None)
19/06/27 15:59:11 DEBUG DefaultTopologyMapper: Got a request for 192.168.3.9
19/06/27 15:59:11 INFO BlockManagerMasterEndpoint: Registering block manager
192.168.3.9:43857 with 366.3 MB RAM, BlockManagerId(2, 192.168.3.9, 43857, None)
19/06/27 15:59:11 INFO CoarseGrainedSchedulerBackend$DriverEndpoint: Registered
executor NettyRpcEndpointRef(spark-client://Executor) (192.168.3.10:40100) with
ID 3
19/06/27 15:59:11 DEBUG DefaultTopologyMapper: Got a request for 192.168.3.10
19/06/27 15:59:11 INFO BlockManagerMasterEndpoint: Registering block manager
192.168.3.10:38527 with 366.3 MB RAM, BlockManagerId(3, 192.168.3.10, 38527,
None)
19/06/27 15:59:20 DEBUG Client: IPC Client (1998371610) connection to
NameNode-1/192.168.3.7:54310 from hduser: closed
19/06/27 15:59:20 DEBUG Client: IPC Client (1998371610) connection to
NameNode-1/192.168.3.7:54310 from hduser: stopped, remaining connections 0
Regards,
David
