Uploaded image for project: 'Modules'
  1. Modules
  2. MODULES-5153

puppetlabs-chocolatey: Failure waiting for PowerShell process xxxx to start pipe server

    XMLWordPrintable

    Details

    • Type: Bug
    • Status: Resolved
    • Priority: Critical
    • Resolution: Fixed
    • Affects Version/s: None
    • Fix Version/s: None
    • Component/s: chocolatey , powershell
    • Environment:
      • Puppet 4.8
      • Puppet Agent 1.10.1
      • Windows Server 2016
      • puppetlabs-chocolatey, 3.0.0
    • Template:
      MODULES Bug Template
    • Team:
      Modules
    • Zendesk Ticket IDs:
      42332
    • Zendesk Ticket Count:
      1

      Description

      Hello together,

      after applying a Windows Server 2016 node to host group, the puppet agent fails always on the first run while installing chocolatey.
      This is what my monitoring log said:

      Failure waiting for PowerShell process 3232 to start pipe server
      change from notrun to 0 failed: Failure waiting for PowerShell process 3232 to start pipe server

      This always happen if i apply only chocolatey module or chocolatey and some modules who install firefox, chrome, etc. over chocolatey. On my big Deployment Processes where i have about hundret puppet modules, it seems to work, but i think this is just a false conclusion because i dont know what puppet is doing in the background that this failure is maybe just skipped. Whatever. The apply of only chocolatey fail (but only on the first run, if a prompt puppet agent --test again, it works ...).

      Maybe it comes from the latest windows updates, because on the day where we update our servers, it does not work anymore. To be sure its not a failure on my side, i have create new Windows Templates for provisioning, restore, my Puppetmaster from last week, reinstall the puppet chocolatey provider, ... so this is the only thing left i can guessing.

      Here the run from a fresh puppet installation after assigning the certificates and assigning to the hostgroup:

      Debug: Dynamically-bound server lookup failed, falling back to server setting
      Debug: Dynamically-bound port lookup failed; falling back to masterport setting
      Debug: Failed to load library 'msgpack' for feature 'msgpack'
      Debug: Puppet::Network::Format[msgpack]: feature msgpack is missing
      Debug: catalog supports formats: pson yaml dot binary
      Debug: Closing connection for https://puppetmaster01.xxx.de:8140
      Debug: Creating new connection for https://puppetmaster01.xxx.de:8140
      Debug: Starting connection for https://puppetmaster01.xxx.de:8140
      Debug: Caching connection for https://puppetmaster01.xxx.de:8140
      Info: Caching catalog for agentanalysis.xxx.de
      Debug: Puppet::Type::Exec::ProviderPosix: feature posix is missing
      Debug: Puppet::Type::Exec::ProviderShell: feature posix is missing
      Debug: /Package[firefox]: Provider chocolatey does not support features virtual_packages; not managing attribute allow_virtual
      Debug: /Package[googlechrome]: Provider chocolatey does not support features virtual_packages; not managing attribute allow_virtual
      Debug: Creating default schedules
      Debug: Loaded state in 0.06 seconds
      Debug: Loaded transaction store file in 0.00 seconds
      Info: Applying configuration version '1498727398'
      Debug: /Stage[main]/Chocolatey::Install/before: subscribes to Class[Chocolatey::Config]
      Debug: /Stage[main]/Chocolatey::Install/Exec[install_chocolatey_official]/require: subscribes to Registry_value[ChocolateyInstall environment value]
      Debug: Checking the existence of registry value: Registry_value[ChocolateyInstall environment value](provider=registry)
      Debug: Creating registry value: Registry_value[ChocolateyInstall environment value](provider=registry)
      Notice: /Stage[main]/Chocolatey::Install/Registry_value[ChocolateyInstall environment value]/ensure: created
      Debug: Flushing registry value: Registry_value[ChocolateyInstall environment value](provider=registry)
      Debug: /Stage[main]/Chocolatey::Install/Registry_value[ChocolateyInstall environment value]: The container Class[Chocolatey::Install] will propagate my refresh event
      Debug: 2017-06-29 11:09:59 +0200 C:\Windows\system32\WindowsPowershell\v1.0\powershell.exe -NoProfile -NonInteractive -NoLogo -ExecutionPolicy Bypass is running as pid: 3192
      Error: Failure waiting for PowerShell process 3192 to start pipe server
      Error: /Stage[main]/Chocolatey::Install/Exec[install_chocolatey_official]/returns: change from notrun to 0 failed: Failure waiting for PowerShell process 3192 to start pipe server
      Debug: Class[Chocolatey::Install]: Resource is being skipped, unscheduling all events
      Info: Class[Chocolatey::Install]: Unscheduling all events on Class[Chocolatey::Install]
      Debug: Class[Chocolatey::Config]: Resource is being skipped, unscheduling all events
      Debug: Class[Chocolatey::Config]: Resource is being skipped, unscheduling all events
      Debug: Class[Chocolatey]: Resource is being skipped, unscheduling all events
      Debug: Puppet::Type::Package::ProviderChocolatey: file C:\ProgramData\chocolatey\choco.exe does not exist
      Debug: Puppet::Type::Package::ProviderChocolatey: file C:\ProgramData\chocolatey\choco.exe does not exist
      Debug: Puppet::Type::Package::ProviderChocolatey: file C:\ProgramData\chocolatey\choco.exe does not exist
      Debug: Puppet::Type::Package::ProviderChocolatey: file C:\ProgramData\chocolatey\choco.exe does not exist
      Error: /Package[firefox]: Provider chocolatey is not functional on this host
      Error: /Package[googlechrome]: Provider chocolatey is not functional on this host
      Debug: Class[Firefox]: Resource is being skipped, unscheduling all events
      Debug: Class[Google_chrome]: Resource is being skipped, unscheduling all events
      Debug: Stage[main]: Resource is being skipped, unscheduling all events
      Debug: Finishing transaction 50865860
      Debug: Storing state
      Debug: Stored state in 0.11 seconds
      Notice: Applied catalog in 10.63 seconds
      

        Attachments

          Issue Links

            Activity

              People

              Assignee:
              michael.lombardi Michael Lombardi
              Reporter:
              anreik Anrew Piek
              Votes:
              2 Vote for this issue
              Watchers:
              8 Start watching this issue

                Dates

                Created:
                Updated:
                Resolved:

                  Zendesk Support