DEBUG: 1 files to send in job...
DEBUG: update_reasons(attr=0(), s="+connecting-to-device")
DEBUG2: op='+', new_reasons=1, state_reasons=0
STATE: +connecting-to-device
DEBUG: Looking up "192.168.122.251"...
DEBUG: Connecting to 192.168.122.251:631
INFO: Connecting to printer.
DEBUG: update_reasons(attr=0(), s="-cups-certificate-error")
DEBUG2: op='-', new_reasons=1, state_reasons=1
DEBUG: update_reasons(attr=0(), s="-connecting-to-device")
DEBUG2: op='-', new_reasons=1, state_reasons=1
STATE: -connecting-to-device
INFO: Connected to printer.
DEBUG: Connected to 192.168.122.251:631...
DEBUG: Getting supported attributes...
DEBUG: Get-Printer-Attributes: successful-ok (successful-ok)
DEBUG: copies-supported=1-9999
DEBUG: document-format-supported (35 values)
DEBUG: [0] = "application/octet-stream"
DEBUG: [1] = "application/pdf"
DEBUG: [2] = "application/postscript"
DEBUG: [3] = "application/rss+xml"
DEBUG: [4] = "application/vnd.cups-banner"
DEBUG: [5] = "application/vnd.cups-command"
DEBUG: [6] = "application/vnd.cups-pdf"
DEBUG: [7] = "application/vnd.cups-postscript"
DEBUG: [8] = "application/vnd.cups-ppd"
DEBUG: [9] = "application/vnd.cups-raster"
DEBUG: [10] = "application/vnd.cups-raw"
DEBUG: [11] = "application/vnd.hp-hpgl"
DEBUG: [12] = "application/x-cshell"
DEBUG: [13] = "application/x-csource"
DEBUG: [14] = "application/x-perl"
DEBUG: [15] = "application/x-shell"
DEBUG: [16] = "image/gif"
DEBUG: [17] = "image/jpeg"
DEBUG: [18] = "image/png"
DEBUG: [19] = "image/tiff"
DEBUG: [20] = "image/x-alias"
DEBUG: [21] = "image/x-bitmap"
DEBUG: [22] = "image/x-icon"
DEBUG: [23] = "image/x-photocd"
DEBUG: [24] = "image/x-portable-anymap"
DEBUG: [25] = "image/x-portable-bitmap"
DEBUG: [26] = "image/x-portable-graymap"
DEBUG: [27] = "image/x-portable-pixmap"
DEBUG: [28] = "image/x-sgi-rgb"
DEBUG: [29] = "image/x-sun-raster"
DEBUG: [30] = "image/x-xbitmap"
DEBUG: [31] = "image/x-xpixmap"
DEBUG: [32] = "text/css"
DEBUG: [33] = "text/html"
DEBUG: [34] = "text/plain"
DEBUG: media-col-supported (4 values)
DEBUG: [0] = "media-color"
DEBUG: [1] = "media-key"
DEBUG: [2] = "media-size"
DEBUG: [3] = "media-type"
INFO: 
DEBUG: update_reasons(attr=1(none), s="(null)")
DEBUG2: op=' ', new_reasons=0, state_reasons=0
DEBUG: final_content_type="application/octet-stream", document_format="application/octet-stream"
DEBUG: Validate-Job IPP/2.0
DEBUG: printer-uri="ipp://192.168.122.251:631/printers/foo"
DEBUG: requesting-user-name="twaugh"
DEBUG: document-format="application/octet-stream"
DEBUG: Validate-Job: successful-ok (successful-ok)
DEBUG: Create-Job IPP/2.0
DEBUG: printer-uri="ipp://192.168.122.251:631/printers/foo"
DEBUG: requesting-user-name="twaugh"
DEBUG: document-format="application/octet-stream"
DEBUG: Create-Job: successful-ok (successful-ok)
INFO: Print file accepted - job ID 2.
INFO: 
DEBUG: update_reasons(attr=1(none), s="(null)")
DEBUG2: op=' ', new_reasons=0, state_reasons=0
DEBUG: Get-Printer-Attributes: successful-ok (successful-ok)
DEBUG: Get-Job-Attributes: successful-ok (successful-ok)
DEBUG: job-id=2
DEBUG: Sending file 1 using chunking...
DEBUG: Send-Document: cups-upgrade-required (Upgrade Required)
ERROR: Unable to add document to print job.
INFO: Waiting for job to complete.
DEBUG: Get-Job-Attributes: successful-ok (successful-ok)
DEBUG: update_reasons(attr=0(), s="+cups-remote-pending-held")
DEBUG2: op='+', new_reasons=1, state_reasons=0
STATE: +cups-remote-pending-held
PAGE: total 0
INFO: 
DEBUG: update_reasons(attr=1(none), s="(null)")
DEBUG2: op=' ', new_reasons=0, state_reasons=1
DEBUG: Get-Printer-Attributes: successful-ok (successful-ok)
DEBUG: Get-Job-Attributes: successful-ok (successful-ok)
DEBUG: Get-Job-Attributes: successful-ok (successful-ok)
DEBUG: update_reasons(attr=0(), s="+cups-remote-pending-held")
DEBUG2: op='+', new_reasons=1, state_reasons=1
PAGE: total 0
INFO: 
DEBUG: update_reasons(attr=1(none), s="(null)")
DEBUG2: op=' ', new_reasons=0, state_reasons=1
DEBUG: Get-Printer-Attributes: successful-ok (successful-ok)
DEBUG: Get-Job-Attributes: successful-ok (successful-ok)
DEBUG: Get-Job-Attributes: successful-ok (successful-ok)
DEBUG: update_reasons(attr=0(), s="+cups-remote-pending-held")
DEBUG2: op='+', new_reasons=1, state_reasons=1
PAGE: total 0
INFO: 
DEBUG: update_reasons(attr=1(none), s="(null)")
DEBUG2: op=' ', new_reasons=0, state_reasons=1
DEBUG: Get-Printer-Attributes: successful-ok (successful-ok)
DEBUG: Get-Job-Attributes: successful-ok (successful-ok)
DEBUG: Get-Job-Attributes: successful-ok (successful-ok)
DEBUG: update_reasons(attr=0(), s="+cups-remote-pending-held")
DEBUG2: op='+', new_reasons=1, state_reasons=1
PAGE: total 0
etc