{"action":"created","issue":{"url":"https://api.github.com/repos/docker/docker/issues/25979","repository_url":"https://api.github.com/repos/docker/docker","labels_url":"https://api.github.com/repos/docker/docker/issues/25979/labels{/name}","comments_url":"https://api.github.com/repos/docker/docker/issues/25979/comments","events_url":"https://api.github.com/repos/docker/docker/issues/25979/events","html_url":"https://github.com/docker/docker/issues/25979","id":172919508,"number":25979,"title":"On image build: standard_init_linux.go:175: exec user process caused \"permission denied\" ","user":{"login":"rbucchi","id":1633319,"avatar_url":"https://avatars.githubusercontent.com/u/1633319?v=3","gravatar_id":"","url":"https://api.github.com/users/rbucchi","html_url":"https://github.com/rbucchi","followers_url":"https://api.github.com/users/rbucchi/followers","following_url":"https://api.github.com/users/rbucchi/following{/other_user}","gists_url":"https://api.github.com/users/rbucchi/gists{/gist_id}","starred_url":"https://api.github.com/users/rbucchi/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/rbucchi/subscriptions","organizations_url":"https://api.github.com/users/rbucchi/orgs","repos_url":"https://api.github.com/users/rbucchi/repos","events_url":"https://api.github.com/users/rbucchi/events{/privacy}","received_events_url":"https://api.github.com/users/rbucchi/received_events","type":"User","site_admin":false},"labels":[{"url":"https://api.github.com/repos/docker/docker/labels/version/1.12","name":"version/1.12","color":"ededed"}],"state":"open","locked":false,"assignee":null,"assignees":[],"milestone":null,"comments":4,"created_at":"2016-08-24T10:39:45Z","updated_at":"2016-09-27T10:04:27Z","closed_at":null,"body":"<!--\r\nIf you are reporting a new issue, make sure that we do not have any duplicates\r\nalready open. You can ensure this by searching the issue list for this\r\nrepository. If there is a duplicate, please close your issue and add a comment\r\nto the existing issue instead.\r\n\r\nIf you suspect your issue is a bug, please edit your issue description to\r\ninclude the BUG REPORT INFORMATION shown below. If you fail to provide this\r\ninformation within 7 days, we cannot debug your issue and will close it. We\r\nwill, however, reopen it if you later provide the information.\r\n\r\nFor more information about reporting issues, see\r\nhttps://github.com/docker/docker/blob/master/CONTRIBUTING.md#reporting-other-issues\r\n\r\n---------------------------------------------------\r\nBUG REPORT INFORMATION\r\n---------------------------------------------------\r\nUse the commands below to provide key information from your environment:\r\nYou do NOT have to include this information if this is a FEATURE REQUEST\r\n-->\r\n\r\n**Output of `docker version`:**\r\n\r\n```\r\n# docker version\r\nClient:\r\n Version:      1.12.1\r\n API version:  1.24\r\n Go version:   go1.6.3\r\n Git commit:   23cf638\r\n Built:        \r\n OS/Arch:      linux/amd64\r\n\r\nServer:\r\n Version:      1.12.1\r\n API version:  1.24\r\n Go version:   go1.6.3\r\n Git commit:   23cf638\r\n Built:        \r\n OS/Arch:      linux/amd64\r\n```\r\n\r\n**Output of `docker info`:**\r\n\r\n```\r\n# docker info\r\nContainers: 5\r\n Running: 2\r\n Paused: 0\r\n Stopped: 3\r\nImages: 7\r\nServer Version: 1.12.1\r\nStorage Driver: devicemapper\r\n Pool Name: docker-253:1-25219614-pool\r\n Pool Blocksize: 65.54 kB\r\n Base Device Size: 10.74 GB\r\n Backing Filesystem: xfs\r\n Data file: /dev/loop0\r\n Metadata file: /dev/loop1\r\n Data Space Used: 536.6 MB\r\n Data Space Total: 107.4 GB\r\n Data Space Available: 8.029 GB\r\n Metadata Space Used: 1.507 MB\r\n Metadata Space Total: 2.147 GB\r\n Metadata Space Available: 2.146 GB\r\n Thin Pool Minimum Free Space: 10.74 GB\r\n Udev Sync Supported: true\r\n Deferred Removal Enabled: false\r\n Deferred Deletion Enabled: false\r\n Deferred Deleted Device Count: 0\r\n Data loop file: /var/lib/docker/devicemapper/devicemapper/data\r\n WARNING: Usage of loopback devices is strongly discouraged for production use. Use `--storage-opt dm.thinpooldev` to specify a custom block storage device.\r\n Metadata loop file: /var/lib/docker/devicemapper/devicemapper/metadata\r\n Library Version: 1.02.107-RHEL7 (2016-06-09)\r\nLogging Driver: json-file\r\nCgroup Driver: cgroupfs\r\nPlugins:\r\n Volume: local\r\n Network: bridge host null calico overlay\r\nSwarm: inactive\r\nRuntimes: runc\r\nDefault Runtime: runc\r\nSecurity Options: seccomp selinux\r\nKernel Version: 3.10.0-327.13.1.el7.x86_64\r\nOperating System: CentOS Linux 7 (Core)\r\nOSType: linux\r\nArchitecture: x86_64\r\nCPUs: 1\r\nTotal Memory: 1.797 GiB\r\nName: nessun-ricordo-1\r\nID: ENCB:4GPL:FDFW:LKLR:UYG6:DDGA:KDA6:DSDB:S5ES:AG6J:L2BW:OTAE\r\nDocker Root Dir: /var/lib/docker\r\nDebug Mode (client): false\r\nDebug Mode (server): false\r\nRegistry: https://index.docker.io/v1/\r\nWARNING: bridge-nf-call-iptables is disabled\r\nWARNING: bridge-nf-call-ip6tables is disabled\r\nCluster Store: etcd://10.0.0.42:2379\r\nInsecure Registries:\r\n 127.0.0.0/8\r\n```\r\n\r\n**Additional environment details (AWS, VirtualBox, physical, etc.):**\r\n\r\nVM on Openstack I installed simultaneously three CentOS identical images as a mesos-marathon cluster:\r\n\r\n```\r\n# cat /etc/redhat-release \r\nCentOS Linux release 7.2.1511 (Core)\r\n# sestatus\r\nSELinux status:                 enabled\r\nSELinuxfs mount:                /sys/fs/selinux\r\nSELinux root directory:         /etc/selinux\r\nLoaded policy name:             targeted\r\nCurrent mode:                   enforcing\r\nMode from config file:          enforcing\r\nPolicy MLS status:              enabled\r\nPolicy deny_unknown status:     allowed\r\nMax kernel policy version:      28\r\n```\r\n\r\nI got etcd as cluster store for Calico as external network drivers.\r\n\r\n```\r\n# systemctl cat docker\r\n# /usr/lib/systemd/system/docker.service\r\n[Unit]\r\nDescription=Docker Application Container Engine\r\nDocumentation=https://docs.docker.com\r\nAfter=network.target\r\n\r\n[Service]\r\nType=notify\r\n# the default is not to use systemd for cgroups because the delegate issues still\r\n# exists and systemd currently does not support the cgroup feature set required\r\n# for containers run by docker\r\nExecStart=/usr/bin/dockerd\r\nExecReload=/bin/kill -s HUP $MAINPID\r\n# Having non-zero Limit*s causes performance problems due to accounting overhead\r\n# in the kernel. We recommend using cgroups to do container-local accounting.\r\nLimitNOFILE=infinity\r\nLimitNPROC=infinity\r\nLimitCORE=infinity\r\n# Uncomment TasksMax if your systemd version supports it.\r\n# Only systemd 226 and above support this version.\r\n#TasksMax=infinity\r\nTimeoutStartSec=0\r\n# set delegate yes so that systemd does not reset the cgroups of docker containers\r\nDelegate=yes\r\n# kill only the docker process, not all processes in the cgroup\r\nKillMode=process\r\n\r\n[Install]\r\nWantedBy=multi-user.target\r\n\r\n# /etc/systemd/system/docker.service.d/override.conf\r\n[Service]\r\nExecStart=\r\nExecStart=/usr/bin/docker daemon --selinux-enabled --cluster-store=etcd://10.0.0.42:2379\r\n ```\r\n\r\n**note**: this issue appear only in one node of the three (apparently) identical servers. \r\n\r\n**Steps to reproduce the issue:**\r\n\r\n  1  git clone https://github.com/DS-CNAF/HTCondor-docker-debian.git\r\n  2  cd HTCondor-docker-debian/\r\n  3  git checkout -b health-check origin/health-check\r\n  4  docker build --tag dscnaf/htcondor-debian .\r\n\r\n**Describe the results you received:**\r\n\r\n ```\r\n[root@nessun-ricordo-1 HTCondor-docker-debian]# docker build --tag dscnaf/htcondor-debian .                                                                                                                                                   \r\nSending build context to Docker daemon 159.7 kB\r\nStep 1 : FROM ubuntu:14.04\r\n ---> ff6011336327\r\nStep 2 : MAINTAINER Riccardo Bucchi <riccardo.bucchi26@gmail.com>\r\n ---> Using cache\r\n ---> 3c0413bbe458\r\nStep 3 : ENV TINI_VERSION v0.9.0\r\n ---> Using cache\r\n ---> 9eb9b0c30721\r\nStep 4 : EXPOSE 5000\r\n ---> Using cache\r\n ---> e4e86e366a4a\r\nStep 5 : ADD https://github.com/krallin/tini/releases/download/${TINI_VERSION}/tini /sbin/tini\r\nDownloading [==================================================>] 18.73 kB/18.73 kB\r\n ---> Using cache\r\n ---> 64c5f11ac6e0\r\nStep 6 : RUN set -ex    && apt-get update && apt-get install -y wget procps     && chmod +x /sbin/tini  && echo \"deb http://research.cs.wisc.edu/htcondor/ubuntu/stable/ trusty contrib\" >> /etc/apt/sources.list       && wget -qO - http://r\r\nesearch.cs.wisc.edu/htcondor/ubuntu/HTCondor-Release.gpg.key | apt-key add -         && export DEBIAN_FRONTEND=noninteractive   && apt-get update       && apt-get install condor -y --force-yes        && apt-get install -y python-pip && pi\r\np install supervisor supervisor-stdout  && apt-get install fuse -y      && wget --no-check-certificate -q https://get.onedata.org/oneclient.sh  && chmod 775 oneclient.sh       && ./oneclient.sh         && mkdir /var/log/oneclient   && mkd\r\nir -p /opt/health/master/ /opt/health/executor/ /opt/health/submitter/  && apt-get install -y python-pip && pip install Flask   && apt-get -y remove wget python-pip         && apt-get clean all\r\n ---> Running in 75310ae10868\r\nstandard_init_linux.go:175: exec user process caused \"permission denied\"\r\nThe command '/bin/sh -c set -ex         && apt-get update && apt-get install -y wget procps     && chmod +x /sbin/tini  && echo \"deb http://research.cs.wisc.edu/htcondor/ubuntu/stable/ trusty contrib\" >> /etc/apt/sources.list       && wge\r\nt -qO - http://research.cs.wisc.edu/htcondor/ubuntu/HTCondor-Release.gpg.key | apt-key add -         && export DEBIAN_FRONTEND=noninteractive   && apt-get update       && apt-get install condor -y --force-yes        && apt-get install -y \r\npython-pip && pip install supervisor supervisor-stdout  && apt-get install fuse -y      && wget --no-check-certificate -q https://get.onedata.org/oneclient.sh  && chmod 775 oneclient.sh       && ./oneclient.sh         && mkdir /var/log/on\r\neclient         && mkdir -p /opt/health/master/ /opt/health/executor/ /opt/health/submitter/    && apt-get install -y python-pip && pip install Flask   && apt-get -y remove wget python-pip         && apt-get clean all' returned a non-zero\r\n code: 1\r\n ```\r\n\r\n**Describe the results you expected:**\r\n\r\n ```\r\n[root@nessun-ricordo-2 HTCondor-docker-debian]# docker build --tag dscnaf/htcondor-debian .\r\n...\r\nSuccessfully built 7dfbce8f1152\r\n ```"},"comment":{"url":"https://api.github.com/repos/docker/docker/issues/comments/249822005","html_url":"https://github.com/docker/docker/issues/25979#issuecomment-249822005","issue_url":"https://api.github.com/repos/docker/docker/issues/25979","id":249822005,"user":{"login":"the-nw1-group","id":13179270,"avatar_url":"https://avatars.githubusercontent.com/u/13179270?v=3","gravatar_id":"","url":"https://api.github.com/users/the-nw1-group","html_url":"https://github.com/the-nw1-group","followers_url":"https://api.github.com/users/the-nw1-group/followers","following_url":"https://api.github.com/users/the-nw1-group/following{/other_user}","gists_url":"https://api.github.com/users/the-nw1-group/gists{/gist_id}","starred_url":"https://api.github.com/users/the-nw1-group/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/the-nw1-group/subscriptions","organizations_url":"https://api.github.com/users/the-nw1-group/orgs","repos_url":"https://api.github.com/users/the-nw1-group/repos","events_url":"https://api.github.com/users/the-nw1-group/events{/privacy}","received_events_url":"https://api.github.com/users/the-nw1-group/received_events","type":"User","site_admin":false},"created_at":"2016-09-27T10:04:27Z","updated_at":"2016-09-27T10:04:27Z","body":"Ah I see what you mean, here's the rest!\r\n\r\n```\r\nSep 27 09:58:04 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:04.306102427+01:00\" level=debug msg=\"Untar time: 10.877199316s\"\r\nSep 27 09:58:04 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:04.306183703+01:00\" level=debug msg=\"devmapper: UnmountDevice(hash=2a5a1fe5eb02a98b1f6399599017bda3a42ef070a1f7b3b8ce2601b8d513be22)\"\r\nSep 27 09:58:04 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:04.306210922+01:00\" level=debug msg=\"devmapper: Unmount(/var/lib/docker/devicemapper/mnt/2a5a1fe5eb02a98b1f6399599017bda3a42ef070a1f7b3b8ce2601b8d513be22)\"\r\nSep 27 09:58:06 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:06.759218381+01:00\" level=debug msg=\"devmapper: Unmount done\"\r\nSep 27 09:58:06 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:06.759298690+01:00\" level=debug msg=\"devmapper: deactivateDevice(2a5a1fe5eb02a98b1f6399599017bda3a42ef070a1f7b3b8ce2601b8d513be22)\"\r\nSep 27 09:58:06 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:06.759427548+01:00\" level=debug msg=\"devmapper: removeDevice START(docker-253:1-1006633150-2a5a1fe5eb02a98b1f6399599017bda3a42ef070a1f7b3b8ce2601b8d513be22)\"\r\nSep 27 09:58:06 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:06.791957037+01:00\" level=debug msg=\"devmapper: removeDevice END(docker-253:1-1006633150-2a5a1fe5eb02a98b1f6399599017bda3a42ef070a1f7b3b8ce2601b8d513be22)\"\r\nSep 27 09:58:06 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:06.792028141+01:00\" level=debug msg=\"devmapper: deactivateDevice END(2a5a1fe5eb02a98b1f6399599017bda3a42ef070a1f7b3b8ce2601b8d513be22)\"\r\nSep 27 09:58:06 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:06.792049808+01:00\" level=debug msg=\"devmapper: UnmountDevice(hash=2a5a1fe5eb02a98b1f6399599017bda3a42ef070a1f7b3b8ce2601b8d513be22) END\"\r\nSep 27 09:58:06 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:06.792114005+01:00\" level=debug msg=\"Applied tar sha256:0aeb287b1ba9fd4c951bb9f4bd8e50908f51c630e07b655b3b2f9581dc0fef0d to 2a5a1fe5eb02a98b1f6399599017bda3a42ef070a1f7b3b8ce2601b8d513be22, size: 196744353\"\r\nSep 27 09:58:06 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:06.802062188+01:00\" level=debug msg=\"Calling POST /v1.24/containers/create\"\r\nSep 27 09:58:06 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:06.802536818+01:00\" level=debug msg=\"form data: {\\\"AttachStderr\\\":true,\\\"AttachStdin\\\":false,\\\"AttachStdout\\\":true,\\\"Cmd\\\":null,\\\"Domainname\\\":\\\"\\\",\\\"Entrypoint\\\":[\\\"/bin/bash\\\"],\\\"Env\\\":[],\\\"HostConfig\\\":{\\\"AutoRemove\\\":false,\\\"Binds\\\":null,\\\"BlkioDeviceReadBps\\\":null,\\\"BlkioDeviceReadIOps\\\":null,\\\"BlkioDeviceWriteBps\\\":null,\\\"BlkioDeviceWriteIOps\\\":null,\\\"BlkioWeight\\\":0,\\\"BlkioWeightDevice\\\":null,\\\"CapAdd\\\":null,\\\"CapDrop\\\":null,\\\"Cgroup\\\":\\\"\\\",\\\"CgroupParent\\\":\\\"\\\",\\\"ConsoleSize\\\":[0,0],\\\"ContainerIDFile\\\":\\\"\\\",\\\"CpuCount\\\":0,\\\"CpuPercent\\\":0,\\\"CpuPeriod\\\":0,\\\"CpuQuota\\\":0,\\\"CpuShares\\\":0,\\\"CpusetCpus\\\":\\\"\\\",\\\"CpusetMems\\\":\\\"\\\",\\\"Devices\\\":[],\\\"DiskQuota\\\":0,\\\"Dns\\\":[],\\\"DnsOptions\\\":[],\\\"DnsSearch\\\":[],\\\"ExtraHosts\\\":null,\\\"GroupAdd\\\":null,\\\"IOMaximumBandwidth\\\":0,\\\"IOMaximumIOps\\\":0,\\\"IpcMode\\\":\\\"\\\",\\\"Isolation\\\":\\\"\\\",\\\"KernelMemory\\\":0,\\\"Links\\\":null,\\\"LogConfig\\\":{\\\"Config\\\":{},\\\"Type\\\":\\\"\\\"},\\\"Memory\\\":0,\\\"MemoryReservation\\\":0,\\\"MemorySwap\\\":0,\\\"MemorySwappiness\\\":-1,\\\"NetworkMode\\\":\\\"default\\\",\\\"OomKillDisable\\\":false,\\\"OomScoreAdj\\\":0,\\\"PidMode\\\":\\\"\\\",\\\"PidsLimit\\\":0,\\\"PortBindings\\\":{},\\\"Privileged\\\":false,\\\"PublishAllPorts\\\":false,\\\"ReadonlyRootfs\\\":false,\\\"RestartPolicy\\\":{\\\"MaximumRetryCount\\\":0,\\\"Name\\\":\\\"no\\\"},\\\"SecurityOpt\\\":null,\\\"ShmSize\\\":0,\\\"UTSMode\\\":\\\"\\\",\\\"Ulimits\\\":null,\\\"UsernsMode\\\":\\\"\\\",\\\"VolumeDriver\\\":\\\"\\\",\\\"VolumesFrom\\\":null},\\\"Hostname\\\":\\\"\\\",\\\"Image\\\":\\\"centos:7\\\",\\\"Labels\\\":{},\\\"NetworkingConfig\\\":{\\\"EndpointsConfig\\\":{}},\\\"OnBuild\\\":null,\\\"OpenStdin\\\":false,\\\"StdinOnce\\\":false,\\\"Tty\\\":false,\\\"User\\\":\\\"\\\",\\\"Volumes\\\":{},\\\"WorkingDir\\\":\\\"\\\"}\"\r\nSep 27 09:58:06 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:06.805113982+01:00\" level=debug msg=\"devmapper: AddDevice(hash=cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624-init basehash=2a5a1fe5eb02a98b1f6399599017bda3a42ef070a1f7b3b8ce2601b8d513be22)\"\r\nSep 27 09:58:06 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:06.810376751+01:00\" level=debug msg=\"devmapper: registerDevice(26, cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624-init)\"\r\nSep 27 09:58:06 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:06.812625540+01:00\" level=debug msg=\"devmapper: AddDevice(hash=cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624-init basehash=2a5a1fe5eb02a98b1f6399599017bda3a42ef070a1f7b3b8ce2601b8d513be22) END\"\r\nSep 27 09:58:06 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:06.813890398+01:00\" level=debug msg=\"devmapper: activateDeviceIfNeeded(cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624-init)\"\r\nSep 27 09:58:06 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:06.871658299+01:00\" level=debug msg=\"devmapper: UnmountDevice(hash=cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624-init)\"\r\nSep 27 09:58:06 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:06.871737508+01:00\" level=debug msg=\"devmapper: Unmount(/var/lib/docker/devicemapper/mnt/cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624-init)\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.149996331+01:00\" level=debug msg=\"devmapper: Unmount done\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.150072278+01:00\" level=debug msg=\"devmapper: deactivateDevice(cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624-init)\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.150198594+01:00\" level=debug msg=\"devmapper: removeDevice START(docker-253:1-1006633150-cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624-init)\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.178951792+01:00\" level=debug msg=\"devmapper: removeDevice END(docker-253:1-1006633150-cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624-init)\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.179021760+01:00\" level=debug msg=\"devmapper: deactivateDevice END(cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624-init)\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.179044685+01:00\" level=debug msg=\"devmapper: UnmountDevice(hash=cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624-init) END\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.179066230+01:00\" level=debug msg=\"devmapper: AddDevice(hash=cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624 basehash=cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624-init)\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.184616298+01:00\" level=debug msg=\"devmapper: registerDevice(27, cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624)\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.187621498+01:00\" level=debug msg=\"devmapper: AddDevice(hash=cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624 basehash=cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624-init) END\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.193093307+01:00\" level=debug msg=\"devmapper: activateDeviceIfNeeded(cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624)\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.243711822+01:00\" level=debug msg=\"container mounted via layerStore: /var/lib/docker/devicemapper/mnt/cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624/rootfs\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.243800660+01:00\" level=debug msg=\"devmapper: UnmountDevice(hash=cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624)\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.243824674+01:00\" level=debug msg=\"devmapper: Unmount(/var/lib/docker/devicemapper/mnt/cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624)\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.307410846+01:00\" level=debug msg=\"devmapper: Unmount done\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.307550926+01:00\" level=debug msg=\"devmapper: deactivateDevice(cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624)\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.307703677+01:00\" level=debug msg=\"devmapper: removeDevice START(docker-253:1-1006633150-cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624)\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.332042459+01:00\" level=debug msg=\"devmapper: removeDevice END(docker-253:1-1006633150-cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624)\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.332102056+01:00\" level=debug msg=\"devmapper: deactivateDevice END(cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624)\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.332127144+01:00\" level=debug msg=\"devmapper: UnmountDevice(hash=cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624) END\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.433950336+01:00\" level=debug msg=\"Calling POST /v1.24/containers/05b710dd4f49573a9c8c9be23cc78a43154146ae0564a23d02d2f96a8e695f6f/attach?stderr=1&stdout=1&stream=1\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.434272515+01:00\" level=debug msg=\"attach: stdout: begin\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.434287893+01:00\" level=debug msg=\"attach: stderr: begin\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.434888417+01:00\" level=debug msg=\"Calling POST /v1.24/containers/05b710dd4f49573a9c8c9be23cc78a43154146ae0564a23d02d2f96a8e695f6f/start\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.435722441+01:00\" level=debug msg=\"devmapper: activateDeviceIfNeeded(cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624)\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.478542785+01:00\" level=debug msg=\"container mounted via layerStore: /var/lib/docker/devicemapper/mnt/cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624/rootfs\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.478793447+01:00\" level=debug msg=\"Assigning addresses for endpoint kickass_goldwasser's interface on network bridge\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.478835693+01:00\" level=debug msg=\"RequestAddress(LocalDefault/172.17.0.0/16, <nil>, map[])\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.498571657+01:00\" level=debug msg=\"Assigning addresses for endpoint kickass_goldwasser's interface on network bridge\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.506013220+01:00\" level=debug msg=\"Programming external connectivity on endpoint kickass_goldwasser (00ee07f587fd69518a524089cc987a9d94e8992c83dd6ceee380a23d919c3148)\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.622372693+01:00\" level=debug msg=\"sandbox set key processing took 20.313875ms for container 05b710dd4f49573a9c8c9be23cc78a43154146ae0564a23d02d2f96a8e695f6f\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.688957302+01:00\" level=debug msg=\"containerd: process exited\" id=05b710dd4f49573a9c8c9be23cc78a43154146ae0564a23d02d2f96a8e695f6f pid=init status=1 systemPid=20129\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.695774030+01:00\" level=debug msg=\"libcontainerd: received containerd event: &types.Event{Type:\\\"start-container\\\", Id:\\\"05b710dd4f49573a9c8c9be23cc78a43154146ae0564a23d02d2f96a8e695f6f\\\", Status:0x0, Pid:\\\"\\\", Timestamp:(*timestamp.Timestamp)(0xc82109d430)}\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.716105915+01:00\" level=debug msg=\"libcontainerd: event unhandled: type:\\\"start-container\\\" id:\\\"05b710dd4f49573a9c8c9be23cc78a43154146ae0564a23d02d2f96a8e695f6f\\\" timestamp:<seconds:1474966687 nanos:695392511 > \"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.717539075+01:00\" level=debug msg=\"libcontainerd: received containerd event: &types.Event{Type:\\\"exit\\\", Id:\\\"05b710dd4f49573a9c8c9be23cc78a43154146ae0564a23d02d2f96a8e695f6f\\\", Status:0x1, Pid:\\\"init\\\", Timestamp:(*timestamp.Timestamp)(0xc8210a8af0)}\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.717852752+01:00\" level=debug msg=\"attach: stdout: end\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.717885611+01:00\" level=debug msg=\"attach: stderr: end\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.718216543+01:00\" level=debug msg=\"Revoking external connectivity on endpoint kickass_goldwasser (00ee07f587fd69518a524089cc987a9d94e8992c83dd6ceee380a23d919c3148)\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.720105690+01:00\" level=debug msg=\"Calling POST /v1.24/containers/05b710dd4f49573a9c8c9be23cc78a43154146ae0564a23d02d2f96a8e695f6f/wait\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.776590506+01:00\" level=debug msg=\"Releasing addresses for endpoint kickass_goldwasser's interface on network bridge\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.777213694+01:00\" level=debug msg=\"ReleaseAddress(LocalDefault/172.17.0.0/16, 172.17.0.2)\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.782968941+01:00\" level=debug msg=\"devmapper: UnmountDevice(hash=cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624)\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.783014354+01:00\" level=debug msg=\"devmapper: Unmount(/var/lib/docker/devicemapper/mnt/cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624)\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.835861859+01:00\" level=debug msg=\"devmapper: Unmount done\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.835932578+01:00\" level=debug msg=\"devmapper: deactivateDevice(cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624)\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.836104628+01:00\" level=debug msg=\"devmapper: removeDevice START(docker-253:1-1006633150-cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624)\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.859907797+01:00\" level=debug msg=\"devmapper: removeDevice END(docker-253:1-1006633150-cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624)\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.859970757+01:00\" level=debug msg=\"devmapper: deactivateDevice END(cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624)\"\r\nSep 27 09:58:07 vm-beis-dev01 docker[19155]: time=\"2016-09-27T09:58:07.859992167+01:00\" level=debug msg=\"devmapper: UnmountDevice(hash=cadb4bb409e2b13ec2e87daae387fe5cd0105b689d224809f0bf9fb4f9533624) END\"\r\n```"}}
{"actor":{"display_login":"the-nw1-group"}}