compose icon indicating copy to clipboard operation
compose copied to clipboard

Docker Compose with volume stuck on "compose.parallel.feed_queue: Pending: set()"

Open darty opened this issue 4 years ago • 25 comments

Description of the issue

When using a bind volume in a yml file, docker-compose does not start the service, but is stuck on "compose.parallel.feed_queue: Pending: set()". If the volume declarations are removed from the yml file, the container starts.

Context information (for bug reports)

Output of docker-compose version

docker-compose version 1.25.5, build 8a1c60f6
docker-py version: 4.1.0
CPython version: 3.7.4
OpenSSL version: OpenSSL 1.1.1c  28 May 2019

Output of docker version

Client: Docker Engine - Community
 Version:           19.03.8
 API version:       1.40
 Go version:        go1.12.17
 Git commit:        afacb8b
 Built:             Wed Mar 11 01:23:10 2020
 OS/Arch:           windows/amd64
 Experimental:      false

Server: Docker Engine - Community
 Engine:
  Version:          19.03.8
  API version:      1.40 (minimum version 1.12)
  Go version:       go1.12.17
  Git commit:       afacb8b
  Built:            Wed Mar 11 01:29:16 2020
  OS/Arch:          linux/amd64
  Experimental:     false
 containerd:
  Version:          v1.2.13
  GitCommit:        7ad184331fa3e55e52b890ea95e65ba581ae3429
 runc:
  Version:          1.0.0-rc10
  GitCommit:        dc9208a3303feef5b3839f4323d9beb36df0a9dd
 docker-init:
  Version:          0.18.0
  GitCommit:        fec3683

Output of docker-compose config (Make sure to add the relevant -f and other flags)

networks:
  app:
    name: app
services:
  db:
    command: --character-set-server=utf8 --innodb-flush-method=littlesync --innodb-use-native-aio=OFF
      --log_bin=ON --skip-innodb-file-per-table
    container_name: backend-db-mysql
    environment:
      MYSQL_ROOT_PASSWORD: Xq54tGxtZt4MJha
    expose:
    - '3306'
    image: mysql:latest
    networks:
      app: null
    ports:
    - published: 3306
      target: 3306
    restart: always
    volumes:
    - source: D:\development\private\backend-db-test\backend-db-mysql\data
      target: /var/lib/mysql
      type: bind
    - source: D:\development\private\backend-db-test\backend-db-mysql\logs
      target: /var/log/mysql
      type: bind
version: '3.7'

Steps to reproduce the issue

  1. Use following yml file:
version: '3.7'

services:
   db:
    image: mysql:latest
    container_name: backend-db-mysql
    ports:
    - "3306:3306"
    expose:
    - '3306'
    volumes:
      - type: bind
        source: ./backend-db-mysql/data
        target: /var/lib/mysql
      - type: bind
        source: ./backend-db-mysql/logs
        target: /var/log/mysql
    environment:
        MYSQL_ROOT_PASSWORD: ${PERSISTENT_DB_ROOT_PWD}
    restart: always
    command: --character-set-server=utf8 --innodb-flush-method=littlesync --innodb-use-native-aio=OFF --log_bin=ON --skip-innodb-file-per-table
    networks:
    - app
       
networks:
  app:
    name: app

Alternatively, I have tried to use the following volume definitions with the same result:

...
volumes:
      - ./backend-db-mysql/data:/var/lib/mysql:rw
      - ./backend-db-mysql/logs:/var/log/mysql:rw
...
  1. Use following .env file:
# For building
DOCKERFILE=Dockerfile

# Environment forwarding
GLOBAL_ENV=.env

PERSISTENT_DB_PORT=3306
PERSISTENT_DB_DIALECT=mysql
PERSISTENT_DB_NAME=*HIDDEN*
PERSISTENT_DB_USER=*HIDDEN*
PERSISTENT_DB_PWD=*HIDDEN*
PERSISTENT_DB_ROOT_PWD=*HIDDEN*
  1. Run command: docker-compose --verbose up

Observed result

Following output is given:

compose.config.config.find: Using configuration files: .\docker-compose.yml
docker.utils.config.find_config_file: Trying paths: ['C:\\Users\\Donald\\.docker\\config.json', 'C:\\Users\\Donald\\.dockercfg']
docker.utils.config.find_config_file: Found file at path: C:\Users\Donald\.docker\config.json
docker.auth.load_config: Found 'auths' section
docker.auth.parse_auth: Auth data for https://index.docker.io/v1/ is absent. Client might be using a credentials store instead.
docker.auth.load_config: Found 'credsStore' section
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/version HTTP/1.1" 200 853
compose.cli.command.get_client: docker-compose version 1.25.5, build 8a1c60f6
docker-py version: 4.1.0
CPython version: 3.7.4
OpenSSL version: OpenSSL 1.1.1c  28 May 2019
compose.cli.command.get_client: Docker base_url: http+docker://localnpipe
compose.cli.command.get_client: Docker version: Platform={'Name': 'Docker Engine - Community'}, Components=[{'Name': 'Engine', 'Version': '19.03.8', 'Details': {'ApiVersion': '1.40', 'Arch': 'amd64', 'BuildTime': '2020-03-11T01:29:16.000000000+00:00', 'Experimental': 'false', 'GitCommit': 'afacb8b', 'GoVersion': 'go1.12.17', 'KernelVersion': '4.19.76-linuxkit', 'MinAPIVersion': '1.12', 'Os': 'linux'}}, {'Name': 'containerd', 'Version': 'v1.2.13', 'Details': {'GitCommit': '7ad184331fa3e55e52b890ea95e65ba581ae3429'}}, {'Name': 'runc', 'Version': '1.0.0-rc10', 'Details': {'GitCommit': 'dc9208a3303feef5b3839f4323d9beb36df0a9dd'}}, {'Name': 'docker-init', 'Version': '0.18.0', 'Details': {'GitCommit': 'fec3683'}}], Version=19.03.8, ApiVersion=1.40, MinAPIVersion=1.12, GitCommit=afacb8b, GoVersion=go1.12.17, Os=linux, Arch=amd64, KernelVersion=4.19.76-linuxkit, BuildTime=2020-03-11T01:29:16.000000000+00:00
compose.cli.verbose_proxy.proxy_callable: docker inspect_network <- ('app')
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/networks/app HTTP/1.1" 200 540
compose.cli.verbose_proxy.proxy_callable: docker inspect_network -> {'Attachable': True,
 'ConfigFrom': {'Network': ''},
 'ConfigOnly': False,
 'Containers': {},
 'Created': '2020-07-01T15:33:52.097459378Z',
 'Driver': 'bridge',
 'EnableIPv6': False,
 'IPAM': {'Config': [{'Gateway': '172.18.0.1', 'Subnet': '172.18.0.0/16'}],
          'Driver': 'default',
          'Options': None},
...
compose.cli.verbose_proxy.proxy_callable: docker info <- ()
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/info HTTP/1.1" 200 None
compose.cli.verbose_proxy.proxy_callable: docker info -> {'Architecture': 'x86_64',
 'BridgeNfIp6tables': True,
 'BridgeNfIptables': True,
 'CPUSet': True,
 'CPUShares': True,
 'CgroupDriver': 'cgroupfs',
 'ClusterAdvertise': '',
 'ClusterStore': '',
 'ContainerdCommit': {'Expected': '7ad184331fa3e55e52b890ea95e65ba581ae3429',
                      'ID': '7ad184331fa3e55e52b890ea95e65ba581ae3429'},
...
compose.cli.verbose_proxy.proxy_callable: docker inspect_network <- ('app')
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/networks/app HTTP/1.1" 200 540
compose.cli.verbose_proxy.proxy_callable: docker inspect_network -> {'Attachable': True,
 'ConfigFrom': {'Network': ''},
 'ConfigOnly': False,
 'Containers': {},
 'Created': '2020-07-01T15:33:52.097459378Z',
 'Driver': 'bridge',
 'EnableIPv6': False,
 'IPAM': {'Config': [{'Gateway': '172.18.0.1', 'Subnet': '172.18.0.0/16'}],
          'Driver': 'default',
          'Options': None},
...
compose.cli.verbose_proxy.proxy_callable: docker containers <- (all=False, filters={'label': ['com.docker.compose.project=backend-db-test', 'com.docker.compose.oneoff=False']})
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/containers/json?limit=-1&all=0&size=0&trunc_cmd=0&filters=%7B%22label%22%3A+%5B%22com.docker.compose.project%3Dbackend-db-test%22%2C+%22com.docker.compose.oneoff%3DFalse%22%5D%7D HTTP/1.1" 200 3
compose.cli.verbose_proxy.proxy_callable: docker containers -> (list with 0 items)
compose.cli.verbose_proxy.proxy_callable: docker containers <- (all=False, filters={'label': ['com.docker.compose.project=backenddbtest', 'com.docker.compose.oneoff=False']})
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/containers/json?limit=-1&all=0&size=0&trunc_cmd=0&filters=%7B%22label%22%3A+%5B%22com.docker.compose.project%3Dbackenddbtest%22%2C+%22com.docker.compose.oneoff%3DFalse%22%5D%7D HTTP/1.1" 200 3
compose.cli.verbose_proxy.proxy_callable: docker containers -> (list with 0 items)
compose.cli.verbose_proxy.proxy_callable: docker containers <- (all=True, filters={'label': ['com.docker.compose.project=backend-db-test', 'com.docker.compose.oneoff=False']})
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/containers/json?limit=-1&all=1&size=0&trunc_cmd=0&filters=%7B%22label%22%3A+%5B%22com.docker.compose.project%3Dbackend-db-test%22%2C+%22com.docker.compose.oneoff%3DFalse%22%5D%7D HTTP/1.1" 200 1572
compose.cli.verbose_proxy.proxy_callable: docker containers -> (list with 1 items)
compose.cli.verbose_proxy.proxy_callable: docker inspect_container <- ('1f6296183499d299609f041dc6dccad6ee3fc027a03f64a8b9b5f25636d69738')
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/containers/1f6296183499d299609f041dc6dccad6ee3fc027a03f64a8b9b5f25636d69738/json HTTP/1.1" 200 None
compose.cli.verbose_proxy.proxy_callable: docker inspect_container -> {'AppArmorProfile': '',
 'Args': ['--character-set-server=utf8',
          '--innodb-flush-method=littlesync',
          '--innodb-use-native-aio=OFF',
          '--log_bin=ON',
          '--skip-innodb-file-per-table'],
 'Config': {'AttachStderr': False,
            'AttachStdin': False,
            'AttachStdout': False,
            'Cmd': ['--character-set-server=utf8',
...
compose.cli.verbose_proxy.proxy_callable: docker containers <- (all=True, filters={'label': ['com.docker.compose.project=backend-db-test', 'com.docker.compose.service=db', 'com.docker.compose.oneoff=False']})
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/containers/json?limit=-1&all=1&size=0&trunc_cmd=0&filters=%7B%22label%22%3A+%5B%22com.docker.compose.project%3Dbackend-db-test%22%2C+%22com.docker.compose.service%3Ddb%22%2C+%22com.docker.compose.oneoff%3DFalse%22%5D%7D HTTP/1.1" 200 1572
compose.cli.verbose_proxy.proxy_callable: docker containers -> (list with 1 items)
compose.cli.verbose_proxy.proxy_callable: docker inspect_container <- ('1f6296183499d299609f041dc6dccad6ee3fc027a03f64a8b9b5f25636d69738')
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/containers/1f6296183499d299609f041dc6dccad6ee3fc027a03f64a8b9b5f25636d69738/json HTTP/1.1" 200 None
compose.cli.verbose_proxy.proxy_callable: docker inspect_container -> {'AppArmorProfile': '',
 'Args': ['--character-set-server=utf8',
          '--innodb-flush-method=littlesync',
          '--innodb-use-native-aio=OFF',
          '--log_bin=ON',
          '--skip-innodb-file-per-table'],
 'Config': {'AttachStderr': False,
            'AttachStdin': False,
            'AttachStdout': False,
            'Cmd': ['--character-set-server=utf8',
...
compose.cli.verbose_proxy.proxy_callable: docker inspect_image <- ('mysql:latest')
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/images/mysql:latest/json HTTP/1.1" 200 None
compose.cli.verbose_proxy.proxy_callable: docker inspect_image -> {'Architecture': 'amd64',
 'Author': '',
 'Comment': '',
 'Config': {'ArgsEscaped': True,
            'AttachStderr': False,
            'AttachStdin': False,
            'AttachStdout': False,
            'Cmd': ['mysqld'],
            'Domainname': '',
            'Entrypoint': ['docker-entrypoint.sh'],
...
compose.cli.verbose_proxy.proxy_callable: docker containers <- (all=True, filters={'label': ['com.docker.compose.project=backend-db-test', 'com.docker.compose.service=db', 'com.docker.compose.oneoff=False']})
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/containers/json?limit=-1&all=1&size=0&trunc_cmd=0&filters=%7B%22label%22%3A+%5B%22com.docker.compose.project%3Dbackend-db-test%22%2C+%22com.docker.compose.service%3Ddb%22%2C+%22com.docker.compose.oneoff%3DFalse%22%5D%7D HTTP/1.1" 200 1572
compose.cli.verbose_proxy.proxy_callable: docker containers -> (list with 1 items)
compose.cli.verbose_proxy.proxy_callable: docker inspect_image <- ('mysql:latest')
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/images/mysql:latest/json HTTP/1.1" 200 None
compose.cli.verbose_proxy.proxy_callable: docker inspect_image -> {'Architecture': 'amd64',
 'Author': '',
 'Comment': '',
 'Config': {'ArgsEscaped': True,
            'AttachStderr': False,
            'AttachStdin': False,
            'AttachStdout': False,
            'Cmd': ['mysqld'],
            'Domainname': '',
            'Entrypoint': ['docker-entrypoint.sh'],
...
compose.cli.verbose_proxy.proxy_callable: docker inspect_container <- ('1f6296183499d299609f041dc6dccad6ee3fc027a03f64a8b9b5f25636d69738')
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/containers/1f6296183499d299609f041dc6dccad6ee3fc027a03f64a8b9b5f25636d69738/json HTTP/1.1" 200 None
compose.cli.verbose_proxy.proxy_callable: docker inspect_container -> {'AppArmorProfile': '',
 'Args': ['--character-set-server=utf8',
          '--innodb-flush-method=littlesync',
          '--innodb-use-native-aio=OFF',
          '--log_bin=ON',
          '--skip-innodb-file-per-table'],
 'Config': {'AttachStderr': False,
            'AttachStdin': False,
            'AttachStdout': False,
            'Cmd': ['--character-set-server=utf8',
...
compose.service._containers_have_diverged: 1f6296183499_backend-db-mysql has diverged: c1165d4bccecc6ee29397c5b22b4a054c39c7da457e5348a4e4b072c88ffcf92 != 9523b380ab62ba94094ab258b744f0e8731b7ef353b46dfd02e37c4e570a5f08
compose.parallel.feed_queue: Pending: {<Service: db>}
compose.parallel.feed_queue: Starting producer thread for <Service: db>
Recreating 1f6296183499_backend-db-mysql ...
compose.parallel.feed_queue: Pending: {<Container: 1f6296183499_backend-db-mysql (1f6296)>}
compose.parallel.feed_queue: Starting producer thread for <Container: 1f6296183499_backend-db-mysql (1f6296)>
compose.cli.verbose_proxy.proxy_callable: docker stop <- ('1f6296183499d299609f041dc6dccad6ee3fc027a03f64a8b9b5f25636d69738', timeout=10)
urllib3.connectionpool._make_request: http://localhost:None "POST /v1.38/containers/1f6296183499d299609f041dc6dccad6ee3fc027a03f64a8b9b5f25636d69738/stop?t=10 HTTP/1.1" 304 0
compose.cli.verbose_proxy.proxy_callable: docker stop -> None
compose.cli.verbose_proxy.proxy_callable: docker inspect_image <- ('mysql:latest')
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/images/mysql:latest/json HTTP/1.1" 200 None
compose.cli.verbose_proxy.proxy_callable: docker inspect_image -> {'Architecture': 'amd64',
 'Author': '',
 'Comment': '',
 'Config': {'ArgsEscaped': True,
            'AttachStderr': False,
            'AttachStdin': False,
            'AttachStdout': False,
            'Cmd': ['mysqld'],
            'Domainname': '',
            'Entrypoint': ['docker-entrypoint.sh'],
...
compose.cli.verbose_proxy.proxy_callable: docker inspect_image <- ('sha256:a77a35a8a140c4ed547209dc0c814cbc85112528bf6058315c7c8efa88fd070e')
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/images/sha256:a77a35a8a140c4ed547209dc0c814cbc85112528bf6058315c7c8efa88fd070e/json HTTP/1.1" 200 None
compose.cli.verbose_proxy.proxy_callable: docker inspect_image -> {'Architecture': 'amd64',
 'Author': '',
 'Comment': '',
 'Config': {'ArgsEscaped': True,
            'AttachStderr': False,
            'AttachStdin': False,
            'AttachStdout': False,
            'Cmd': ['mysqld'],
            'Domainname': '',
            'Entrypoint': ['docker-entrypoint.sh'],
...
compose.cli.verbose_proxy.proxy_callable: docker inspect_image <- ('mysql:latest')
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/images/mysql:latest/json HTTP/1.1" 200 None
compose.cli.verbose_proxy.proxy_callable: docker inspect_image -> {'Architecture': 'amd64',
 'Author': '',
 'Comment': '',
 'Config': {'ArgsEscaped': True,
            'AttachStderr': False,
            'AttachStdin': False,
            'AttachStdout': False,
            'Cmd': ['mysqld'],
            'Domainname': '',
            'Entrypoint': ['docker-entrypoint.sh'],
...
compose.service.build_container_labels: Added config hash: 9523b380ab62ba94094ab258b744f0e8731b7ef353b46dfd02e37c4e570a5f08
compose.cli.verbose_proxy.proxy_callable: docker create_host_config <- (links=[], port_bindings={'3306/tcp': ['3306']}, binds=[], volumes_from=[], privileged=False, network_mode='app', devices=None, dns=None, dns_opt=None, dns_search=None, restart_policy={'Name': 'always', 'MaximumRetryCount': 0}, runtime=None, cap_add=None, cap_drop=None, mem_limit=None, mem_reservation=None, memswap_limit=None, ulimits=None, log_config={'Type': '', 'Config': {}}, extra_hosts=None, read_only=None, pid_mode=None, security_opt=None, ipc_mode=None, cgroup_parent=None, cpu_quota=None, shm_size=None, sysctls=None, pids_limit=None, tmpfs=None, oom_kill_disable=None, oom_score_adj=None, mem_swappiness=None, group_add=None, userns_mode=None, init=None, init_path=None, isolation=None, cpu_count=None, cpu_percent=None, nano_cpus=None, volume_driver=None, cpuset_cpus=None, cpu_shares=None, storage_opt=None, blkio_weight=None, blkio_weight_device=None, device_read_bps=None, device_read_iops=None, device_write_bps=None, device_write_iops=None, mounts=[{'Target': '/var/log/mysql', 'Source': 'D:\\development\\private\\backend-db-test\\backend-db-mysql\\logs', 'Type': 'bind', 'ReadOnly': None}, {'Target': '/var/lib/mysql', 'Source': 'D:\\development\\private\\backend-db-test\\backend-db-mysql\\data', 'Type': 'bind', 'ReadOnly': None}], device_cgroup_rules=None, cpu_period=None, cpu_rt_period=None, cpu_rt_runtime=None)
compose.cli.verbose_proxy.proxy_callable: docker create_host_config -> {'Binds': [],
 'Links': [],
 'LogConfig': {'Config': {}, 'Type': ''},
 'Mounts': [{'ReadOnly': None,
             'Source': 'D:\\development\\private\\backend-db-test\\backend-db-mysql\\logs',
             'Target': '/var/log/mysql',
             'Type': 'bind'},
            {'ReadOnly': None,
             'Source': 'D:\\development\\private\\backend-db-test\\backend-db-mysql\\data',
             'Target': '/var/lib/mysql',
...
compose.cli.verbose_proxy.proxy_callable: docker create_container <- (command='--character-set-server=utf8 --innodb-flush-method=littlesync --innodb-use-native-aio=OFF --log_bin=ON --skip-innodb-file-per-table', environment=['MYSQL_ROOT_PASSWORD=Xq54tGxtZt4MJha'], image='mysql:latest', ports=[('3306', 'tcp'), '3306'], volumes={}, name='backend-db-mysql', detach=True, labels={'com.docker.compose.project': 'backend-db-test', 'com.docker.compose.service': 'db', 'com.docker.compose.oneoff': 'False', 'com.docker.compose.project.working_dir': 'D:\\development\\private\\backend-db-test', 'com.docker.compose.project.config_files': 'docker-compose.yml', 'com.docker.compose.container-number': '1', 'com.docker.compose.version': '1.25.5', 'com.docker.compose.config-hash': '9523b380ab62ba94094ab258b744f0e8731b7ef353b46dfd02e37c4e570a5f08'}, host_config={'NetworkMode': 'app', 'RestartPolicy': {'Name': 'always', 'MaximumRetryCount': 0}, 'VolumesFrom': [], 'Binds': [], 'PortBindings': {'3306/tcp': [{'HostIp': '', 'HostPort': '3306'}]}, 'Links': [], 'LogConfig': {'Type': '', 'Config': {}}, 'Mounts': [{'Target': '/var/log/mysql', 'Source': 'D:\\development\\private\\backend-db-test\\backend-db-mysql\\logs', 'Type': 'bind', 'ReadOnly': None}, {'Target': '/var/lib/mysql', 'Source': 'D:\\development\\private\\backend-db-test\\backend-db-mysql\\data', 'Type': 'bind', 'ReadOnly': None}]}, networking_config={'EndpointsConfig': {'app': {'Aliases': ['db'], 'IPAMConfig': {}}}})
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
...

Expected result

Successful service start.

If the volumes definition is removed, the service starts, i.e. this yml file:

version: '3.7'

services:
   db:
    image: mysql:latest
    container_name: backend-db-mysql
    ports:
    - "3306:3306"
    expose:
    - '3306'
    environment:
        MYSQL_ROOT_PASSWORD: ${PERSISTENT_DB_ROOT_PWD}
    restart: always
    command: --character-set-server=utf8 --innodb-flush-method=littlesync --innodb-use-native-aio=OFF --log_bin=ON --skip-innodb-file-per-table
    networks:
    - app
       
networks:
  app:
    name: app

Produces the following output:

compose.config.config.find: Using configuration files: .\docker-compose.yml
docker.utils.config.find_config_file: Trying paths: ['C:\\Users\\Donald\\.docker\\config.json', 'C:\\Users\\Donald\\.dockercfg']
docker.utils.config.find_config_file: Found file at path: C:\Users\Donald\.docker\config.json
docker.auth.load_config: Found 'auths' section
docker.auth.parse_auth: Auth data for https://index.docker.io/v1/ is absent. Client might be using a credentials store instead.
docker.auth.load_config: Found 'credsStore' section
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/version HTTP/1.1" 200 853
compose.cli.command.get_client: docker-compose version 1.25.5, build 8a1c60f6
docker-py version: 4.1.0
CPython version: 3.7.4
OpenSSL version: OpenSSL 1.1.1c  28 May 2019
compose.cli.command.get_client: Docker base_url: http+docker://localnpipe
compose.cli.command.get_client: Docker version: Platform={'Name': 'Docker Engine - Community'}, Components=[{'Name': 'Engine', 'Version': '19.03.8', 'Details': {'ApiVersion': '1.40', 'Arch': 'amd64', 'BuildTime': '2020-03-11T01:29:16.000000000+00:00', 'Experimental': 'false', 'GitCommit': 'afacb8b', 'GoVersion': 'go1.12.17', 'KernelVersion': '4.19.76-linuxkit', 'MinAPIVersion': '1.12', 'Os': 'linux'}}, {'Name': 'containerd', 'Version': 'v1.2.13', 'Details': {'GitCommit': '7ad184331fa3e55e52b890ea95e65ba581ae3429'}}, {'Name': 'runc', 'Version': '1.0.0-rc10', 'Details': {'GitCommit': 'dc9208a3303feef5b3839f4323d9beb36df0a9dd'}}, {'Name': 'docker-init', 'Version': '0.18.0', 'Details': {'GitCommit': 'fec3683'}}], Version=19.03.8, ApiVersion=1.40, MinAPIVersion=1.12, GitCommit=afacb8b, GoVersion=go1.12.17, Os=linux, Arch=amd64, KernelVersion=4.19.76-linuxkit, BuildTime=2020-03-11T01:29:16.000000000+00:00
compose.cli.verbose_proxy.proxy_callable: docker inspect_network <- ('app')
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/networks/app HTTP/1.1" 200 540
compose.cli.verbose_proxy.proxy_callable: docker inspect_network -> {'Attachable': True,
 'ConfigFrom': {'Network': ''},
 'ConfigOnly': False,
 'Containers': {},
 'Created': '2020-07-01T15:33:52.097459378Z',
 'Driver': 'bridge',
 'EnableIPv6': False,
 'IPAM': {'Config': [{'Gateway': '172.18.0.1', 'Subnet': '172.18.0.0/16'}],
          'Driver': 'default',
          'Options': None},
...
compose.cli.verbose_proxy.proxy_callable: docker info <- ()
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/info HTTP/1.1" 200 None
compose.cli.verbose_proxy.proxy_callable: docker info -> {'Architecture': 'x86_64',
 'BridgeNfIp6tables': True,
 'BridgeNfIptables': True,
 'CPUSet': True,
 'CPUShares': True,
 'CgroupDriver': 'cgroupfs',
 'ClusterAdvertise': '',
 'ClusterStore': '',
 'ContainerdCommit': {'Expected': '7ad184331fa3e55e52b890ea95e65ba581ae3429',
                      'ID': '7ad184331fa3e55e52b890ea95e65ba581ae3429'},
...
compose.cli.verbose_proxy.proxy_callable: docker inspect_network <- ('app')
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/networks/app HTTP/1.1" 200 540
compose.cli.verbose_proxy.proxy_callable: docker inspect_network -> {'Attachable': True,
 'ConfigFrom': {'Network': ''},
 'ConfigOnly': False,
 'Containers': {},
 'Created': '2020-07-01T15:33:52.097459378Z',
 'Driver': 'bridge',
 'EnableIPv6': False,
 'IPAM': {'Config': [{'Gateway': '172.18.0.1', 'Subnet': '172.18.0.0/16'}],
          'Driver': 'default',
          'Options': None},
...
compose.cli.verbose_proxy.proxy_callable: docker containers <- (all=False, filters={'label': ['com.docker.compose.project=backend-db-test', 'com.docker.compose.oneoff=False']})
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/containers/json?limit=-1&all=0&size=0&trunc_cmd=0&filters=%7B%22label%22%3A+%5B%22com.docker.compose.project%3Dbackend-db-test%22%2C+%22com.docker.compose.oneoff%3DFalse%22%5D%7D HTTP/1.1" 200 3
compose.cli.verbose_proxy.proxy_callable: docker containers -> (list with 0 items)
compose.cli.verbose_proxy.proxy_callable: docker containers <- (all=False, filters={'label': ['com.docker.compose.project=backenddbtest', 'com.docker.compose.oneoff=False']})
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/containers/json?limit=-1&all=0&size=0&trunc_cmd=0&filters=%7B%22label%22%3A+%5B%22com.docker.compose.project%3Dbackenddbtest%22%2C+%22com.docker.compose.oneoff%3DFalse%22%5D%7D HTTP/1.1" 200 3
compose.cli.verbose_proxy.proxy_callable: docker containers -> (list with 0 items)
compose.cli.verbose_proxy.proxy_callable: docker containers <- (all=True, filters={'label': ['com.docker.compose.project=backend-db-test', 'com.docker.compose.oneoff=False']})
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/containers/json?limit=-1&all=1&size=0&trunc_cmd=0&filters=%7B%22label%22%3A+%5B%22com.docker.compose.project%3Dbackend-db-test%22%2C+%22com.docker.compose.oneoff%3DFalse%22%5D%7D HTTP/1.1" 200 1572
compose.cli.verbose_proxy.proxy_callable: docker containers -> (list with 1 items)
compose.cli.verbose_proxy.proxy_callable: docker inspect_container <- ('1f6296183499d299609f041dc6dccad6ee3fc027a03f64a8b9b5f25636d69738')
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/containers/1f6296183499d299609f041dc6dccad6ee3fc027a03f64a8b9b5f25636d69738/json HTTP/1.1" 200 None
compose.cli.verbose_proxy.proxy_callable: docker inspect_container -> {'AppArmorProfile': '',
 'Args': ['--character-set-server=utf8',
          '--innodb-flush-method=littlesync',
          '--innodb-use-native-aio=OFF',
          '--log_bin=ON',
          '--skip-innodb-file-per-table'],
 'Config': {'AttachStderr': False,
            'AttachStdin': False,
            'AttachStdout': False,
            'Cmd': ['--character-set-server=utf8',
...
compose.cli.verbose_proxy.proxy_callable: docker containers <- (all=True, filters={'label': ['com.docker.compose.project=backend-db-test', 'com.docker.compose.service=db', 'com.docker.compose.oneoff=False']})
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/containers/json?limit=-1&all=1&size=0&trunc_cmd=0&filters=%7B%22label%22%3A+%5B%22com.docker.compose.project%3Dbackend-db-test%22%2C+%22com.docker.compose.service%3Ddb%22%2C+%22com.docker.compose.oneoff%3DFalse%22%5D%7D HTTP/1.1" 200 1572
compose.cli.verbose_proxy.proxy_callable: docker containers -> (list with 1 items)
compose.cli.verbose_proxy.proxy_callable: docker inspect_container <- ('1f6296183499d299609f041dc6dccad6ee3fc027a03f64a8b9b5f25636d69738')
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/containers/1f6296183499d299609f041dc6dccad6ee3fc027a03f64a8b9b5f25636d69738/json HTTP/1.1" 200 None
compose.cli.verbose_proxy.proxy_callable: docker inspect_container -> {'AppArmorProfile': '',
 'Args': ['--character-set-server=utf8',
          '--innodb-flush-method=littlesync',
          '--innodb-use-native-aio=OFF',
          '--log_bin=ON',
          '--skip-innodb-file-per-table'],
 'Config': {'AttachStderr': False,
            'AttachStdin': False,
            'AttachStdout': False,
            'Cmd': ['--character-set-server=utf8',
...
compose.cli.verbose_proxy.proxy_callable: docker inspect_image <- ('mysql:latest')
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/images/mysql:latest/json HTTP/1.1" 200 None
compose.cli.verbose_proxy.proxy_callable: docker inspect_image -> {'Architecture': 'amd64',
 'Author': '',
 'Comment': '',
 'Config': {'ArgsEscaped': True,
            'AttachStderr': False,
            'AttachStdin': False,
            'AttachStdout': False,
            'Cmd': ['mysqld'],
            'Domainname': '',
            'Entrypoint': ['docker-entrypoint.sh'],
...
compose.cli.verbose_proxy.proxy_callable: docker containers <- (all=True, filters={'label': ['com.docker.compose.project=backend-db-test', 'com.docker.compose.service=db', 'com.docker.compose.oneoff=False']})
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/containers/json?limit=-1&all=1&size=0&trunc_cmd=0&filters=%7B%22label%22%3A+%5B%22com.docker.compose.project%3Dbackend-db-test%22%2C+%22com.docker.compose.service%3Ddb%22%2C+%22com.docker.compose.oneoff%3DFalse%22%5D%7D HTTP/1.1" 200 1572
compose.cli.verbose_proxy.proxy_callable: docker containers -> (list with 1 items)
compose.cli.verbose_proxy.proxy_callable: docker inspect_image <- ('mysql:latest')
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/images/mysql:latest/json HTTP/1.1" 200 None
compose.cli.verbose_proxy.proxy_callable: docker inspect_image -> {'Architecture': 'amd64',
 'Author': '',
 'Comment': '',
 'Config': {'ArgsEscaped': True,
            'AttachStderr': False,
            'AttachStdin': False,
            'AttachStdout': False,
            'Cmd': ['mysqld'],
            'Domainname': '',
            'Entrypoint': ['docker-entrypoint.sh'],
...
compose.cli.verbose_proxy.proxy_callable: docker inspect_container <- ('1f6296183499d299609f041dc6dccad6ee3fc027a03f64a8b9b5f25636d69738')
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/containers/1f6296183499d299609f041dc6dccad6ee3fc027a03f64a8b9b5f25636d69738/json HTTP/1.1" 200 None
compose.cli.verbose_proxy.proxy_callable: docker inspect_container -> {'AppArmorProfile': '',
 'Args': ['--character-set-server=utf8',
          '--innodb-flush-method=littlesync',
          '--innodb-use-native-aio=OFF',
          '--log_bin=ON',
          '--skip-innodb-file-per-table'],
 'Config': {'AttachStderr': False,
            'AttachStdin': False,
            'AttachStdout': False,
            'Cmd': ['--character-set-server=utf8',
...
compose.service._containers_have_diverged: 1f6296183499_backend-db-mysql has diverged: c1165d4bccecc6ee29397c5b22b4a054c39c7da457e5348a4e4b072c88ffcf92 != 258d0ef2b49cc54667542c4a87a476fd1457e863bf50178db046193af9def3a9
compose.parallel.feed_queue: Pending: {<Service: db>}
compose.parallel.feed_queue: Starting producer thread for <Service: db>
Recreating 1f6296183499_backend-db-mysql ...
compose.parallel.feed_queue: Pending: {<Container: 1f6296183499_backend-db-mysql (1f6296)>}
compose.parallel.feed_queue: Starting producer thread for <Container: 1f6296183499_backend-db-mysql (1f6296)>
compose.cli.verbose_proxy.proxy_callable: docker stop <- ('1f6296183499d299609f041dc6dccad6ee3fc027a03f64a8b9b5f25636d69738', timeout=10)
urllib3.connectionpool._make_request: http://localhost:None "POST /v1.38/containers/1f6296183499d299609f041dc6dccad6ee3fc027a03f64a8b9b5f25636d69738/stop?t=10 HTTP/1.1" 304 0
compose.cli.verbose_proxy.proxy_callable: docker stop -> None
compose.cli.verbose_proxy.proxy_callable: docker inspect_image <- ('mysql:latest')
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/images/mysql:latest/json HTTP/1.1" 200 None
compose.cli.verbose_proxy.proxy_callable: docker inspect_image -> {'Architecture': 'amd64',
 'Author': '',
 'Comment': '',
 'Config': {'ArgsEscaped': True,
            'AttachStderr': False,
            'AttachStdin': False,
            'AttachStdout': False,
            'Cmd': ['mysqld'],
            'Domainname': '',
            'Entrypoint': ['docker-entrypoint.sh'],
...
compose.cli.verbose_proxy.proxy_callable: docker inspect_image <- ('sha256:a77a35a8a140c4ed547209dc0c814cbc85112528bf6058315c7c8efa88fd070e')
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/images/sha256:a77a35a8a140c4ed547209dc0c814cbc85112528bf6058315c7c8efa88fd070e/json HTTP/1.1" 200 None
compose.cli.verbose_proxy.proxy_callable: docker inspect_image -> {'Architecture': 'amd64',
 'Author': '',
 'Comment': '',
 'Config': {'ArgsEscaped': True,
            'AttachStderr': False,
            'AttachStdin': False,
            'AttachStdout': False,
            'Cmd': ['mysqld'],
            'Domainname': '',
            'Entrypoint': ['docker-entrypoint.sh'],
...
compose.cli.verbose_proxy.proxy_callable: docker inspect_image <- ('mysql:latest')
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/images/mysql:latest/json HTTP/1.1" 200 None
compose.cli.verbose_proxy.proxy_callable: docker inspect_image -> {'Architecture': 'amd64',
 'Author': '',
 'Comment': '',
 'Config': {'ArgsEscaped': True,
            'AttachStderr': False,
            'AttachStdin': False,
            'AttachStdout': False,
            'Cmd': ['mysqld'],
            'Domainname': '',
            'Entrypoint': ['docker-entrypoint.sh'],
...
compose.service.build_container_labels: Added config hash: 258d0ef2b49cc54667542c4a87a476fd1457e863bf50178db046193af9def3a9
compose.cli.verbose_proxy.proxy_callable: docker create_host_config <- (links=[], port_bindings={'3306/tcp': ['3306']}, binds=['backend-db-test_db_data:/var/lib/mysql:rw'], volumes_from=[], privileged=False, network_mode='app', devices=None, dns=None, dns_opt=None, dns_search=None, restart_policy={'Name': 'always', 'MaximumRetryCount': 0}, runtime=None, cap_add=None, cap_drop=None, mem_limit=None, mem_reservation=None, memswap_limit=None, ulimits=None, log_config={'Type': '', 'Config': {}}, extra_hosts=None, read_only=None, pid_mode=None, security_opt=None, ipc_mode=None, cgroup_parent=None, cpu_quota=None, shm_size=None, sysctls=None, pids_limit=None, tmpfs=None, oom_kill_disable=None, oom_score_adj=None, mem_swappiness=None, group_add=None, userns_mode=None, init=None, init_path=None, isolation=None, cpu_count=None, cpu_percent=None, nano_cpus=None, volume_driver=None, cpuset_cpus=None, cpu_shares=None, storage_opt=None, blkio_weight=None, blkio_weight_device=None, device_read_bps=None, device_read_iops=None, device_write_bps=None, device_write_iops=None, mounts=None, device_cgroup_rules=None, cpu_period=None, cpu_rt_period=None, cpu_rt_runtime=None)
compose.cli.verbose_proxy.proxy_callable: docker create_host_config -> {'Binds': ['backend-db-test_db_data:/var/lib/mysql:rw'],
 'Links': [],
 'LogConfig': {'Config': {}, 'Type': ''},
 'NetworkMode': 'app',
 'PortBindings': {'3306/tcp': [{'HostIp': '', 'HostPort': '3306'}]},
 'RestartPolicy': {'MaximumRetryCount': 0, 'Name': 'always'},
 'VolumesFrom': []}
compose.cli.verbose_proxy.proxy_callable: docker create_container <- (command='--character-set-server=utf8 --innodb-flush-method=littlesync --innodb-use-native-aio=OFF --log_bin=ON --skip-innodb-file-per-table', environment=['MYSQL_ROOT_PASSWORD=Xq54tGxtZt4MJha', 'affinity:container==1f6296183499d299609f041dc6dccad6ee3fc027a03f64a8b9b5f25636d69738'], image='mysql:latest', ports=[('3306', 'tcp'), '3306'], volumes={}, name='backend-db-mysql', detach=True, labels={'com.docker.compose.project': 'backend-db-test', 'com.docker.compose.service': 'db', 'com.docker.compose.oneoff': 'False', 'com.docker.compose.project.working_dir': 'D:\\development\\private\\backend-db-test', 'com.docker.compose.project.config_files': 'docker-compose.yml', 'com.docker.compose.container-number': '1', 'com.docker.compose.version': '1.25.5', 'com.docker.compose.config-hash': '258d0ef2b49cc54667542c4a87a476fd1457e863bf50178db046193af9def3a9'}, host_config={'NetworkMode': 'app', 'RestartPolicy': {'Name': 'always', 'MaximumRetryCount': 0}, 'VolumesFrom': [], 'Binds': ['backend-db-test_db_data:/var/lib/mysql:rw'], 'PortBindings': {'3306/tcp': [{'HostIp': '', 'HostPort': '3306'}]}, 'Links': [], 'LogConfig': {'Type': '', 'Config': {}}}, networking_config={'EndpointsConfig': {'app': {'Aliases': ['db'], 'IPAMConfig': {}}}})
urllib3.connectionpool._make_request: http://localhost:None "POST /v1.38/containers/create?name=backend-db-mysql HTTP/1.1" 201 88
compose.cli.verbose_proxy.proxy_callable: docker create_container -> {'Id': '43bbbebb61cd99025df65565179181607b3cf3815eaec774ec5dc9e6dbedd93d',
 'Warnings': []}
compose.cli.verbose_proxy.proxy_callable: docker inspect_container <- ('43bbbebb61cd99025df65565179181607b3cf3815eaec774ec5dc9e6dbedd93d')
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/containers/43bbbebb61cd99025df65565179181607b3cf3815eaec774ec5dc9e6dbedd93d/json HTTP/1.1" 200 None
compose.cli.verbose_proxy.proxy_callable: docker inspect_container -> {'AppArmorProfile': '',
 'Args': ['--character-set-server=utf8',
          '--innodb-flush-method=littlesync',
          '--innodb-use-native-aio=OFF',
          '--log_bin=ON',
          '--skip-innodb-file-per-table'],
 'Config': {'AttachStderr': False,
            'AttachStdin': False,
            'AttachStdout': False,
            'Cmd': ['--character-set-server=utf8',
...
compose.cli.verbose_proxy.proxy_callable: docker attach <- ('43bbbebb61cd99025df65565179181607b3cf3815eaec774ec5dc9e6dbedd93d', stdout=True, stderr=True, stream=True)
urllib3.connectionpool._make_request: http://localhost:None "POST /v1.38/containers/43bbbebb61cd99025df65565179181607b3cf3815eaec774ec5dc9e6dbedd93d/attach?logs=0&stdout=1&stderr=1&stream=1 HTTP/1.1" 101 0
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/containers/43bbbebb61cd99025df65565179181607b3cf3815eaec774ec5dc9e6dbedd93d/json HTTP/1.1" 200 None
compose.cli.verbose_proxy.proxy_callable: docker attach -> <docker.types.daemon.CancellableStream object at 0x000001AD5B424F08>
compose.cli.verbose_proxy.proxy_callable: docker disconnect_container_from_network <- ('43bbbebb61cd99025df65565179181607b3cf3815eaec774ec5dc9e6dbedd93d', 'app')
urllib3.connectionpool._make_request: http://localhost:None "POST /v1.38/networks/app/disconnect HTTP/1.1" 200 0
compose.cli.verbose_proxy.proxy_callable: docker disconnect_container_from_network -> None
compose.cli.verbose_proxy.proxy_callable: docker connect_container_to_network <- ('43bbbebb61cd99025df65565179181607b3cf3815eaec774ec5dc9e6dbedd93d', 'app', aliases=['db', '43bbbebb61cd'], ipv4_address=None, ipv6_address=None, links=[], link_local_ips=None)
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
urllib3.connectionpool._make_request: http://localhost:None "POST /v1.38/networks/app/connect HTTP/1.1" 200 0
compose.cli.verbose_proxy.proxy_callable: docker connect_container_to_network -> None
compose.cli.verbose_proxy.proxy_callable: docker start <- ('43bbbebb61cd99025df65565179181607b3cf3815eaec774ec5dc9e6dbedd93d')
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
compose.parallel.feed_queue: Pending: set()
urllib3.connectionpool._make_request: http://localhost:None "POST /v1.38/containers/43bbbebb61cd99025df65565179181607b3cf3815eaec774ec5dc9e6dbedd93d/start HTTP/1.1" 204 0
compose.cli.verbose_proxy.proxy_callable: docker start -> None
compose.cli.verbose_proxy.proxy_callable: docker remove_container <- ('1f6296183499d299609f041dc6dccad6ee3fc027a03f64a8b9b5f25636d69738')
urllib3.connectionpool._make_request: http://localhost:None "DELETE /v1.38/containers/1f6296183499d299609f041dc6dccad6ee3fc027a03f64a8b9b5f25636d69738?v=False&link=False&force=False HTTP/1.1" 204 0
compose.cli.verbose_proxy.proxy_callable: docker remove_container -> None
Recreating 1f6296183499_backend-db-mysql ... done
compose.parallel.feed_queue: Pending: set()
compose.parallel.parallel_execute_iter: Finished processing: <Service: db>
compose.parallel.feed_queue: Pending: set()
compose.cli.verbose_proxy.proxy_callable: docker events <- (filters={'label': ['com.docker.compose.project=backend-db-test', 'com.docker.compose.oneoff=False']}, decode=True)
Attaching to backend-db-mysql
backend-db-mysql | 2020-07-01 16:02:18+00:00 [Note] [Entrypoint]: Entrypoint script for MySQL Server 8.0.20-1debian10 started.
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/events?filters=%7B%22label%22%3A+%5B%22com.docker.compose.project%3Dbackend-db-test%22%2C+%22com.docker.compose.oneoff%3DFalse%22%5D%7D HTTP/1.1" 200 None
compose.cli.verbose_proxy.proxy_callable: docker events -> <docker.types.daemon.CancellableStream object at 0x000001AD5B3FEC48>
backend-db-mysql | 2020-07-01 16:02:18+00:00 [Note] [Entrypoint]: Switching to dedicated user 'mysql'
backend-db-mysql | 2020-07-01 16:02:18+00:00 [Note] [Entrypoint]: Entrypoint script for MySQL Server 8.0.20-1debian10 started.
backend-db-mysql | 2020-07-01T16:02:19.059185Z 0 [Warning] [MY-011070] [Server] 'Disabling symbolic links using --skip-symbolic-links (or equivalent) is the default. Consider not using this option as it' is deprecated and will be removed in a future release.
backend-db-mysql | 2020-07-01T16:02:19.059298Z 0 [System] [MY-010116] [Server] /usr/sbin/mysqld (mysqld 8.0.20) starting as process 1
backend-db-mysql | 2020-07-01T16:02:19.062102Z 0 [Warning] [MY-013242] [Server] --character-set-server: 'utf8' is currently an alias for the character set UTF8MB3, but will be an alias for UTF8MB4 in a future release. Please consider using UTF8MB4 in order to be unambiguous.
backend-db-mysql | 2020-07-01T16:02:19.068964Z 1 [System] [MY-013576] [InnoDB] InnoDB initialization has started.
backend-db-mysql | 2020-07-01T16:02:19.284476Z 1 [System] [MY-013577] [InnoDB] InnoDB initialization has ended.
backend-db-mysql | 2020-07-01T16:02:19.371873Z 0 [System] [MY-011323] [Server] X Plugin ready for connections. Socket: '/var/run/mysqld/mysqlx.sock' bind-address: '::' port: 33060
backend-db-mysql | 2020-07-01T16:02:19.428858Z 0 [Warning] [MY-010068] [Server] CA certificate ca.pem is self signed.
backend-db-mysql | 2020-07-01T16:02:19.432637Z 0 [Warning] [MY-011810] [Server] Insecure configuration for --pid-file: Location '/var/run/mysqld' in the path is accessible to all OS users. Consider choosing a different directory.
backend-db-mysql | 2020-07-01T16:02:19.446559Z 0 [System] [MY-010931] [Server] /usr/sbin/mysqld: ready for connections. Version: '8.0.20'  socket: '/var/run/mysqld/mysqld.sock'  port: 3306  MySQL Community Server - GPL.

Stacktrace / full error message

See observed result

Alternatively, I have tried the following:

docker-compose --verbose build && docker-compose --verbose start db

Which gives the following output:

compose.config.config.find: Using configuration files: .\docker-compose.yml
docker.utils.config.find_config_file: Trying paths: ['C:\\Users\\Donald\\.docker\\config.json', 'C:\\Users\\Donald\\.dockercfg']
docker.utils.config.find_config_file: Found file at path: C:\Users\Donald\.docker\config.json
docker.auth.load_config: Found 'auths' section
docker.auth.parse_auth: Auth data for https://index.docker.io/v1/ is absent. Client might be using a credentials store instead.
docker.auth.load_config: Found 'credsStore' section
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/version HTTP/1.1" 200 853
compose.cli.command.get_client: docker-compose version 1.25.5, build 8a1c60f6
docker-py version: 4.1.0
CPython version: 3.7.4
OpenSSL version: OpenSSL 1.1.1c  28 May 2019
compose.cli.command.get_client: Docker base_url: http+docker://localnpipe
compose.cli.command.get_client: Docker version: Platform={'Name': 'Docker Engine - Community'}, Components=[{'Name': 'Engine', 'Version': '19.03.8', 'Details': {'ApiVersion': '1.40', 'Arch': 'amd64', 'BuildTime': '2020-03-11T01:29:16.000000000+00:00', 'Experimental': 'false', 'GitCommit': 'afacb8b', 'GoVersion': 'go1.12.17', 'KernelVersion': '4.19.76-linuxkit', 'MinAPIVersion': '1.12', 'Os': 'linux'}}, {'Name': 'containerd', 'Version': 'v1.2.13', 'Details': {'GitCommit': '7ad184331fa3e55e52b890ea95e65ba581ae3429'}}, {'Name': 'runc', 'Version': '1.0.0-rc10', 'Details': {'GitCommit': 'dc9208a3303feef5b3839f4323d9beb36df0a9dd'}}, {'Name': 'docker-init', 'Version': '0.18.0', 'Details': {'GitCommit': 'fec3683'}}], Version=19.03.8, ApiVersion=1.40, MinAPIVersion=1.12, GitCommit=afacb8b, GoVersion=go1.12.17, Os=linux, Arch=amd64, KernelVersion=4.19.76-linuxkit, BuildTime=2020-03-11T01:29:16.000000000+00:00
compose.cli.verbose_proxy.proxy_callable: docker inspect_network <- ('app')
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/networks/app HTTP/1.1" 200 540
compose.cli.verbose_proxy.proxy_callable: docker inspect_network -> {'Attachable': True,
 'ConfigFrom': {'Network': ''},
 'ConfigOnly': False,
 'Containers': {},
 'Created': '2020-07-01T15:33:52.097459378Z',
 'Driver': 'bridge',
 'EnableIPv6': False,
 'IPAM': {'Config': [{'Gateway': '172.18.0.1', 'Subnet': '172.18.0.0/16'}],
          'Driver': 'default',
          'Options': None},
...
compose.project.build: db uses an image, skipping
compose.config.config.find: Using configuration files: .\docker-compose.yml
docker.utils.config.find_config_file: Trying paths: ['C:\\Users\\Donald\\.docker\\config.json', 'C:\\Users\\Donald\\.dockercfg']
docker.utils.config.find_config_file: Found file at path: C:\Users\Donald\.docker\config.json
docker.auth.load_config: Found 'auths' section
docker.auth.parse_auth: Auth data for https://index.docker.io/v1/ is absent. Client might be using a credentials store instead.
docker.auth.load_config: Found 'credsStore' section
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/version HTTP/1.1" 200 853
compose.cli.command.get_client: docker-compose version 1.25.5, build 8a1c60f6
docker-py version: 4.1.0
CPython version: 3.7.4
OpenSSL version: OpenSSL 1.1.1c  28 May 2019
compose.cli.command.get_client: Docker base_url: http+docker://localnpipe
compose.cli.command.get_client: Docker version: Platform={'Name': 'Docker Engine - Community'}, Components=[{'Name': 'Engine', 'Version': '19.03.8', 'Details': {'ApiVersion': '1.40', 'Arch': 'amd64', 'BuildTime': '2020-03-11T01:29:16.000000000+00:00', 'Experimental': 'false', 'GitCommit': 'afacb8b', 'GoVersion': 'go1.12.17', 'KernelVersion': '4.19.76-linuxkit', 'MinAPIVersion': '1.12', 'Os': 'linux'}}, {'Name': 'containerd', 'Version': 'v1.2.13', 'Details': {'GitCommit': '7ad184331fa3e55e52b890ea95e65ba581ae3429'}}, {'Name': 'runc', 'Version': '1.0.0-rc10', 'Details': {'GitCommit': 'dc9208a3303feef5b3839f4323d9beb36df0a9dd'}}, {'Name': 'docker-init', 'Version': '0.18.0', 'Details': {'GitCommit': 'fec3683'}}], Version=19.03.8, ApiVersion=1.40, MinAPIVersion=1.12, GitCommit=afacb8b, GoVersion=go1.12.17, Os=linux, Arch=amd64, KernelVersion=4.19.76-linuxkit, BuildTime=2020-03-11T01:29:16.000000000+00:00
compose.cli.verbose_proxy.proxy_callable: docker inspect_network <- ('app')
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/networks/app HTTP/1.1" 200 540
compose.cli.verbose_proxy.proxy_callable: docker inspect_network -> {'Attachable': True,
 'ConfigFrom': {'Network': ''},
 'ConfigOnly': False,
 'Containers': {},
 'Created': '2020-07-01T15:33:52.097459378Z',
 'Driver': 'bridge',
 'EnableIPv6': False,
 'IPAM': {'Config': [{'Gateway': '172.18.0.1', 'Subnet': '172.18.0.0/16'}],
          'Driver': 'default',
          'Options': None},
...
Starting db ...
compose.parallel.feed_queue: Pending: {<Service: db>}
compose.parallel.feed_queue: Starting producer thread for <Service: db>
compose.cli.verbose_proxy.proxy_callable: docker containers <- (all=True, filters={'label': ['com.docker.compose.project=backend-db-test', 'com.docker.compose.service=db', 'com.docker.compose.oneoff=False']})
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/containers/json?limit=-1&all=1&size=0&trunc_cmd=0&filters=%7B%22label%22%3A+%5B%22com.docker.compose.project%3Dbackend-db-test%22%2C+%22com.docker.compose.service%3Ddb%22%2C+%22com.docker.compose.oneoff%3DFalse%22%5D%7D HTTP/1.1" 200 3
compose.cli.verbose_proxy.proxy_callable: docker containers -> (list with 0 items)
compose.cli.verbose_proxy.proxy_callable: docker containers <- (all=True, filters={'label': ['com.docker.compose.project=backenddbtest', 'com.docker.compose.service=db', 'com.docker.compose.oneoff=False']})
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/containers/json?limit=-1&all=1&size=0&trunc_cmd=0&filters=%7B%22label%22%3A+%5B%22com.docker.compose.project%3Dbackenddbtest%22%2C+%22com.docker.compose.service%3Ddb%22%2C+%22com.docker.compose.oneoff%3DFalse%22%5D%7D HTTP/1.1" 200 3
compose.cli.verbose_proxy.proxy_callable: docker containers -> (list with 0 items)
compose.parallel.parallel_execute_iter: Finished processing: <Service: db>
compose.cli.verbose_proxy.proxy_callable: docker containers <- (all=False, filters={'label': ['com.docker.compose.project=backend-db-test', 'com.docker.compose.service=db', 'com.docker.compose.oneoff=False']})
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/containers/json?limit=-1&all=0&size=0&trunc_cmd=0&filters=%7B%22label%22%3A+%5B%22com.docker.compose.project%3Dbackend-db-test%22%2C+%22com.docker.compose.service%3Ddb%22%2C+%22com.docker.compose.oneoff%3DFalse%22%5D%7D HTTP/1.1" 200 3
compose.cli.verbose_proxy.proxy_callable: docker containers -> (list with 0 items)
compose.cli.verbose_proxy.proxy_callable: docker containers <- (all=False, filters={'label': ['com.docker.compose.project=backenddbtest', 'com.docker.compose.service=db', 'com.docker.compose.oneoff=False']})
urllib3.connectionpool._make_request: http://localhost:None "GET /v1.38/containers/json?limit=-1&all=0&size=0&trunc_cmd=0&filters=%7B%22label%22%3A+%5B%22com.docker.compose.project%3Dbackenddbtest%22%2C+%22com.docker.compose.service%3Ddb%22%2C+%22com.docker.compose.oneoff%3DFalse%22%5D%7D HTTP/1.1" 200 3
Starting db ... failed
compose.parallel.feed_queue: Pending: set()
compose.cli.main.exit_if: No containers to start

Additional information

OS version / distribution, docker-compose install method, etc.

OS: Windows 10 Docker: standard installation CLI: MINGW64 (from the Git for windows installation)

$ bash --version
GNU bash, version 4.4.23(1)-release (x86_64-pc-msys)
Copyright (C) 2016 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>

This is free software; you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law.

darty avatar Jul 01 '20 16:07 darty

FWIW confirming this from my setup: OS: Ubuntu 18.04 Docker version 19.03.12, build 48a66213fe docker-compose version 1.25.5, build 8a1c60f6

A service in my compose.yml was referencing a (currently) offline mount point, would not allow the container to start with the working volume mounts. Volume commented out, container runs.

gavinc avatar Jul 14 '20 21:07 gavinc

Confirming this on Windows 10 (Docker version 19.03.12, build 48a66213fe).

It is also possible to reproduce this just with a logging option: Remove max-file: 10 and docker-compose -f .\1.yml --verbose up -d will complete,otherwise it is locked in feed_queue empty set forever.

version: "3.4"

services:
  dbx:
    image: postgres:11.7
    # volumes:
    #   - "./dbxdata:/var/lib/postgresql/data"

    logging:
         driver: "json-file"
         options:
           max-file: 10
    environment:
      - POSTGRES_USER=u
      - POSTGRES_PASSWORD=p
    container_name: "db"

angrave avatar Sep 02 '20 22:09 angrave

I have the same problem as @angrave (same version of Docker).

chrischu avatar Sep 22 '20 11:09 chrischu

I just figured out the problem: The max-file value needs to be a string (max-file: "10"). Then it works as expected!

chrischu avatar Sep 22 '20 12:09 chrischu

Original issue does not have a max-file option, so it does not help. After 3 months it would be great to receive some feedback.

darty avatar Sep 22 '20 12:09 darty

Any update on this? The issue still applies to the latest version (Engine: 19.03.13, Compose: 1.27.4) on Windows 10.

AmirrezaNasiri avatar Oct 03 '20 19:10 AmirrezaNasiri

In my case, adding volume sources to "Resources > File Sharing" in Docker Desktop settings solved the issue. Interesting that they weren't added automatically, and the logs were quite misleading.

pending_set_loop

AmirrezaNasiri avatar Oct 03 '20 21:10 AmirrezaNasiri

Also seeing this issue after updating Docker for Mac to v2.5.0. Containers won't start because they are waiting for another container to start? The other container won't start though, because it depends on the one that starts before it.

After downgrading to v2.4.0 my containers are running fine again.

thijskaspers avatar Nov 03 '20 08:11 thijskaspers

I was able to fix this problem by turning off all of the experimental features specifically Use gRPC FUSE for file sharing

was causing the issues

edit: Without gRPC Fuse, the containers couldn't talk to each other. I turned off buildKit in the docker engine and that resolved the issue

qhenkart avatar Nov 11 '20 22:11 qhenkart

Seeing this when trying to start a windows container.

image

alandillon avatar Nov 28 '20 07:11 alandillon

I just had this issue for my Jekyll blog site which I normally bring up using docker-compose with mapped volume to rebuild when I create a new post - it was hanging, tried to run docker-compose up with the --verbose switch and saw the same compose.parallel.feed_queue: Pending: set().

I tried it on my Macbook and it was working fine

I didn't have any experimental features turned on, but I need need to go into (on Windows) settings-> resources -> File Sharing and add the folder I was mapping in my docker compose (the root of my blog site)

Re ran docker compose and its now up and running

Version Info: image

cmjchrisjones avatar Dec 01 '20 23:12 cmjchrisjones

Same issue here, on Windows

using 3.8 for docker compose version (engine: 20.10.2, compose 1.27.4, docker desktop 3.1.0)

andrei-dascalu avatar Feb 10 '21 09:02 andrei-dascalu

I have this issue on Linux as well, running on an aarch64 cpu.

Linux sanguine 5.11.6-1-MANJARO-ARM #1 SMP Thu Mar 11 18:20:41 UTC 2021 aarch64 GNU/Linux
docker-compose version 1.28.5, build unknown
Docker version 20.10.5, build 55c4c88966

Using buildkit or not using buildkit seems to make no difference. It works seemingly unpredictably. Sometimes I get the timeouts, sometimes I don't.

I also have

    devices:
      - /dev/fuse:/dev/fuse

in my compose file, but commenting it out doesn't help.

The only thing that makes it start is commenting out my bind mounts, as the original issue mentions.

EDIT:

Seems like the cultprit was a drive that failed to mount, which was being used in a bind mount. So, I guess the real issue is that it just times out without any useful error message in the case of a bind mount that doesn't exist ( or which can't be mounted for some other reason). In my case it was an external drive that was turned off.

weskerfoot avatar Mar 29 '21 16:03 weskerfoot

Same issue on a ubuntu aws. docker-compose up -d stuck on thsi infinite loop

arayariquelmes avatar Apr 19 '21 16:04 arayariquelmes

Same behavior with

$docker-compose version docker-compose version 1.29.2, build 5becea4c docker-py version: 5.0.0 CPython version: 3.9.0 OpenSSL version: OpenSSL 1.1.1h 22 Sep 2020

mattiaskjellsson avatar Aug 12 '21 09:08 mattiaskjellsson

Guys, I had similar issue and I found out it's due to new "stable" version of docker-compose.

Scenario: In my case, I deploy 140 containers in a single docker-compsoe file on server A. I don't use any volumes. I had version 1.18.0, build 8dd22a9 installed on server A. It is still running perfectly fine. Now, on a new server B, I install docker-compose version 1.29.2, build 5becea4c and for the same docker-compose file used in server A, docker-compose on server B is stuck infinitely. Load average on system was hardly 20% as I am not using cpu/memory eating containers. When I tried to reduce the num of containers to 50, it worked again.

Solution: I simply downgraded to the 1.18.0 version on server B and docker-compose with 140 containers started running fine!

Question: How come a "stable" & latest version of docker-compose not support what it's previous version (11 versions before precisely) was supporting more number of containers ????

neo3matrix avatar Sep 01 '21 18:09 neo3matrix

I have also ran into this. Scenario: windows 10, 20H2, 3 containers with docker-compose + one docker only (no compose) container. Having only the docker-compose containers works. I also have volumes. Seems the problem is often related to volumes, but not always, probably, almost sure, there is a subtle issue that can reproduce with more than one scenario.

danzaharescu avatar Sep 02 '21 09:09 danzaharescu

I was able to address this issue by remove and re-add folders in Preference > Resouces > File Sharing ...

django-wong avatar Sep 04 '21 16:09 django-wong

My Linux Debian will completely freeze up when I arrive in this state... I need to unplug the device to force reboot. I can no longer use docker-compose at the moment.

Depechie avatar Sep 08 '21 20:09 Depechie

I have the same issue. It seems to be related to the volume mounts (which has caused us nothing but trouble on MacOS). The container will come up initially, but after a few restarts, it eventually gets to a state where it just hangs. I have the gRPC Fuse feature disabled. If I remove the volume mount section, the container starts as I would expect.

dhay avatar Sep 22 '21 22:09 dhay

I had the same problem with @dhay, removing volume section did help :man_shrugging:

kidlab avatar Oct 22 '21 05:10 kidlab

Incidentally, clicking "update and restart" on docker fixed this issue for me.

Rambatino avatar Nov 21 '21 09:11 Rambatino

I simply restarted docker for Mac and the problem went away

mhawila avatar Jan 05 '22 11:01 mhawila

The same appears

docker-compose version 1.29.2, build 5becea4c
docker-py version: 5.0.0
CPython version: 3.7.10
OpenSSL version: OpenSSL 1.1.0l  10 Sep 2019

Linux/Focal Fossa-Ubuntu. Faced this issue when number of services running via single Docker-compose became around of 150

nyckyta avatar Jan 27 '22 16:01 nyckyta

This issue has been automatically marked as stale because it has not had recent activity. It will be closed if no further activity occurs. Thank you for your contributions.

stale[bot] avatar Jul 31 '22 02:07 stale[bot]

This issue has been automatically closed because it had not recent activity during the stale period.

stale[bot] avatar Nov 02 '22 05:11 stale[bot]

This issue has been automatically closed because it had not recent activity during the stale period.

stale[bot] avatar Nov 12 '22 12:11 stale[bot]

I found myself in this situation connecting to another Mac on my network via SSH and running Docker commands. As a result, the host Mac had a dialog created because I added a new volume thus the host Mac had prompted me for access to the Downloads folder. The solution was to physically logon to the host Mac and click to approve the permissions.

ryanrodemoyer avatar Jun 17 '23 17:06 ryanrodemoyer