-----BEGIN PGP SIGNED MESSAGE-----
Hash: SHA1
Hi,
I was printing a 300 page job, page by page, from a script (that adds a
label), but it get stuck at page 163:
psselect -p$PAGE $FILE /tmp/pagina.ps
echo "Sending page $PAGE to default printer"
lp /tmp/pagina.ps -o page-label="$PAGE"
lpq shows the pages as "printing":
tp0 is ready and printing
Rank Owner Job File(s) Total Size
active cer 1409 pagina.ps 57344 bytes
It seems to be printing, looking at the process list:
18564 ? Ss 0:00 /usr/sbin/cupsd -c /etc/cups/cupsd.conf
18570 ? S 0:00 \_ /bin/bash /usr/lib/cups/filter/pstoturboprint
1409 cer pagina.ps 1 page-label=163 cpi=10 lpi=6 InkType=Black_0
MediaType=Plainpaper_0 _kde-filters zedoColorModel=Gray PageSize=A4
Resolution=360x360dpi_1 zedoDithering=ErrorDiffusion InputSlot=AutomaticFeed
zedoLicensedTo=LicenseOwner zedoColorCorrection=1 zedoUserColor=0 zedoMirror=0
zedoDuplexAdjust=0 zedoBrightness=0 zedoContrast=0 zedoGamut=0 zedoIntensity=0
zedoGamma=180 zedoColorY=0 zedoColorC=0 zedoColorM=0 zedoColorK=0
job-uuid=urn:uuid:3b273496-4625-3ca4-6b68-6805247ec89b
18588 ? S 0:00 | \_ /usr/bin/tpprint -a0 -e1 -s8268x11693 -v2
-l/var/log/turboprint_cups.log ---page-label=163 ---cpi=10 ---lpi=6
---InkType=Black_0 ---MediaType=Plainpaper_0 ---_kde-filters
---zedoColorModel=Gray ---PageSize=A4 ---Resolution=360x360dpi_1
---zedoDithering=ErrorDiffusion ---InputSlot=AutomaticFeed
---zedoLicensedTo=LicenseOwner ---zedoColorCorrection=1 ---zedoUserColor=0
---zedoMirror=0 ---zedoDuplexAdjust=0 ---zedoBrightness=0 ---zedoContrast=0
---zedoGamut=0 ---zedoIntensity=0 ---zedoGamma=180 ---zedoColorY=0
---zedoColorC=0 ---zedoColorM=0 ---zedoColorK=0
---job-uuid=urn:uuid:3b273496-4625-3ca4-6b68-6805247ec89b
--ppdfile=/etc/cups/ppd/tp0.ppd --psheader=/tmp/pstoturboprint18570.chunk
--jobid=1409 --username=cer --title=pagina.ps /tmp/pstoturboprint18570.fifo -
18571 ? S 0:00 \_ parallel:/dev/lp0 1409 cer pagina.ps 1
page-label=163 cpi=10 lpi=6 InkType=Black_0 MediaType=Plainpaper_0 _kde-filters
zedoColorModel=Gray PageSize=A4 Resolution=360x360dpi_1
zedoDithering=ErrorDiffusion InputSlot=AutomaticFeed
zedoLicensedTo=LicenseOwner zedoColorCorrection=1 zedoUserColor=0 zedoMirror=0
zedoDuplexAdjust=0 zedoBrightness=0 zedoContrast=0 zedoGamut=0 zedoIntensity=0
zedoGamma=180 zedoColorY=0 zedoColorC=0 zedoColorM=0 zedoColorK=0
job-uuid=urn:uuid:3b273496-4625-3ca4-6b68-6805247ec89b
but the page 163 gets stuck and never prints. Looking at the
/tmp/pagina.ps file with "gv", it is blank; it appears that I tried to
print over the end of the book, but I can't understand why cups gets
stuck.
I have restarted cups in debug mode:
D [24/Aug/2007:16:56:22 +0200] add_job: requesting-user-name="cer"
I [24/Aug/2007:16:56:22 +0200] Adding start banner page "none" to job 1409.
d [24/Aug/2007:16:56:22 +0200] copy_banner(0x800841f8[5], 0x8008a708[1409],
none)
d [24/Aug/2007:16:56:22 +0200] add_job_state_reasons(0x800841f8[5], 1409)
d [24/Aug/2007:16:56:22 +0200] cupsdAddEvent(event=job-created,
dest=0x80073528(tp0), job=0x8008a708(1409), text="Job created.", ...)
D [24/Aug/2007:16:56:22 +0200] Discarding unused job-created event...
d [24/Aug/2007:16:56:22 +0200] add_file(con=0x800841f8[5], job=1409,
filetype=application/postscript, compression=0)
I [24/Aug/2007:16:56:22 +0200] Adding end banner page "none" to job 1409.
d [24/Aug/2007:16:56:22 +0200] copy_banner(0x800841f8[5], 0x8008a708[1409],
none)
I [24/Aug/2007:16:56:22 +0200] Job 1409 queued on "tp0" by "cer".
D [24/Aug/2007:16:56:22 +0200] Job 1409 hold_until = 0
d [24/Aug/2007:16:56:22 +0200] cupsdSaveJob(job=0x8008a708(1409)):
job->attrs=0x80087a00
d [24/Aug/2007:16:56:22 +0200] cupsdCheckJobs: 1 active jobs, sleeping=0,
reload=0
d [24/Aug/2007:16:56:22 +0200] cupsdCheckJobs: Job 1409: state_value=3,
loaded=yes
d [24/Aug/2007:16:56:22 +0200] start_job: id = 1409, file = 0/1
d [24/Aug/2007:16:56:22 +0200] cupsdAddEvent(event=printer-state-changed,
dest=0x80073528(tp0), job=(nil)(0), text="%s "%s" state changed.", ...)
D [24/Aug/2007:16:56:22 +0200] Discarding unused printer-state-changed event...
D [24/Aug/2007:16:56:22 +0200] job-sheets=none,none
D [24/Aug/2007:16:56:22 +0200] banner_page = 0
D [24/Aug/2007:16:56:22 +0200] [Job 1409] argv[0]="tp0"
D [24/Aug/2007:16:56:22 +0200] [Job 1409] argv[1]="1409"
D [24/Aug/2007:16:56:22 +0200] [Job 1409] argv[2]="cer"
D [24/Aug/2007:16:56:22 +0200] [Job 1409] argv[3]="pagina.ps"
D [24/Aug/2007:16:56:22 +0200] [Job 1409] argv[4]="1"
D [24/Aug/2007:16:56:22 +0200] [Job 1409] argv[5]="page-label=163 cpi=10 lpi=6
InkType=Black_0 MediaType=Plainpaper_0 _kde-filters zedoColorModel=Gray
PageSize=A4 Resolution=360x360dpi_1 zedoDithering=ErrorDiffusion
InputSlot=AutomaticFeed zedoLicensedTo=LicenseOwner zedoColorCorrection=1
zedoUserColor=0 zedoMirror=0 zedoDuplexAdjust=0 zedoBrightness=0 zedoContrast=0
zedoGamut=0 zedoIntensity=0 zedoGamma=180 zedoColorY=0 zedoColorC=0
zedoColorM=0 zedoColorK=0
job-uuid=urn:uuid:3b273496-4625-3ca4-6b68-6805247ec89b"
D [24/Aug/2007:16:56:22 +0200] [Job 1409] argv[6]="/var/spool/cups/d01409-001"
D [24/Aug/2007:16:56:22 +0200] [Job 1409]
envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [24/Aug/2007:16:56:22 +0200] [Job 1409] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [24/Aug/2007:16:56:22 +0200] [Job 1409]
envp[2]="CUPS_DOCROOT=/usr/share/doc/packages/cups"
D [24/Aug/2007:16:56:22 +0200] [Job 1409]
envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [24/Aug/2007:16:56:22 +0200] [Job 1409]
envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [24/Aug/2007:16:56:22 +0200] [Job 1409] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [24/Aug/2007:16:56:22 +0200] [Job 1409] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [24/Aug/2007:16:56:22 +0200] [Job 1409] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [24/Aug/2007:16:56:22 +0200] [Job 1409]
envp[8]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [24/Aug/2007:16:56:22 +0200] [Job 1409] envp[9]="[EMAIL PROTECTED]"
D [24/Aug/2007:16:56:22 +0200] [Job 1409] envp[10]="SOFTWARE=CUPS/1.2.7"
D [24/Aug/2007:16:56:22 +0200] [Job 1409] envp[11]="TMPDIR=/var/spool/cups/tmp"
D [24/Aug/2007:16:56:22 +0200] [Job 1409] envp[12]="USER=root"
D [24/Aug/2007:16:56:22 +0200] [Job 1409] envp[13]="CUPS_SERVER=localhost"
D [24/Aug/2007:16:56:22 +0200] [Job 1409] envp[14]="CUPS_ENCRYPTION=IfRequested"
D [24/Aug/2007:16:56:22 +0200] [Job 1409] envp[15]="IPP_PORT=631"
D [24/Aug/2007:16:56:22 +0200] [Job 1409] envp[16]="CHARSET=utf-8"
D [24/Aug/2007:16:56:22 +0200] [Job 1409] envp[17]="LANG=en_US"
D [24/Aug/2007:16:56:22 +0200] [Job 1409] envp[18]="PPD=/etc/cups/ppd/tp0.ppd"
D [24/Aug/2007:16:56:22 +0200] [Job 1409] envp[19]="RIP_MAX_CACHE=8m"
D [24/Aug/2007:16:56:22 +0200] [Job 1409]
envp[20]="CONTENT_TYPE=application/postscript"
D [24/Aug/2007:16:56:22 +0200] [Job 1409]
envp[21]="DEVICE_URI=parallel:/dev/lp0"
D [24/Aug/2007:16:56:22 +0200] [Job 1409] envp[22]="PRINTER=tp0"
D [24/Aug/2007:16:56:22 +0200] [Job 1409]
envp[23]="FINAL_CONTENT_TYPE=printer/tp0"
d [24/Aug/2007:16:56:22 +0200] start_job: status_pipes = [ 9 10 ]
d [24/Aug/2007:16:56:22 +0200] start_job: filter="/usr/lib/cups/filter/pstops"
d [24/Aug/2007:16:56:22 +0200] start_job: filterfds[0]=[ 11 12 ]
d [24/Aug/2007:16:56:22 +0200] cupsdStartProcess("/usr/lib/cups/filter/pstops",
0x8008a628, 0xbfc16ef8, -1, 12, 10)
d [24/Aug/2007:16:56:22 +0200] start_job: Closing filter pipes for slot 1 [ -1
-1 ]...
I [24/Aug/2007:16:56:22 +0200] Started filter /usr/lib/cups/filter/pstops (PID
18569) for job 1409.
d [24/Aug/2007:16:56:22 +0200] start_job: print_pipes = [ 13 14 ]
d [24/Aug/2007:16:56:22 +0200] start_job:
filter="/usr/lib/cups/filter/pstoturboprint"
d [24/Aug/2007:16:56:22 +0200] start_job: filterfds[1]=[ 13 14 ]
d [24/Aug/2007:16:56:22 +0200]
cupsdStartProcess("/usr/lib/cups/filter/pstoturboprint", 0x8008a628,
0xbfc16ef8, 11, 14, 10)
d [24/Aug/2007:16:56:22 +0200] start_job: Closing filter pipes for slot 0 [ 11
12 ]...
I [24/Aug/2007:16:56:22 +0200] Started filter
/usr/lib/cups/filter/pstoturboprint (PID 18570) for job 1409.
d [24/Aug/2007:16:56:22 +0200] start_job:
backend="/usr/lib/cups/backend/parallel"
d [24/Aug/2007:16:56:22 +0200] start_job: filterfds[0] = [ -1 -1 ]
d [24/Aug/2007:16:56:22 +0200]
cupsdStartProcess("/usr/lib/cups/backend/parallel", 0x8008a628, 0xbfc16ef8, 13,
-1, 10)
I [24/Aug/2007:16:56:22 +0200] Started backend /usr/lib/cups/backend/parallel
(PID 18571) for job 1409.
d [24/Aug/2007:16:56:22 +0200] start_job: Closing print pipes [ 13 14 ]...
d [24/Aug/2007:16:56:22 +0200] start_job: Closing back pipes [ 7 8 ]...
d [24/Aug/2007:16:56:22 +0200] start_job: Closing status output pipe 10...
d [24/Aug/2007:16:56:22 +0200] start_job: Closing filter pipes for slot 0 [ -1
-1 ]...
d [24/Aug/2007:16:56:22 +0200] start_job: Adding fd 9 to InputSet...
d [24/Aug/2007:16:56:22 +0200] cupsdAddEvent(event=job-state,
dest=0x80073528(tp0), job=0x8008a708(1409), text="Job #%d started.", ...)
D [24/Aug/2007:16:56:22 +0200] Discarding unused job-state event...
D [24/Aug/2007:16:56:22 +0200] cupsdProcessIPPRequest: 5 status_code=0
(successful-ok)
d [24/Aug/2007:16:56:22 +0200] cupsdProcessIPPRequest: Adding fd 5 to
OutputSet...
d [24/Aug/2007:16:56:22 +0200] process_children()
D [24/Aug/2007:16:56:22 +0200] PID 18569 (/usr/lib/cups/filter/pstops) exited
with no errors.
D [24/Aug/2007:16:56:22 +0200] [Job 1409] Page = 595x842; 10,20 to 586,833
D [24/Aug/2007:16:56:22 +0200] [Job 1409] slow_collate=0, slow_duplex=0,
slow_order=0
D [24/Aug/2007:16:56:22 +0200] [Job 1409] Before copy_comments - %!PS-Adobe-3.0
D [24/Aug/2007:16:56:22 +0200] [Job 1409] %!PS-Adobe-3.0
D [24/Aug/2007:16:56:22 +0200] [Job 1409] %%Title: (Microsoft Word - ... )
D [24/Aug/2007:16:56:22 +0200] [Job 1409] %%Version: 1 3
D [24/Aug/2007:16:56:22 +0200] [Job 1409] %%CreationDate: 11:59:55 AM 08/24/2007
D [24/Aug/2007:16:56:22 +0200] [Job 1409] %%For: (Netrufo)
D [24/Aug/2007:16:56:22 +0200] [Job 1409] %%DocumentData: Clean7Bit
D [24/Aug/2007:16:56:22 +0200] [Job 1409] %%LanguageLevel: 3
D [24/Aug/2007:16:56:22 +0200] [Job 1409] %%BoundingBox: 0 0 595 842
D [24/Aug/2007:16:56:22 +0200] [Job 1409] %%HiResBoundingBox: 0.0 0.0 595.0
842.0
D [24/Aug/2007:16:56:22 +0200] [Job 1409] %%Pages: 0 0
D [24/Aug/2007:16:56:22 +0200] [Job 1409] %%DocumentProcessColors: (atend)
D [24/Aug/2007:16:56:22 +0200] [Job 1409] %%DocumentSuppliedResources:
D [24/Aug/2007:16:56:22 +0200] [Job 1409] %%+ procset (Adobe Acrobat - PDF
operators) 1.2 0
D [24/Aug/2007:16:56:22 +0200] [Job 1409] %%+ procset (Adobe Acrobat - type
operators) 1.2 0
D [24/Aug/2007:16:56:22 +0200] [Job 1409] %%EndComments
D [24/Aug/2007:16:56:22 +0200] [Job 1409] Before copy_prolog - %%BeginDefaults
D [24/Aug/2007:16:56:22 +0200] [Job 1409] Before copy_setup - %%BeginSetup
D [24/Aug/2007:16:56:22 +0200] [Job 1409] Before page loop - %%Trailer
D [24/Aug/2007:16:56:22 +0200] [Job 1409] Wrote 0 pages...
d [24/Aug/2007:16:56:22 +0200] cupsdWriteClient: 5 bytes < 0
d [24/Aug/2007:16:56:22 +0200] cupsdWriteClient: Removing fd 5 from OutputSet...
d [24/Aug/2007:16:56:22 +0200] cupsdReadClient: 5, used=0, file=-1 state=0
d [24/Aug/2007:16:56:22 +0200] cupsdReadClient: httpGets returned EOF...
D [24/Aug/2007:16:56:22 +0200] cupsdCloseClient: 5
d [24/Aug/2007:16:56:22 +0200] cupsdCloseClient: Removing fd 5 from InputSet
and OutputSet...
d [24/Aug/2007:16:56:22 +0200] [Job 1409] STATE: +connecting-to-device
d [24/Aug/2007:16:56:22 +0200] cupsdAddEvent(event=printer-state-changed,
dest=0x80073528(tp0), job=(nil)(0), text="Printer "%s" state changed.", ...)
D [24/Aug/2007:16:56:22 +0200] Discarding unused printer-state-changed event...
d [24/Aug/2007:16:56:22 +0200] [Job 1409] STATE: -connecting-to-device
d [24/Aug/2007:16:56:22 +0200] cupsdAddEvent(event=printer-state-changed,
dest=0x80073528(tp0), job=(nil)(0), text="Printer "%s" state changed.", ...)
D [24/Aug/2007:16:56:22 +0200] Discarding unused printer-state-changed event...
D [24/Aug/2007:16:56:22 +0200] [Job 1409] backendRunLoop(print_fd=0,
device_fd=4, use_bc=0)
d [24/Aug/2007:16:56:23 +0200] select_timeout: 11 seconds to process active jobs
d [24/Aug/2007:16:56:27 +0200] cupsdAcceptClient(lis=0x80060640) 2 Clients = 0
D [24/Aug/2007:16:56:27 +0200] cupsdAcceptClient: 5 from localhost:631 (IPv4)
d [24/Aug/2007:16:56:27 +0200] cupsdAcceptClient: 5 connected to server on
localhost:631
d [24/Aug/2007:16:56:27 +0200] cupsdAcceptClient: Adding fd 5 to InputSet...
d [24/Aug/2007:16:56:27 +0200] cupsdReadClient: 5, used=0, file=-1 state=0
D [24/Aug/2007:16:56:27 +0200] cupsdReadClient: 5 POST / HTTP/1.1
d [24/Aug/2007:16:56:27 +0200] cupsdFindBest: uri = "/"...
d [24/Aug/2007:16:56:27 +0200] cupsdFindBest: Location CUPS_INTERNAL_BROWSE_ACL
Limit 0
d [24/Aug/2007:16:56:27 +0200] cupsdFindBest: Location /admin Limit 7f
d [24/Aug/2007:16:56:27 +0200] cupsdFindBest: Location / Limit 7f
d [24/Aug/2007:16:56:27 +0200] cupsdFindBest: best = /
d [24/Aug/2007:16:56:27 +0200] cupsdAuthorize: con->uri="/",
con->best=0x800603a0(/)
d [24/Aug/2007:16:56:27 +0200] cupsdAuthorize: Authorization=""
D [24/Aug/2007:16:56:27 +0200] cupsdAuthorize: No authentication data provided.
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: con->uri="/",
con->best=0x800603a0(/)
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: level=AUTH_ANON,
type=AUTH_NONE, satisfy=AUTH_SATISFY_ALL, num_names=0
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: auth=AUTH_ALLOW...
d [24/Aug/2007:16:56:27 +0200] POST /
d [24/Aug/2007:16:56:27 +0200] CONTENT_TYPE = application/ipp
d [24/Aug/2007:16:56:27 +0200] cupsdReadClient: 5
con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=350, con->file=-1
d [24/Aug/2007:16:56:27 +0200] cupsdReadClient: 5, used=342, file=-1 state=6
d [24/Aug/2007:16:56:27 +0200] cupsdReadClient: 5
con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=342, con->file=-1
d [24/Aug/2007:16:56:27 +0200] cupsdProcessIPPRequest(0x8008b998[5]):
operation_id = 4002
D [24/Aug/2007:16:56:27 +0200] CUPS-Get-Printers
d [24/Aug/2007:16:56:27 +0200] get_printers(0x8008b998[5], 0)
d [24/Aug/2007:16:56:27 +0200] cupsdFindPolicyOp(p=0x8005a4e0,
op=4002(CUPS-Get-Printers))
d [24/Aug/2007:16:56:27 +0200] cupsdFindPolicyOp: Found wildcard match...
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: con->uri="/",
con->best=0x8005b6a8((null))
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: level=AUTH_ANON,
type=AUTH_NONE, satisfy=AUTH_SATISFY_ALL, num_names=0
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: op=0(unknown-0000)
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: auth=AUTH_ALLOW...
d [24/Aug/2007:16:56:27 +0200] add_printer_state_reasons(0x8008b998[5],
0x80060868[lp])
d [24/Aug/2007:16:56:27 +0200] copy_attrs(to=0x8008a628, from=0x8006be70,
ra=0x80084438, group=0, quickcopy=0)
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x8008a628,
0x8006bf80[printer-name,4,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x8008a628,
0x8006c020[printer-info,4,41])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x8008a628,
0x8006c1a8[job-sheets-default,4,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x8008a628,
0x8006d190[printer-make-and-model,4,41])
d [24/Aug/2007:16:56:27 +0200] copy_attrs(to=0x8008a628, from=0x800610b8,
ra=0x80084438, group=0, quickcopy=-2147483648)
d [24/Aug/2007:16:56:27 +0200] add_printer_state_reasons(0x8008b998[5],
0x8006ca28[lpg])
d [24/Aug/2007:16:56:27 +0200] copy_attrs(to=0x8008a628, from=0x8006c460,
ra=0x80084438, group=0, quickcopy=0)
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x8008a628,
0x8006cfd0[printer-name,4,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x8008a628,
0x8006d830[printer-info,4,41])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x8008a628,
0x8006d8f8[job-sheets-default,4,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x8008a628,
0x8006d978[printer-make-and-model,4,41])
d [24/Aug/2007:16:56:27 +0200] copy_attrs(to=0x8008a628, from=0x800610b8,
ra=0x80084438, group=0, quickcopy=-2147483648)
d [24/Aug/2007:16:56:27 +0200] add_printer_state_reasons(0x8008b998[5],
0x8009e3e8[tf0])
d [24/Aug/2007:16:56:27 +0200] copy_attrs(to=0x8008a628, from=0x8009ea30,
ra=0x80084438, group=0, quickcopy=0)
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x8008a628,
0x8009eaa8[printer-name,4,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x8008a628,
0x8009eaf8[printer-info,4,41])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x8008a628,
0x8009e0a0[job-sheets-default,4,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x8008a628,
0x80074b48[printer-make-and-model,4,41])
d [24/Aug/2007:16:56:27 +0200] copy_attrs(to=0x8008a628, from=0x800610b8,
ra=0x80084438, group=0, quickcopy=-2147483648)
d [24/Aug/2007:16:56:27 +0200] add_printer_state_reasons(0x8008b998[5],
0x80073528[tp0])
d [24/Aug/2007:16:56:27 +0200] copy_attrs(to=0x8008a628, from=0x8009e308,
ra=0x80084438, group=0, quickcopy=0)
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x8008a628,
0x8009e380[printer-name,4,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x8008a628,
0x8009e0f8[printer-info,4,41])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x8008a628,
0x8009e1c0[job-sheets-default,4,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x8008a628,
0x80081660[printer-make-and-model,4,41])
d [24/Aug/2007:16:56:27 +0200] copy_attrs(to=0x8008a628, from=0x800610b8,
ra=0x80084438, group=0, quickcopy=-2147483648)
D [24/Aug/2007:16:56:27 +0200] cupsdProcessIPPRequest: 5 status_code=0
(successful-ok)
d [24/Aug/2007:16:56:27 +0200] cupsdProcessIPPRequest: Adding fd 5 to
OutputSet...
d [24/Aug/2007:16:56:27 +0200] select_timeout: 11 seconds to process active jobs
d [24/Aug/2007:16:56:27 +0200] cupsdWriteClient: 5 bytes < 0
d [24/Aug/2007:16:56:27 +0200] cupsdWriteClient: Removing fd 5 from OutputSet...
d [24/Aug/2007:16:56:27 +0200] cupsdReadClient: 5, used=0, file=-1 state=0
D [24/Aug/2007:16:56:27 +0200] cupsdReadClient: 5 POST / HTTP/1.1
d [24/Aug/2007:16:56:27 +0200] cupsdFindBest: uri = "/"...
d [24/Aug/2007:16:56:27 +0200] cupsdFindBest: Location CUPS_INTERNAL_BROWSE_ACL
Limit 0
d [24/Aug/2007:16:56:27 +0200] cupsdFindBest: Location /admin Limit 7f
d [24/Aug/2007:16:56:27 +0200] cupsdFindBest: Location / Limit 7f
d [24/Aug/2007:16:56:27 +0200] cupsdFindBest: best = /
d [24/Aug/2007:16:56:27 +0200] cupsdAuthorize: con->uri="/",
con->best=0x800603a0(/)
d [24/Aug/2007:16:56:27 +0200] cupsdAuthorize: Authorization=""
D [24/Aug/2007:16:56:27 +0200] cupsdAuthorize: No authentication data provided.
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: con->uri="/",
con->best=0x800603a0(/)
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: level=AUTH_ANON,
type=AUTH_NONE, satisfy=AUTH_SATISFY_ALL, num_names=0
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: auth=AUTH_ALLOW...
d [24/Aug/2007:16:56:27 +0200] POST /
d [24/Aug/2007:16:56:27 +0200] CONTENT_TYPE = application/ipp
d [24/Aug/2007:16:56:27 +0200] cupsdReadClient: 5
con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=350, con->file=-1
d [24/Aug/2007:16:56:27 +0200] cupsdReadClient: 5, used=342, file=-1 state=6
d [24/Aug/2007:16:56:27 +0200] cupsdReadClient: 5
con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=342, con->file=-1
d [24/Aug/2007:16:56:27 +0200] cupsdProcessIPPRequest(0x8008b998[5]):
operation_id = 4005
D [24/Aug/2007:16:56:27 +0200] CUPS-Get-Classes
d [24/Aug/2007:16:56:27 +0200] get_printers(0x8008b998[5], 1)
d [24/Aug/2007:16:56:27 +0200] cupsdFindPolicyOp(p=0x8005a4e0,
op=4005(CUPS-Get-Classes))
d [24/Aug/2007:16:56:27 +0200] cupsdFindPolicyOp: Found wildcard match...
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: con->uri="/",
con->best=0x8005b6a8((null))
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: level=AUTH_ANON,
type=AUTH_NONE, satisfy=AUTH_SATISFY_ALL, num_names=0
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: op=0(unknown-0000)
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: auth=AUTH_ALLOW...
D [24/Aug/2007:16:56:27 +0200] cupsdProcessIPPRequest: 5 status_code=0
(successful-ok)
d [24/Aug/2007:16:56:27 +0200] cupsdProcessIPPRequest: Adding fd 5 to
OutputSet...
d [24/Aug/2007:16:56:27 +0200] select_timeout: 11 seconds to process active jobs
d [24/Aug/2007:16:56:27 +0200] cupsdWriteClient: 5 bytes < 0
d [24/Aug/2007:16:56:27 +0200] cupsdWriteClient: Removing fd 5 from OutputSet...
d [24/Aug/2007:16:56:27 +0200] cupsdReadClient: 5, used=0, file=-1 state=0
D [24/Aug/2007:16:56:27 +0200] cupsdReadClient: 5 POST / HTTP/1.1
d [24/Aug/2007:16:56:27 +0200] cupsdFindBest: uri = "/"...
d [24/Aug/2007:16:56:27 +0200] cupsdFindBest: Location CUPS_INTERNAL_BROWSE_ACL
Limit 0
d [24/Aug/2007:16:56:27 +0200] cupsdFindBest: Location /admin Limit 7f
d [24/Aug/2007:16:56:27 +0200] cupsdFindBest: Location / Limit 7f
d [24/Aug/2007:16:56:27 +0200] cupsdFindBest: best = /
d [24/Aug/2007:16:56:27 +0200] cupsdAuthorize: con->uri="/",
con->best=0x800603a0(/)
d [24/Aug/2007:16:56:27 +0200] cupsdAuthorize: Authorization=""
D [24/Aug/2007:16:56:27 +0200] cupsdAuthorize: No authentication data provided.
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: con->uri="/",
con->best=0x800603a0(/)
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: level=AUTH_ANON,
type=AUTH_NONE, satisfy=AUTH_SATISFY_ALL, num_names=0
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: auth=AUTH_ALLOW...
d [24/Aug/2007:16:56:27 +0200] POST /
d [24/Aug/2007:16:56:27 +0200] CONTENT_TYPE = application/ipp
d [24/Aug/2007:16:56:27 +0200] cupsdReadClient: 5
con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=75, con->file=-1
d [24/Aug/2007:16:56:27 +0200] cupsdReadClient: 5, used=67, file=-1 state=6
d [24/Aug/2007:16:56:27 +0200] cupsdReadClient: 5
con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=67, con->file=-1
d [24/Aug/2007:16:56:27 +0200] cupsdProcessIPPRequest(0x8008b998[5]):
operation_id = 4001
D [24/Aug/2007:16:56:27 +0200] CUPS-Get-Default
d [24/Aug/2007:16:56:27 +0200] get_default(0x8008b998[5])
d [24/Aug/2007:16:56:27 +0200] cupsdFindPolicyOp(p=0x8005a4e0,
op=4001(CUPS-Get-Default))
d [24/Aug/2007:16:56:27 +0200] cupsdFindPolicyOp: Found wildcard match...
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: con->uri="/",
con->best=0x8005b6a8((null))
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: level=AUTH_ANON,
type=AUTH_NONE, satisfy=AUTH_SATISFY_ALL, num_names=0
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: op=0(unknown-0000)
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: auth=AUTH_ALLOW...
d [24/Aug/2007:16:56:27 +0200] add_printer_state_reasons(0x8008b998[5],
0x80073528[tp0])
d [24/Aug/2007:16:56:27 +0200]
printer-uri-supported="ipp://localhost:631/printers/tp0"
d [24/Aug/2007:16:56:27 +0200] add_queued_job_count(0x8008b998[5],
0x80073528[tp0])
d [24/Aug/2007:16:56:27 +0200] copy_attrs(to=0x80084ba8, from=0x8009e308,
ra=(nil), group=0, quickcopy=0)
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8009e330[uri-authentication-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8009e358[uri-security-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8009e380[printer-name,4,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8009e3a8[printer-location,4,41])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8009e0f8[printer-info,4,41])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8009e120[printer-more-info,4,45])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8009e148[job-quota-period,4,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8009e170[job-k-limit,4,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8009e198[job-page-limit,4,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8009e1c0[job-sheets-default,4,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8009e1f0[device-uri,4,45])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x80081218[color-supported,4,22])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x80081608[pages-per-minute,4,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x80081660[printer-make-and-model,4,41])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x80076b88[media-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x80076e40[media-default,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x80077088[port-monitor,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x800770b0[port-monitor-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x80073a50[finishings-supported,4,23])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x800770d8[finishings-default,4,23])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x80073af8[document-format-supported,4,49])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x80073c60[copies-default,4,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x800771a8[job-hold-until-default,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x800771d0[job-priority-default,4,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x800771f8[number-up-default,4,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x80077220[orientation-requested-default,4,23])
d [24/Aug/2007:16:56:27 +0200] copy_attrs(to=0x80084ba8, from=0x800610b8,
ra=(nil), group=0, quickcopy=-2147483648)
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8006be18[charset-configured,4,47])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8006d080[charset-supported,4,47])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x80061738[compression-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8006bdb0[copies-supported,4,33])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8006bce0[document-format-default,4,49])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8006bc88[generated-natural-language-supported,4,48])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x800617b8[ipp-versions-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x800613c0[job-hold-until-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8006bc60[job-priority-supported,4,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x800771f8[number-up-default,4,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x80077220[orientation-requested-default,4,23])
d [24/Aug/2007:16:56:27 +0200] copy_attrs(to=0x80084ba8, from=0x800610b8,
ra=(nil), group=0, quickcopy=-2147483648)
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8006be18[charset-configured,4,47])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8006d080[charset-supported,4,47])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x80061738[compression-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8006bdb0[copies-supported,4,33])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8006bce0[document-format-default,4,49])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8006bc88[generated-natural-language-supported,4,48])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x800617b8[ipp-versions-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x800613c0[job-hold-until-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8006bc60[job-priority-supported,4,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x800615c8[job-sheets-supported,4,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x80061320[multiple-document-handling-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8006b978[multiple-document-jobs-supported,4,22])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8006b1f0[multiple-operation-time-out,4,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8006b190[natural-language-configured,4,48])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8006bd60[notify-attributes-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8006b130[notify-lease-duration-default,4,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8006b0d8[notify-lease-duration-supported,4,33])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x80061880[notify-max-events-supported,4,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x80061820[notify-events-default,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8006b2c8[notify-events-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x80061858[notify-pull-method-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8006d018[notify-schemes-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8006b9c0[number-up-supported,4,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x8006ba48[operations-supported,4,23])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x800732e0[orientation-requested-supported,4,23])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x80061350[page-ranges-supported,4,22])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x80061398[pdl-override-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x80061260[printer-error-policy-supported,4,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ba8,
0x800610e0[printer-op-policy-supported,4,42])
D [24/Aug/2007:16:56:27 +0200] cupsdProcessIPPRequest: 5 status_code=0
(successful-ok)
d [24/Aug/2007:16:56:27 +0200] cupsdProcessIPPRequest: Adding fd 5 to
OutputSet...
d [24/Aug/2007:16:56:27 +0200] select_timeout: 11 seconds to process active jobs
d [24/Aug/2007:16:56:27 +0200] cupsdWriteClient: 5 bytes < 0
d [24/Aug/2007:16:56:27 +0200] cupsdWriteClient: Removing fd 5 from OutputSet...
d [24/Aug/2007:16:56:27 +0200] cupsdReadClient: 5, used=0, file=-1 state=0
D [24/Aug/2007:16:56:27 +0200] cupsdReadClient: 5 POST / HTTP/1.1
d [24/Aug/2007:16:56:27 +0200] cupsdFindBest: uri = "/"...
d [24/Aug/2007:16:56:27 +0200] cupsdFindBest: Location CUPS_INTERNAL_BROWSE_ACL
Limit 0
d [24/Aug/2007:16:56:27 +0200] cupsdFindBest: Location /admin Limit 7f
d [24/Aug/2007:16:56:27 +0200] cupsdFindBest: Location / Limit 7f
d [24/Aug/2007:16:56:27 +0200] cupsdFindBest: best = /
d [24/Aug/2007:16:56:27 +0200] cupsdAuthorize: con->uri="/",
con->best=0x800603a0(/)
d [24/Aug/2007:16:56:27 +0200] cupsdAuthorize: Authorization=""
D [24/Aug/2007:16:56:27 +0200] cupsdAuthorize: No authentication data provided.
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: con->uri="/",
con->best=0x800603a0(/)
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: level=AUTH_ANON,
type=AUTH_NONE, satisfy=AUTH_SATISFY_ALL, num_names=0
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: auth=AUTH_ALLOW...
d [24/Aug/2007:16:56:27 +0200] POST /
d [24/Aug/2007:16:56:27 +0200] CONTENT_TYPE = application/ipp
d [24/Aug/2007:16:56:27 +0200] cupsdReadClient: 5
con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=119, con->file=-1
d [24/Aug/2007:16:56:27 +0200] cupsdReadClient: 5, used=111, file=-1 state=6
d [24/Aug/2007:16:56:27 +0200] cupsdReadClient: 5
con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=111, con->file=-1
d [24/Aug/2007:16:56:27 +0200] cupsdProcessIPPRequest(0x8008b998[5]):
operation_id = 000b
D [24/Aug/2007:16:56:27 +0200] Get-Printer-Attributes
ipp://localhost/printers/tp0
d [24/Aug/2007:16:56:27 +0200] get_printer_attrs(0x8008b998[5],
ipp://localhost/printers/tp0)
d [24/Aug/2007:16:56:27 +0200] cupsdFindPolicyOp(p=0x8005a4e0,
op=b(Get-Printer-Attributes))
d [24/Aug/2007:16:56:27 +0200] cupsdFindPolicyOp: Found wildcard match...
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: con->uri="/",
con->best=0x8005b6a8((null))
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: level=AUTH_ANON,
type=AUTH_NONE, satisfy=AUTH_SATISFY_ALL, num_names=0
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: op=0(unknown-0000)
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: auth=AUTH_ALLOW...
d [24/Aug/2007:16:56:27 +0200] add_printer_state_reasons(0x8008b998[5],
0x80073528[tp0])
d [24/Aug/2007:16:56:27 +0200]
printer-uri-supported="ipp://localhost:631/printers/tp0"
d [24/Aug/2007:16:56:27 +0200] add_queued_job_count(0x8008b998[5],
0x80073528[tp0])
d [24/Aug/2007:16:56:27 +0200] copy_attrs(to=0x800851a8, from=0x8009e308,
ra=(nil), group=0, quickcopy=0)
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x8009e330[uri-authentication-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x8009e358[uri-security-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x8009e380[printer-name,4,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x8009e3a8[printer-location,4,41])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x8009e0f8[printer-info,4,41])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x8009e120[printer-more-info,4,45])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x8009e148[job-quota-period,4,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x8009e170[job-k-limit,4,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x8009e198[job-page-limit,4,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x8009e1c0[job-sheets-default,4,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x8009e1f0[device-uri,4,45])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x80081218[color-supported,4,22])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x80081608[pages-per-minute,4,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x80081660[printer-make-and-model,4,41])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x80076b88[media-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x80076e40[media-default,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x80077088[port-monitor,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x800770b0[port-monitor-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x80073a50[finishings-supported,4,23])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x800770d8[finishings-default,4,23])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x80073af8[document-format-supported,4,49])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x80073c60[copies-default,4,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x800771a8[job-hold-until-default,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x800771d0[job-priority-default,4,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x800771f8[number-up-default,4,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x80077220[orientation-requested-default,4,23])
d [24/Aug/2007:16:56:27 +0200] copy_attrs(to=0x800851a8, from=0x800610b8,
ra=(nil), group=0, quickcopy=-2147483648)
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x8006be18[charset-configured,4,47])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x8006d080[charset-supported,4,47])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x80061738[compression-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x8006bdb0[copies-supported,4,33])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x8006bce0[document-format-default,4,49])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x8006bc88[generated-natural-language-supported,4,48])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x800617b8[ipp-versions-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x800613c0[job-hold-until-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x8006bc60[job-priority-supported,4,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x800615c8[job-sheets-supported,4,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x80061320[multiple-document-handling-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x8006b978[multiple-document-jobs-supported,4,22])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x8006b1f0[multiple-operation-time-out,4,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x8006b190[natural-language-configured,4,48])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x8006bd60[notify-attributes-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x8006b130[notify-lease-duration-default,4,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x8006b0d8[notify-lease-duration-supported,4,33])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x80061880[notify-max-events-supported,4,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x80061820[notify-events-default,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x8006b2c8[notify-events-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x80061858[notify-pull-method-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x8006d018[notify-schemes-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x8006b9c0[number-up-supported,4,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x8006ba48[operations-supported,4,23])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x800732e0[orientation-requested-supported,4,23])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x80061350[page-ranges-supported,4,22])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x80061398[pdl-override-supported,4,44])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x80061260[printer-error-policy-supported,4,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x800851a8,
0x800610e0[printer-op-policy-supported,4,42])
D [24/Aug/2007:16:56:27 +0200] cupsdProcessIPPRequest: 5 status_code=0
(successful-ok)
d [24/Aug/2007:16:56:27 +0200] cupsdProcessIPPRequest: Adding fd 5 to
OutputSet...
d [24/Aug/2007:16:56:27 +0200] select_timeout: 11 seconds to process active jobs
d [24/Aug/2007:16:56:27 +0200] cupsdWriteClient: 5 bytes < 0
d [24/Aug/2007:16:56:27 +0200] cupsdWriteClient: Removing fd 5 from OutputSet...
d [24/Aug/2007:16:56:27 +0200] cupsdReadClient: 5, used=0, file=-1 state=0
D [24/Aug/2007:16:56:27 +0200] cupsdReadClient: 5 POST / HTTP/1.1
d [24/Aug/2007:16:56:27 +0200] cupsdFindBest: uri = "/"...
d [24/Aug/2007:16:56:27 +0200] cupsdFindBest: Location CUPS_INTERNAL_BROWSE_ACL
Limit 0
d [24/Aug/2007:16:56:27 +0200] cupsdFindBest: Location /admin Limit 7f
d [24/Aug/2007:16:56:27 +0200] cupsdFindBest: Location / Limit 7f
d [24/Aug/2007:16:56:27 +0200] cupsdFindBest: best = /
d [24/Aug/2007:16:56:27 +0200] cupsdAuthorize: con->uri="/",
con->best=0x800603a0(/)
d [24/Aug/2007:16:56:27 +0200] cupsdAuthorize: Authorization=""
D [24/Aug/2007:16:56:27 +0200] cupsdAuthorize: No authentication data provided.
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: con->uri="/",
con->best=0x800603a0(/)
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: level=AUTH_ANON,
type=AUTH_NONE, satisfy=AUTH_SATISFY_ALL, num_names=0
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: auth=AUTH_ALLOW...
d [24/Aug/2007:16:56:27 +0200] POST /
d [24/Aug/2007:16:56:27 +0200] CONTENT_TYPE = application/ipp
d [24/Aug/2007:16:56:27 +0200] cupsdReadClient: 5
con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=119, con->file=-1
d [24/Aug/2007:16:56:27 +0200] cupsdReadClient: 5, used=111, file=-1 state=6
d [24/Aug/2007:16:56:27 +0200] cupsdReadClient: 5
con->data_encoding=HTTP_ENCODE_LENGTH, con->data_remaining=111, con->file=-1
d [24/Aug/2007:16:56:27 +0200] cupsdProcessIPPRequest(0x8008b998[5]):
operation_id = 000a
D [24/Aug/2007:16:56:27 +0200] Get-Jobs ipp://localhost/printers/tp0
d [24/Aug/2007:16:56:27 +0200] get_jobs(0x8008b998[5],
ipp://localhost/printers/tp0)
d [24/Aug/2007:16:56:27 +0200] cupsdFindPolicyOp(p=0x8005a4e0, op=a(Get-Jobs))
d [24/Aug/2007:16:56:27 +0200] cupsdFindPolicyOp: Found wildcard match...
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: con->uri="/",
con->best=0x8005b6a8((null))
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: level=AUTH_ANON,
type=AUTH_NONE, satisfy=AUTH_SATISFY_ALL, num_names=0
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: op=0(unknown-0000)
d [24/Aug/2007:16:56:27 +0200] cupsdIsAuthorized: auth=AUTH_ALLOW...
d [24/Aug/2007:16:56:27 +0200] get_jobs: job->id = 1409
d [24/Aug/2007:16:56:27 +0200] get_jobs: count = 1
d [24/Aug/2007:16:56:27 +0200] add_job_state_reasons(0x8008b998[5], 1409)
d [24/Aug/2007:16:56:27 +0200] copy_attrs(to=0x80084ad8, from=0x80087a00,
ra=(nil), group=2, quickcopy=0)
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x80087ae0[printer-uri,2,45])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x80087b60[job-originating-user-name,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x80087b88[job-name,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x80087bf0[document-format,2,49])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x80087c40[page-label,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x80087cf0[job-sheets,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8, 0x80087ca8[cpi,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8, 0x80087db8[lpi,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x80087e20[InkType,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x80087e88[MediaType,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x80087ed0[_kde-filters,2,22])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x80087f20[zedoColorModel,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x80087f90[PageSize,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x80087fd8[Resolution,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x80088048[zedoDithering,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x800880c0[InputSlot,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x80088108[zedoLicensedTo,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x80088180[zedoColorCorrection,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x800881f0[zedoUserColor,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x80088260[zedoMirror,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x800882a8[zedoDuplexAdjust,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x800882f8[zedoBrightness,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x80088348[zedoContrast,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x80088398[zedoGamut,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x800883e0[zedoIntensity,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x8008a4a0[zedoGamma,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x8008a508[zedoColorY,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x8008a550[zedoColorC,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x8008a598[zedoColorM,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x8008a5e0[zedoColorK,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x8008a6d0[job-priority,2,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x8008a890[job-uuid,2,45])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x8008a950[job-originating-host-name,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x8008a9c8[time-at-creation,2,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x8008aa18[time-at-processing,2,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x8008aa68[time-at-completed,2,13])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x8008aab8[job-id,2,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x8008ab00[job-state,2,23])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x8008ab48[job-media-sheets-completed,2,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x8008aba0[job-printer-uri,2,45])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x8008abf0[job-name,2,42])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x8008ac18[job-k-octets,2,21])
d [24/Aug/2007:16:56:27 +0200] copy_attribute(0x80084ad8,
0x8008ac68[job-hold-until,2,44])
D [24/Aug/2007:16:56:27 +0200] cupsdProcessIPPRequest: 5 status_code=0
(successful-ok)
d [24/Aug/2007:16:56:27 +0200] cupsdProcessIPPRequest: Adding fd 5 to
OutputSet...
d [24/Aug/2007:16:56:27 +0200] select_timeout: 11 seconds to process active jobs
d [24/Aug/2007:16:56:27 +0200] cupsdWriteClient: 5 bytes < 0
d [24/Aug/2007:16:56:27 +0200] cupsdWriteClient: Removing fd 5 from OutputSet...
d [24/Aug/2007:16:56:27 +0200] cupsdReadClient: 5, used=0, file=-1 state=0
d [24/Aug/2007:16:56:27 +0200] cupsdReadClient: httpGets returned EOF...
D [24/Aug/2007:16:56:27 +0200] cupsdCloseClient: 5
d [24/Aug/2007:16:56:27 +0200] cupsdCloseClient: Removing fd 5 from InputSet
and OutputSet...
d [24/Aug/2007:16:56:28 +0200] select_timeout: 11 seconds to process active jobs
d [24/Aug/2007:16:56:39 +0200] cupsdCheckJobs: 1 active jobs, sleeping=0,
reload=0
d [24/Aug/2007:16:56:39 +0200] cupsdCheckJobs: Job 1409: state_value=5,
loaded=yes
d [24/Aug/2007:16:56:39 +0200] select_timeout: 11 seconds to process active jobs
d [24/Aug/2007:16:56:50 +0200] cupsdCheckJobs: 1 active jobs, sleeping=0,
reload=0
d [24/Aug/2007:16:56:50 +0200] cupsdCheckJobs: Job 1409: state_value=5,
loaded=yes
d [24/Aug/2007:16:56:50 +0200] select_timeout: 11 seconds to process active jobs
d [24/Aug/2007:16:57:01 +0200] cupsdCheckJobs: 1 active jobs, sleeping=0,
reload=0
d [24/Aug/2007:16:57:01 +0200] cupsdCheckJobs: Job 1409: state_value=5,
loaded=yes
d [24/Aug/2007:16:57:01 +0200] stringpool: 1231 strings, 10328 allocated, 18160
total bytes
d [24/Aug/2007:16:57:01 +0200] select_timeout: 11 seconds to process active jobs
d [24/Aug/2007:16:57:12 +0200] cupsdCheckJobs: 1 active jobs, sleeping=0,
reload=0
d [24/Aug/2007:16:57:12 +0200] cupsdCheckJobs: Job 1409: state_value=5,
loaded=yes
d [24/Aug/2007:16:57:12 +0200] select_timeout: 11 seconds to process active jobs
d [24/Aug/2007:16:57:23 +0200] cupsdCheckJobs: 1 active jobs, sleeping=0,
reload=0
d [24/Aug/2007:16:57:23 +0200] cupsdCheckJobs: Job 1409: state_value=5,
loaded=yes
d [24/Aug/2007:16:57:23 +0200] select_timeout: 11 seconds to process active jobs
d [24/Aug/2007:16:57:34 +0200] cupsdCheckJobs: 1 active jobs, sleeping=0,
reload=0
d [24/Aug/2007:16:57:34 +0200] cupsdCheckJobs: Job 1409: state_value=5,
loaded=yes
d [24/Aug/2007:16:57:34 +0200] select_timeout: 11 seconds to process active jobs
d [24/Aug/2007:16:57:45 +0200] cupsdCheckJobs: 1 active jobs, sleeping=0,
reload=0
d [24/Aug/2007:16:57:45 +0200] cupsdCheckJobs: Job 1409: state_value=5,
loaded=yes
d [24/Aug/2007:16:57:45 +0200] select_timeout: 11 seconds to process active jobs
d [24/Aug/2007:16:57:56 +0200] cupsdCheckJobs: 1 active jobs, sleeping=0,
reload=0
d [24/Aug/2007:16:57:56 +0200] cupsdCheckJobs: Job 1409: state_value=5,
loaded=yes
d [24/Aug/2007:16:57:56 +0200] select_timeout: 11 seconds to process active jobs
d [24/Aug/2007:16:58:07 +0200] cupsdCheckJobs: 1 active jobs, sleeping=0,
reload=0
d [24/Aug/2007:16:58:07 +0200] cupsdCheckJobs: Job 1409: state_value=5,
loaded=yes
d [24/Aug/2007:16:58:07 +0200] stringpool: 1231 strings, 10328 allocated, 18160
total bytes
d [24/Aug/2007:16:58:07 +0200] select_timeout: 11 seconds to process active jobs
d [24/Aug/2007:16:58:18 +0200] cupsdCheckJobs: 1 active jobs, sleeping=0,
reload=0
And it doesn't print anything. The page is blank, but it should do
something, complain of an error, something... but it just stays there,
silent.
Of course, the error is mine, trying to print a non existing page, but...
is it also a bug?
:-?
- --
Cheers,
Carlos Robinson
-----BEGIN PGP SIGNATURE-----
Version: GnuPG v1.4.5 (GNU/Linux)
Comment: Made with pgp4pine 1.76
iD8DBQFGzvdptTMYHG2NR9URAnFPAJ4i84/tZljf+ZeAg+1xhYuDAZ5dcACfSCep
dLvbo063oAMy3/sPnjPIfcQ=
=DT22
-----END PGP SIGNATURE-----
--
To unsubscribe, e-mail: [EMAIL PROTECTED]
For additional commands, e-mail: [EMAIL PROTECTED]
