2017-07-27 11:04:23.478326415 -0700 PDT [INFO] No config file found. Using defaults.
2017-07-27 11:04:23.478440697 -0700 PDT [INFO] Starting plugin log_level=info config="/etc/docker-volume-vsphere.conf" driver=vsphere 
2017-07-27 11:04:23.478597472 -0700 PDT [INFO] Getting volume data from unix:///var/run/docker.sock
2017-07-27 11:04:23.498873246 -0700 PDT [INFO] Found 0 running or paused containers
2017-07-27 11:04:23.499002508 -0700 PDT [INFO] Mounts read successfullydata="/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e / ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\n/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e /mnt/vmdk ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\nproc /proc proc rw,nosuid,nodev,noexec,relatime 0 0\ntmpfs /dev tmpfs rw,nosuid,mode=755 0 0\ndevpts /dev/pts devpts rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=666 0 0\nsysfs /sys sysfs ro,nosuid,nodev,noexec,relatime 0 0\ntmpfs /sys/fs/cgroup tmpfs ro,nosuid,nodev,noexec,relatime,mode=755 0 0\ncgroup /sys/fs/cgroup/cpuset cgroup ro,nosuid,nodev,noexec,relatime,cpuset 0 0\ncgroup /sys/fs/cgroup/cpu cgroup ro,nosuid,nodev,noexec,relatime,cpu 0 0\ncgroup /sys/fs/cgroup/cpuacct cgroup ro,nosuid,nodev,noexec,relatime,cpuacct 0 0\ncgroup /sys/fs/cgroup/blkio cgroup ro,nosuid,nodev,noexec,relatime,blkio 0 0\ncgroup /sys/fs/cgroup/memory cgroup ro,nosuid,nodev,noexec,relatime,memory 0 0\ncgroup /sys/fs/cgroup/devices cgroup ro,nosuid,nodev,noexec,relatime,devices 0 0\ncgroup /sys/fs/cgroup/freezer cgroup ro,nosuid,nodev,noexec,relatime,freezer 0 0\ncgroup /sys/fs/cgroup/net_cls cgroup ro,nosuid,nodev,noexec,relatime,net_cls 0 0\ncgroup /sys/fs/cgroup/perf_event cgroup ro,nosuid,nodev,noexec,relatime,perf_event 0 0\ncgroup /sys/fs/cgroup/net_prio cgroup ro,nosuid,nodev,noexec,relatime,net_prio 0 0\ncgroup /sys/fs/cgroup/hugetlb cgroup ro,nosuid,nodev,noexec,relatime,hugetlb 0 0\nsystemd /sys/fs/cgroup/systemd cgroup ro,nosuid,nodev,noexec,relatime,name=systemd 0 0\nmqueue /dev/mqueue mqueue rw,nosuid,nodev,noexec,relatime 0 0\nudev /dev devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\ndevpts /dev/pts devpts rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000 0 0\ntmpfs /var/run tmpfs rw,nosuid,noexec,relatime,size=404732k,mode=755 0 0\nnone /var/run/lock tmpfs rw,nosuid,nodev,noexec,relatime,size=5120k 0 0\nnone /var/run/shm tmpfs rw,nosuid,nodev,relatime 0 0\nnone /var/run/user tmpfs rw,nosuid,nodev,noexec,relatime,size=102400k,mode=755 0 0\n/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e /etc ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\n/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e /var/log ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\ntmpfs /run/docker/plugins tmpfs rw,nosuid,noexec,relatime,size=404732k,mode=755 0 0\nproc /proc/bus proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/fs proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/irq proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/sys proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/sysrq-trigger proc ro,nosuid,nodev,noexec,relatime 0 0\nudev /proc/kcore devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\nudev /proc/timer_list devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\nudev /proc/timer_stats devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\nudev /proc/sched_debug devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\ntmpfs /sys/firmware tmpfs ro,relatime 0 0\n" 
2017-07-27 11:04:23.499182554 -0700 PDT [INFO] Successfully retrieved mountsmap=map[] 
2017-07-27 11:04:23.499198851 -0700 PDT [INFO] Discovered 0 volumes in use.
2017-07-27 11:04:23.499203929 -0700 PDT [INFO] Refcounting successfully completed
2017-07-27 11:04:23.499211294 -0700 PDT [INFO] Docker VMDK plugin started version="vSphere Volume Driver v0.5" port=1019 mock_esx=false 
2017-07-27 11:04:23.499623755 -0700 PDT [INFO] Going into ServeUnix - Listening on Unix socket address="/run/docker/plugins/vsphere.sock" 
2017-07-27 11:07:03.316992058 -0700 PDT [INFO] Attaching volume and creating filesystem name=TestVolSS fstype=ext4 
2017-07-27 11:07:05.147061812 -0700 PDT [INFO] Scan complete device="/dev/disk/by-path/pci-0000:03:00.0-scsi-0:0:0:0" event="/dev/disk/by-path/pci-0000:03:00.0-scsi-0:0:0:0": 0x100 == IN_CREATE 
2017-07-27 11:07:06.080991833 -0700 PDT [INFO] Volume and filesystem created name=TestVolSS fstype=ext4 
2017-07-27 11:07:28.654767888 -0700 PDT [INFO] Mounting volume name="TestVolSS@sharedVmfs-0" 
2017-07-27 11:07:28.655073127 -0700 PDT [INFO] Mounts read successfullydata="/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e / ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\n/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e /mnt/vmdk ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\nproc /proc proc rw,nosuid,nodev,noexec,relatime 0 0\ntmpfs /dev tmpfs rw,nosuid,mode=755 0 0\ndevpts /dev/pts devpts rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=666 0 0\nsysfs /sys sysfs ro,nosuid,nodev,noexec,relatime 0 0\ntmpfs /sys/fs/cgroup tmpfs ro,nosuid,nodev,noexec,relatime,mode=755 0 0\ncgroup /sys/fs/cgroup/cpuset cgroup ro,nosuid,nodev,noexec,relatime,cpuset 0 0\ncgroup /sys/fs/cgroup/cpu cgroup ro,nosuid,nodev,noexec,relatime,cpu 0 0\ncgroup /sys/fs/cgroup/cpuacct cgroup ro,nosuid,nodev,noexec,relatime,cpuacct 0 0\ncgroup /sys/fs/cgroup/blkio cgroup ro,nosuid,nodev,noexec,relatime,blkio 0 0\ncgroup /sys/fs/cgroup/memory cgroup ro,nosuid,nodev,noexec,relatime,memory 0 0\ncgroup /sys/fs/cgroup/devices cgroup ro,nosuid,nodev,noexec,relatime,devices 0 0\ncgroup /sys/fs/cgroup/freezer cgroup ro,nosuid,nodev,noexec,relatime,freezer 0 0\ncgroup /sys/fs/cgroup/net_cls cgroup ro,nosuid,nodev,noexec,relatime,net_cls 0 0\ncgroup /sys/fs/cgroup/perf_event cgroup ro,nosuid,nodev,noexec,relatime,perf_event 0 0\ncgroup /sys/fs/cgroup/net_prio cgroup ro,nosuid,nodev,noexec,relatime,net_prio 0 0\ncgroup /sys/fs/cgroup/hugetlb cgroup ro,nosuid,nodev,noexec,relatime,hugetlb 0 0\nsystemd /sys/fs/cgroup/systemd cgroup ro,nosuid,nodev,noexec,relatime,name=systemd 0 0\nmqueue /dev/mqueue mqueue rw,nosuid,nodev,noexec,relatime 0 0\nudev /dev devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\ndevpts /dev/pts devpts rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000 0 0\ntmpfs /var/run tmpfs rw,nosuid,noexec,relatime,size=404732k,mode=755 0 0\nnone /var/run/lock tmpfs rw,nosuid,nodev,noexec,relatime,size=5120k 0 0\nnone /var/run/shm tmpfs rw,nosuid,nodev,relatime 0 0\nnone /var/run/user tmpfs rw,nosuid,nodev,noexec,relatime,size=102400k,mode=755 0 0\n/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e /etc ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\n/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e /var/log ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\ntmpfs /run/docker/plugins tmpfs rw,nosuid,noexec,relatime,size=404732k,mode=755 0 0\nproc /proc/bus proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/fs proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/irq proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/sys proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/sysrq-trigger proc ro,nosuid,nodev,noexec,relatime 0 0\nudev /proc/kcore devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\nudev /proc/timer_list devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\nudev /proc/timer_stats devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\nudev /proc/sched_debug devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\ntmpfs /sys/firmware tmpfs ro,relatime 0 0\n" 
2017-07-27 11:07:28.655281897 -0700 PDT [INFO] Successfully retrieved mountsmap=map[] 
2017-07-27 11:07:28.773219787 -0700 PDT [INFO] Directory doesn't exist, creating it path="/mnt/vmdk/TestVolSS@sharedVmfs-0" 
2017-07-27 11:07:29.277097618 -0700 PDT [INFO] Scan complete device="/dev/disk/by-path/pci-0000:03:00.0-scsi-0:0:0:0" event="/dev/disk/by-path/pci-0000:03:00.0-scsi-0:0:0:0": 0x100 == IN_CREATE 
2017-07-27 11:07:55.576110108 -0700 PDT [INFO] Unmounting Volume name="TestVolSS@sharedVmfs-0" 
2017-07-27 11:12:13.57803635 -0700 PDT [INFO] Mounting volume name="TestVolSS@sharedVmfs-0" 
2017-07-27 11:12:13.578459549 -0700 PDT [INFO] Mounts read successfullydata="/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e / ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\n/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e /mnt/vmdk ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\nproc /proc proc rw,nosuid,nodev,noexec,relatime 0 0\ntmpfs /dev tmpfs rw,nosuid,mode=755 0 0\ndevpts /dev/pts devpts rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=666 0 0\nsysfs /sys sysfs ro,nosuid,nodev,noexec,relatime 0 0\ntmpfs /sys/fs/cgroup tmpfs ro,nosuid,nodev,noexec,relatime,mode=755 0 0\ncgroup /sys/fs/cgroup/cpuset cgroup ro,nosuid,nodev,noexec,relatime,cpuset 0 0\ncgroup /sys/fs/cgroup/cpu cgroup ro,nosuid,nodev,noexec,relatime,cpu 0 0\ncgroup /sys/fs/cgroup/cpuacct cgroup ro,nosuid,nodev,noexec,relatime,cpuacct 0 0\ncgroup /sys/fs/cgroup/blkio cgroup ro,nosuid,nodev,noexec,relatime,blkio 0 0\ncgroup /sys/fs/cgroup/memory cgroup ro,nosuid,nodev,noexec,relatime,memory 0 0\ncgroup /sys/fs/cgroup/devices cgroup ro,nosuid,nodev,noexec,relatime,devices 0 0\ncgroup /sys/fs/cgroup/freezer cgroup ro,nosuid,nodev,noexec,relatime,freezer 0 0\ncgroup /sys/fs/cgroup/net_cls cgroup ro,nosuid,nodev,noexec,relatime,net_cls 0 0\ncgroup /sys/fs/cgroup/perf_event cgroup ro,nosuid,nodev,noexec,relatime,perf_event 0 0\ncgroup /sys/fs/cgroup/net_prio cgroup ro,nosuid,nodev,noexec,relatime,net_prio 0 0\ncgroup /sys/fs/cgroup/hugetlb cgroup ro,nosuid,nodev,noexec,relatime,hugetlb 0 0\nsystemd /sys/fs/cgroup/systemd cgroup ro,nosuid,nodev,noexec,relatime,name=systemd 0 0\nmqueue /dev/mqueue mqueue rw,nosuid,nodev,noexec,relatime 0 0\nudev /dev devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\ndevpts /dev/pts devpts rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000 0 0\ntmpfs /var/run tmpfs rw,nosuid,noexec,relatime,size=404732k,mode=755 0 0\nnone /var/run/lock tmpfs rw,nosuid,nodev,noexec,relatime,size=5120k 0 0\nnone /var/run/shm tmpfs rw,nosuid,nodev,relatime 0 0\nnone /var/run/user tmpfs rw,nosuid,nodev,noexec,relatime,size=102400k,mode=755 0 0\n/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e /etc ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\n/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e /var/log ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\ntmpfs /run/docker/plugins tmpfs rw,nosuid,noexec,relatime,size=404732k,mode=755 0 0\nproc /proc/bus proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/fs proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/irq proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/sys proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/sysrq-trigger proc ro,nosuid,nodev,noexec,relatime 0 0\nudev /proc/kcore devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\nudev /proc/timer_list devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\nudev /proc/timer_stats devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\nudev /proc/sched_debug devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\ntmpfs /sys/firmware tmpfs ro,relatime 0 0\n" 
2017-07-27 11:12:13.57861545 -0700 PDT [INFO] Successfully retrieved mountsmap=map[] 
2017-07-27 11:12:14.196837817 -0700 PDT [INFO] Scan complete event="/dev/disk/by-path/pci-0000:03:00.0-scsi-0:0:0:0": 0x100 == IN_CREATE device="/dev/disk/by-path/pci-0000:03:00.0-scsi-0:0:0:0" 
2017-07-27 11:12:36.128593022 -0700 PDT [INFO] Unmounting Volume name="TestVolSS@sharedVmfs-0" 
2017-07-27 11:21:53.835705874 -0700 PDT [INFO] Removing volume name="TestVolSS@sharedVmfs-0" 
2017-07-27 11:21:53.957894045 -0700 PDT [ERROR] Failed to remove volume name="TestVolSS@sharedVmfs-0" error="Failed to remove volume TestVolSS, in use by VM = ubuntu-VM0.1." 
2017-07-27 11:22:46.228211752 -0700 PDT [INFO] Removing volume name="TestVolSS@sharedVmfs-0" 
2017-07-27 11:22:46.330343137 -0700 PDT [ERROR] Failed to remove volume name="TestVolSS@sharedVmfs-0" error="Failed to remove volume TestVolSS, in use by VM = ubuntu-VM0.1." 
2017-07-27 11:23:14.822431621 -0700 PDT [WARNING] Received signal signal=terminated 
2017-07-27 11:23:40.331306051 -0700 PDT [INFO] No config file found. Using defaults.
2017-07-27 11:23:40.33248957 -0700 PDT [INFO] Starting plugin log_level=info config="/etc/docker-volume-vsphere.conf" driver=vsphere 
2017-07-27 11:23:40.332528008 -0700 PDT [INFO] Getting volume data from unix:///var/run/docker.sock
2017-07-27 11:23:42.332820388 -0700 PDT [INFO] Can't connect to unix:///var/run/docker.sock due to (An error occurred trying to connect: context deadline exceeded), skipping discovery
2017-07-27 11:23:42.332869315 -0700 PDT [INFO] Refcounting failed: (An error occurred trying to connect: context deadline exceeded).
2017-07-27 11:23:42.332898822 -0700 PDT [INFO] Docker VMDK plugin started mock_esx=false version="vSphere Volume Driver v0.5" port=1019 
2017-07-27 11:23:42.33499921 -0700 PDT [INFO] Going into ServeUnix - Listening on Unix socket address="/run/docker/plugins/vsphere.sock" 
2017-07-27 11:23:42.33510747 -0700 PDT [INFO] Scheduling again after 2 seconds
2017-07-27 11:23:44.335447809 -0700 PDT [INFO] Getting volume data from unix:///var/run/docker.sock
2017-07-27 11:23:44.374339256 -0700 PDT [INFO] Found 0 running or paused containers
2017-07-27 11:23:44.374503993 -0700 PDT [INFO] Mounts read successfullydata="/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e / ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\n/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e /mnt/vmdk ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\nproc /proc proc rw,nosuid,nodev,noexec,relatime 0 0\ntmpfs /dev tmpfs rw,nosuid,mode=755 0 0\ndevpts /dev/pts devpts rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=666 0 0\nsysfs /sys sysfs ro,nosuid,nodev,noexec,relatime 0 0\ntmpfs /sys/fs/cgroup tmpfs ro,nosuid,nodev,noexec,relatime,mode=755 0 0\ncgroup /sys/fs/cgroup/cpuset cgroup ro,nosuid,nodev,noexec,relatime,cpuset 0 0\ncgroup /sys/fs/cgroup/cpu cgroup ro,nosuid,nodev,noexec,relatime,cpu 0 0\ncgroup /sys/fs/cgroup/cpuacct cgroup ro,nosuid,nodev,noexec,relatime,cpuacct 0 0\ncgroup /sys/fs/cgroup/blkio cgroup ro,nosuid,nodev,noexec,relatime,blkio 0 0\ncgroup /sys/fs/cgroup/memory cgroup ro,nosuid,nodev,noexec,relatime,memory 0 0\ncgroup /sys/fs/cgroup/devices cgroup ro,nosuid,nodev,noexec,relatime,devices 0 0\ncgroup /sys/fs/cgroup/freezer cgroup ro,nosuid,nodev,noexec,relatime,freezer 0 0\ncgroup /sys/fs/cgroup/net_cls cgroup ro,nosuid,nodev,noexec,relatime,net_cls 0 0\ncgroup /sys/fs/cgroup/perf_event cgroup ro,nosuid,nodev,noexec,relatime,perf_event 0 0\ncgroup /sys/fs/cgroup/net_prio cgroup ro,nosuid,nodev,noexec,relatime,net_prio 0 0\ncgroup /sys/fs/cgroup/hugetlb cgroup ro,nosuid,nodev,noexec,relatime,hugetlb 0 0\nsystemd /sys/fs/cgroup/systemd cgroup ro,nosuid,nodev,noexec,relatime,name=systemd 0 0\nmqueue /dev/mqueue mqueue rw,nosuid,nodev,noexec,relatime 0 0\nudev /dev devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\ndevpts /dev/pts devpts rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000 0 0\ntmpfs /var/run tmpfs rw,nosuid,noexec,relatime,size=404732k,mode=755 0 0\nnone /var/run/lock tmpfs rw,nosuid,nodev,noexec,relatime,size=5120k 0 0\nnone /var/run/shm tmpfs rw,nosuid,nodev,relatime 0 0\nnone /var/run/user tmpfs rw,nosuid,nodev,noexec,relatime,size=102400k,mode=755 0 0\n/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e /etc ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\n/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e /var/log ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\ntmpfs /run/docker/plugins tmpfs rw,nosuid,noexec,relatime,size=404732k,mode=755 0 0\nproc /proc/bus proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/fs proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/irq proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/sys proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/sysrq-trigger proc ro,nosuid,nodev,noexec,relatime 0 0\nudev /proc/kcore devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\nudev /proc/timer_list devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\nudev /proc/timer_stats devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\nudev /proc/sched_debug devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\ntmpfs /sys/firmware tmpfs ro,relatime 0 0\n" 
2017-07-27 11:23:44.374695491 -0700 PDT [INFO] Successfully retrieved mountsmap=map[] 
2017-07-27 11:23:44.37470779 -0700 PDT [INFO] Discovered 0 volumes in use.
2017-07-27 11:23:44.374713211 -0700 PDT [INFO] Refcounting successfully completed
2017-07-27 11:26:41.686126239 -0700 PDT [INFO] Attaching volume and creating filesystem name=VolSS1 fstype=ext4 
2017-07-27 11:26:41.922074801 -0700 PDT [ERROR] RawAttach failed name=VolSS1 opts=map[] error="Another task is already in progress." 
2017-07-27 11:26:41.922185742 -0700 PDT [ERROR] Attach volume failed, removing the volume name=VolSS1 error="Another task is already in progress." 
2017-07-27 11:27:38.410024539 -0700 PDT [INFO] Attaching volume and creating filesystem name=VolSS1 fstype=ext4 
2017-07-27 11:27:38.886256639 -0700 PDT [INFO] Scan complete device="/dev/disk/by-path/pci-0000:03:00.0-scsi-0:0:0:0" event="/dev/disk/by-path/pci-0000:03:00.0-scsi-0:0:0:0": 0x100 == IN_CREATE 
2017-07-27 11:27:39.554063026 -0700 PDT [INFO] Volume and filesystem created name=VolSS1 fstype=ext4 
2017-07-27 11:28:39.264514093 -0700 PDT [INFO] Mounting volume name="VolSS1@sharedVmfs-0" 
2017-07-27 11:28:39.2647459 -0700 PDT [INFO] Mounts read successfullydata="/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e / ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\n/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e /mnt/vmdk ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\nproc /proc proc rw,nosuid,nodev,noexec,relatime 0 0\ntmpfs /dev tmpfs rw,nosuid,mode=755 0 0\ndevpts /dev/pts devpts rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=666 0 0\nsysfs /sys sysfs ro,nosuid,nodev,noexec,relatime 0 0\ntmpfs /sys/fs/cgroup tmpfs ro,nosuid,nodev,noexec,relatime,mode=755 0 0\ncgroup /sys/fs/cgroup/cpuset cgroup ro,nosuid,nodev,noexec,relatime,cpuset 0 0\ncgroup /sys/fs/cgroup/cpu cgroup ro,nosuid,nodev,noexec,relatime,cpu 0 0\ncgroup /sys/fs/cgroup/cpuacct cgroup ro,nosuid,nodev,noexec,relatime,cpuacct 0 0\ncgroup /sys/fs/cgroup/blkio cgroup ro,nosuid,nodev,noexec,relatime,blkio 0 0\ncgroup /sys/fs/cgroup/memory cgroup ro,nosuid,nodev,noexec,relatime,memory 0 0\ncgroup /sys/fs/cgroup/devices cgroup ro,nosuid,nodev,noexec,relatime,devices 0 0\ncgroup /sys/fs/cgroup/freezer cgroup ro,nosuid,nodev,noexec,relatime,freezer 0 0\ncgroup /sys/fs/cgroup/net_cls cgroup ro,nosuid,nodev,noexec,relatime,net_cls 0 0\ncgroup /sys/fs/cgroup/perf_event cgroup ro,nosuid,nodev,noexec,relatime,perf_event 0 0\ncgroup /sys/fs/cgroup/net_prio cgroup ro,nosuid,nodev,noexec,relatime,net_prio 0 0\ncgroup /sys/fs/cgroup/hugetlb cgroup ro,nosuid,nodev,noexec,relatime,hugetlb 0 0\nsystemd /sys/fs/cgroup/systemd cgroup ro,nosuid,nodev,noexec,relatime,name=systemd 0 0\nmqueue /dev/mqueue mqueue rw,nosuid,nodev,noexec,relatime 0 0\nudev /dev devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\ndevpts /dev/pts devpts rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000 0 0\ntmpfs /var/run tmpfs rw,nosuid,noexec,relatime,size=404732k,mode=755 0 0\nnone /var/run/lock tmpfs rw,nosuid,nodev,noexec,relatime,size=5120k 0 0\nnone /var/run/shm tmpfs rw,nosuid,nodev,relatime 0 0\nnone /var/run/user tmpfs rw,nosuid,nodev,noexec,relatime,size=102400k,mode=755 0 0\n/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e /etc ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\n/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e /var/log ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\ntmpfs /run/docker/plugins tmpfs rw,nosuid,noexec,relatime,size=404732k,mode=755 0 0\nproc /proc/bus proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/fs proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/irq proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/sys proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/sysrq-trigger proc ro,nosuid,nodev,noexec,relatime 0 0\nudev /proc/kcore devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\nudev /proc/timer_list devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\nudev /proc/timer_stats devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\nudev /proc/sched_debug devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\ntmpfs /sys/firmware tmpfs ro,relatime 0 0\n" 
2017-07-27 11:28:39.265097687 -0700 PDT [INFO] Successfully retrieved mountsmap=map[] 
2017-07-27 11:28:39.367459704 -0700 PDT [INFO] Directory doesn't exist, creating it path="/mnt/vmdk/VolSS1@sharedVmfs-0" 
2017-07-27 11:28:39.886183019 -0700 PDT [INFO] Scan complete device="/dev/disk/by-path/pci-0000:03:00.0-scsi-0:0:0:0" event="/dev/disk/by-path/pci-0000:03:00.0-scsi-0:0:0:0": 0x100 == IN_CREATE 
2017-07-27 11:29:08.024002001 -0700 PDT [INFO] Unmounting Volume name="VolSS1@sharedVmfs-0" 
2017-07-27 11:35:25.592003761 -0700 PDT [INFO] Removing volume name=VolSS1 
2017-07-27 11:35:25.681506994 -0700 PDT [ERROR] Failed to remove volume name=VolSS1 error="Failed to remove volume VolSS1, in use by VM = ubuntu-VM0.1." 
2017-07-27 12:04:51.477546743 -0700 PDT [INFO] Attaching volume and creating filesystem name="VolDSMM@sharedVmfs-1" fstype=ext4 
2017-07-27 12:04:51.953857809 -0700 PDT [INFO] Scan complete device="/dev/disk/by-path/pci-0000:03:00.0-scsi-0:0:0:0" event="/dev/disk/by-path/pci-0000:03:00.0-scsi-0:0:0:0": 0x100 == IN_CREATE 
2017-07-27 12:04:52.525562638 -0700 PDT [INFO] Volume and filesystem created name="VolDSMM@sharedVmfs-1" fstype=ext4 
2017-07-27 12:07:24.615113846 -0700 PDT [INFO] Mounting volume name="VolDSMM@sharedVmfs-1" 
2017-07-27 12:07:24.615419763 -0700 PDT [INFO] Mounts read successfullydata="/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e / ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\n/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e /mnt/vmdk ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\nproc /proc proc rw,nosuid,nodev,noexec,relatime 0 0\ntmpfs /dev tmpfs rw,nosuid,mode=755 0 0\ndevpts /dev/pts devpts rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=666 0 0\nsysfs /sys sysfs ro,nosuid,nodev,noexec,relatime 0 0\ntmpfs /sys/fs/cgroup tmpfs ro,nosuid,nodev,noexec,relatime,mode=755 0 0\ncgroup /sys/fs/cgroup/cpuset cgroup ro,nosuid,nodev,noexec,relatime,cpuset 0 0\ncgroup /sys/fs/cgroup/cpu cgroup ro,nosuid,nodev,noexec,relatime,cpu 0 0\ncgroup /sys/fs/cgroup/cpuacct cgroup ro,nosuid,nodev,noexec,relatime,cpuacct 0 0\ncgroup /sys/fs/cgroup/blkio cgroup ro,nosuid,nodev,noexec,relatime,blkio 0 0\ncgroup /sys/fs/cgroup/memory cgroup ro,nosuid,nodev,noexec,relatime,memory 0 0\ncgroup /sys/fs/cgroup/devices cgroup ro,nosuid,nodev,noexec,relatime,devices 0 0\ncgroup /sys/fs/cgroup/freezer cgroup ro,nosuid,nodev,noexec,relatime,freezer 0 0\ncgroup /sys/fs/cgroup/net_cls cgroup ro,nosuid,nodev,noexec,relatime,net_cls 0 0\ncgroup /sys/fs/cgroup/perf_event cgroup ro,nosuid,nodev,noexec,relatime,perf_event 0 0\ncgroup /sys/fs/cgroup/net_prio cgroup ro,nosuid,nodev,noexec,relatime,net_prio 0 0\ncgroup /sys/fs/cgroup/hugetlb cgroup ro,nosuid,nodev,noexec,relatime,hugetlb 0 0\nsystemd /sys/fs/cgroup/systemd cgroup ro,nosuid,nodev,noexec,relatime,name=systemd 0 0\nmqueue /dev/mqueue mqueue rw,nosuid,nodev,noexec,relatime 0 0\nudev /dev devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\ndevpts /dev/pts devpts rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000 0 0\ntmpfs /var/run tmpfs rw,nosuid,noexec,relatime,size=404732k,mode=755 0 0\nnone /var/run/lock tmpfs rw,nosuid,nodev,noexec,relatime,size=5120k 0 0\nnone /var/run/shm tmpfs rw,nosuid,nodev,relatime 0 0\nnone /var/run/user tmpfs rw,nosuid,nodev,noexec,relatime,size=102400k,mode=755 0 0\n/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e /etc ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\n/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e /var/log ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\ntmpfs /run/docker/plugins tmpfs rw,nosuid,noexec,relatime,size=404732k,mode=755 0 0\nproc /proc/bus proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/fs proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/irq proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/sys proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/sysrq-trigger proc ro,nosuid,nodev,noexec,relatime 0 0\nudev /proc/kcore devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\nudev /proc/timer_list devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\nudev /proc/timer_stats devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\nudev /proc/sched_debug devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\ntmpfs /sys/firmware tmpfs ro,relatime 0 0\n" 
2017-07-27 12:07:24.61562325 -0700 PDT [INFO] Successfully retrieved mountsmap=map[] 
2017-07-27 12:07:24.861577953 -0700 PDT [INFO] Directory doesn't exist, creating it path="/mnt/vmdk/VolDSMM@sharedVmfs-1" 
2017-07-27 12:07:25.369740217 -0700 PDT [INFO] Scan complete device="/dev/disk/by-path/pci-0000:03:00.0-scsi-0:0:0:0" event="/dev/disk/by-path/pci-0000:03:00.0-scsi-0:0:0:0": 0x100 == IN_CREATE 
2017-07-27 12:22:00.221499825 -0700 PDT [INFO] Attaching volume and creating filesystem name="VolDSXX@sharedVmfs-1" fstype=ext4 
2017-07-27 12:22:00.74580966 -0700 PDT [INFO] Scan complete event="/dev/disk/by-path/pci-0000:03:00.0-scsi-0:0:1:0": 0x100 == IN_CREATE device="/dev/disk/by-path/pci-0000:03:00.0-scsi-0:0:1:0" 
2017-07-27 12:22:01.353464309 -0700 PDT [INFO] Volume and filesystem created name="VolDSXX@sharedVmfs-1" fstype=ext4 
2017-07-27 12:29:00.275330693 -0700 PDT [INFO] Unmounting Volume name="VolDSMM@sharedVmfs-1" 
2017-07-27 12:29:37.279643003 -0700 PDT [INFO] Removing volume name="TestVolSS@sharedVmfs-0" 
2017-07-27 12:29:37.373516744 -0700 PDT [ERROR] Failed to remove volume name="TestVolSS@sharedVmfs-0" error="Failed to remove volume TestVolSS, in use by VM = ubuntu-VM0.1." 
2017-07-27 12:29:37.574715255 -0700 PDT [INFO] Removing volume name="VolDSXX@sharedVmfs-1" 
2017-07-27 12:29:38.018901073 -0700 PDT [INFO] Removing volume name="VolSS1@sharedVmfs-0" 
2017-07-27 12:29:38.121455278 -0700 PDT [ERROR] Failed to remove volume name="VolSS1@sharedVmfs-0" error="Failed to remove volume VolSS1, in use by VM = ubuntu-VM0.1." 
2017-07-27 12:30:13.22543637 -0700 PDT [INFO] Attaching volume and creating filesystem name="TestVolMM@sharedVmfs-1" fstype=ext4 
2017-07-27 12:30:13.713663817 -0700 PDT [INFO] Scan complete device="/dev/disk/by-path/pci-0000:03:00.0-scsi-0:0:1:0" event="/dev/disk/by-path/pci-0000:03:00.0-scsi-0:0:1:0": 0x100 == IN_CREATE 
2017-07-27 12:30:14.318163819 -0700 PDT [INFO] Volume and filesystem created name="TestVolMM@sharedVmfs-1" fstype=ext4 
2017-07-27 12:31:15.991662415 -0700 PDT [INFO] Mounting volume name="TestVolMM@sharedVmfs-1" 
2017-07-27 12:31:15.991867901 -0700 PDT [INFO] Mounts read successfullydata="/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e / ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\n/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e /mnt/vmdk ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\nproc /proc proc rw,nosuid,nodev,noexec,relatime 0 0\ntmpfs /dev tmpfs rw,nosuid,mode=755 0 0\ndevpts /dev/pts devpts rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=666 0 0\nsysfs /sys sysfs ro,nosuid,nodev,noexec,relatime 0 0\ntmpfs /sys/fs/cgroup tmpfs ro,nosuid,nodev,noexec,relatime,mode=755 0 0\ncgroup /sys/fs/cgroup/cpuset cgroup ro,nosuid,nodev,noexec,relatime,cpuset 0 0\ncgroup /sys/fs/cgroup/cpu cgroup ro,nosuid,nodev,noexec,relatime,cpu 0 0\ncgroup /sys/fs/cgroup/cpuacct cgroup ro,nosuid,nodev,noexec,relatime,cpuacct 0 0\ncgroup /sys/fs/cgroup/blkio cgroup ro,nosuid,nodev,noexec,relatime,blkio 0 0\ncgroup /sys/fs/cgroup/memory cgroup ro,nosuid,nodev,noexec,relatime,memory 0 0\ncgroup /sys/fs/cgroup/devices cgroup ro,nosuid,nodev,noexec,relatime,devices 0 0\ncgroup /sys/fs/cgroup/freezer cgroup ro,nosuid,nodev,noexec,relatime,freezer 0 0\ncgroup /sys/fs/cgroup/net_cls cgroup ro,nosuid,nodev,noexec,relatime,net_cls 0 0\ncgroup /sys/fs/cgroup/perf_event cgroup ro,nosuid,nodev,noexec,relatime,perf_event 0 0\ncgroup /sys/fs/cgroup/net_prio cgroup ro,nosuid,nodev,noexec,relatime,net_prio 0 0\ncgroup /sys/fs/cgroup/hugetlb cgroup ro,nosuid,nodev,noexec,relatime,hugetlb 0 0\nsystemd /sys/fs/cgroup/systemd cgroup ro,nosuid,nodev,noexec,relatime,name=systemd 0 0\nmqueue /dev/mqueue mqueue rw,nosuid,nodev,noexec,relatime 0 0\nudev /dev devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\ndevpts /dev/pts devpts rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000 0 0\ntmpfs /var/run tmpfs rw,nosuid,noexec,relatime,size=404732k,mode=755 0 0\nnone /var/run/lock tmpfs rw,nosuid,nodev,noexec,relatime,size=5120k 0 0\nnone /var/run/shm tmpfs rw,nosuid,nodev,relatime 0 0\nnone /var/run/user tmpfs rw,nosuid,nodev,noexec,relatime,size=102400k,mode=755 0 0\n/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e /etc ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\n/dev/disk/by-uuid/66a21986-55c4-4ede-a2d9-37d30aa41a8e /var/log ext4 rw,relatime,errors=remount-ro,data=ordered 0 0\ntmpfs /run/docker/plugins tmpfs rw,nosuid,noexec,relatime,size=404732k,mode=755 0 0\nproc /proc/bus proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/fs proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/irq proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/sys proc ro,nosuid,nodev,noexec,relatime 0 0\nproc /proc/sysrq-trigger proc ro,nosuid,nodev,noexec,relatime 0 0\nudev /proc/kcore devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\nudev /proc/timer_list devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\nudev /proc/timer_stats devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\nudev /proc/sched_debug devtmpfs rw,relatime,size=2012868k,nr_inodes=503217,mode=755 0 0\ntmpfs /sys/firmware tmpfs ro,relatime 0 0\n" 
2017-07-27 12:31:15.992060704 -0700 PDT [INFO] Successfully retrieved mountsmap=map[] 
2017-07-27 12:31:16.093729211 -0700 PDT [INFO] Directory doesn't exist, creating it path="/mnt/vmdk/TestVolMM@sharedVmfs-1" 
2017-07-27 12:31:16.585591132 -0700 PDT [INFO] Scan complete device="/dev/disk/by-path/pci-0000:03:00.0-scsi-0:0:1:0" event="/dev/disk/by-path/pci-0000:03:00.0-scsi-0:0:1:0": 0x100 == IN_CREATE