
Ubuntu日本語フォーラム

ログインしていません。
以下の現象について、おわかりになる方はいらっしゃらないでしょうか。
【現象】
2日前まで印刷時のプリンタに caps-pdf を指定していた時には "~/PDF" に印刷結果が pdf ファイルとして出力されていたが、本日 caps-pdf に印刷したところ "~/PDF" に pdf ファイルが作成されなくなった。
【現象発生前と発生後の差異】
現象が発生する前に、Ubuntu へのログイン時に .dmrc が読み込めない旨の警告メッセージが表示される原因不明のトラブルがあり、/home/username のパーミッションを変更することで対処した。
現象が生じることに気がついたのは先に述べたトラブル後、初めて cups-pdf に印刷した時である。
なお、先の .dmrc 関連のトラブルとの因果関係については不明である。
【特に気になっている点】
・エラーログに "cupsdAuthorize: No authentication data provided." というエラーメッセージが記録されていること。
【エラーログ・メッセージ】
『[システム]-[システム管理]-[印刷]-[ヘルプ]-[トラブルシュート]-…以下略』にて収集。
エラーログ による投稿:
D [27/Aug/2009:11:03:13 +0900] cupsdReadClient: 8 POST / HTTP/1.1
D [27/Aug/2009:11:03:13 +0900] cupsdAuthorize: No authentication data provided.
D [27/Aug/2009:11:03:13 +0900] Get-Jobs ipp://localhost/printers/
D [27/Aug/2009:11:03:13 +0900] cupsdProcessIPPRequest: 8 status_code=0 (successful-ok)
D [27/Aug/2009:11:03:13 +0900] cupsdReadClient: 8 POST / HTTP/1.1
D [27/Aug/2009:11:03:13 +0900] cupsdAuthorize: No authentication data provided.
D [27/Aug/2009:11:03:13 +0900] Get-Jobs ipp://localhost/printers/
D [27/Aug/2009:11:03:13 +0900] [Job 6] Loading attributes...
D [27/Aug/2009:11:03:13 +0900] [Job 7] Loading attributes...
D [27/Aug/2009:11:03:13 +0900] [Job 8] Loading attributes...
D [27/Aug/2009:11:03:13 +0900] [Job 9] Loading attributes...
D [27/Aug/2009:11:03:13 +0900] [Job 84] Loading attributes...
D [27/Aug/2009:11:03:13 +0900] [Job 85] Loading attributes...
D [27/Aug/2009:11:03:13 +0900] [Job 86] Loading attributes...
D [27/Aug/2009:11:03:13 +0900] [Job 87] Loading attributes...
D [27/Aug/2009:11:03:13 +0900] [Job 88] Loading attributes...
D [27/Aug/2009:11:03:13 +0900] [Job 89] Loading attributes...
D [27/Aug/2009:11:03:13 +0900] [Job 90] Loading attributes...
D [27/Aug/2009:11:03:13 +0900] [Job 91] Loading attributes...
D [27/Aug/2009:11:03:13 +0900] cupsdProcessIPPRequest: 8 status_code=0 (successful-ok)
D [27/Aug/2009:11:03:14 +0900] cupsdReadClient: 8 POST / HTTP/1.1
D [27/Aug/2009:11:03:14 +0900] cupsdAuthorize: No authentication data provided.
D [27/Aug/2009:11:03:14 +0900] Create-Printer-Subscription /
D [27/Aug/2009:11:03:14 +0900] cupsdCreateSubscription(con=0xb9b09eb0(8), uri="/")
D [27/Aug/2009:11:03:14 +0900] pullmethod="ippget"
D [27/Aug/2009:11:03:14 +0900] notify-lease-duration=86400
D [27/Aug/2009:11:03:14 +0900] notify-time-interval=0
D [27/Aug/2009:11:03:14 +0900] cupsdAddSubscription(mask=17800, dest=(nil)(), job=(nil)(0), uri="(null)")
D [27/Aug/2009:11:03:14 +0900] Added subscription 47 for server
I [27/Aug/2009:11:03:14 +0900] Saving subscriptions.conf...
D [27/Aug/2009:11:03:14 +0900] cupsdProcessIPPRequest: 8 status_code=0 (successful-ok)
D [27/Aug/2009:11:03:15 +0900] cupsdReadClient: 8 POST / HTTP/1.1
D [27/Aug/2009:11:03:15 +0900] cupsdAuthorize: No authentication data provided.
D [27/Aug/2009:11:03:15 +0900] Get-Notifications /
D [27/Aug/2009:11:03:15 +0900] cupsdIsAuthorized: requesting-user-name="mitsugu"
D [27/Aug/2009:11:03:15 +0900] cupsdProcessIPPRequest: 8 status_code=0 (successful-ok)
D [27/Aug/2009:11:03:18 +0900] cupsdAcceptClient: 9 from localhost (Domain)
D [27/Aug/2009:11:03:18 +0900] cupsdReadClient: 9 POST /printers/PDF HTTP/1.1
D [27/Aug/2009:11:03:18 +0900] cupsdAuthorize: No authentication data provided.
D [27/Aug/2009:11:03:18 +0900] Print-Job ipp://localhost/printers/PDF
D [27/Aug/2009:11:03:18 +0900] [Job ???] Auto-typing file...
I [27/Aug/2009:11:03:18 +0900] [Job ???] Request file type is application/postscript.
D [27/Aug/2009:11:03:18 +0900] add_job: requesting-user-name="mitsugu"
D [27/Aug/2009:11:03:18 +0900] Adding default job-sheets values "none,none"...
I [27/Aug/2009:11:03:18 +0900] [Job 92] Adding start banner page "none".
I [27/Aug/2009:11:03:18 +0900] Saving subscriptions.conf...
I [27/Aug/2009:11:03:18 +0900] [Job 92] Adding end banner page "none".
I [27/Aug/2009:11:03:18 +0900] [Job 92] File of type application/postscript queued by "mitsugu".
D [27/Aug/2009:11:03:18 +0900] [Job 92] hold_until=0
I [27/Aug/2009:11:03:18 +0900] [Job 92] Queued on "PDF" by "mitsugu".
I [27/Aug/2009:11:03:18 +0900] Saving subscriptions.conf...
D [27/Aug/2009:11:03:18 +0900] [Job 92] job-sheets=none,none
D [27/Aug/2009:11:03:18 +0900] [Job 92] banner_page = 0
D [27/Aug/2009:11:03:18 +0900] [Job 92] argv[0]="PDF"
D [27/Aug/2009:11:03:18 +0900] [Job 92] argv[1]="92"
D [27/Aug/2009:11:03:18 +0900] [Job 92] argv[2]="mitsugu"
D [27/Aug/2009:11:03:18 +0900] [Job 92] argv[3]="Test Page"
D [27/Aug/2009:11:03:18 +0900] [Job 92] argv[4]="1"
D [27/Aug/2009:11:03:18 +0900] [Job 92] argv[5]="job-uuid=urn:uuid:0a4c7592-f4da-3e2b-636c-18b152f623ff"
D [27/Aug/2009:11:03:18 +0900] [Job 92] argv[6]="/var/spool/cups/d00092-001"
D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[0]="CUPS_CACHEDIR=/var/cache/cups"
D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[1]="CUPS_DATADIR=/usr/share/cups"
D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"
D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"
D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"
D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"
D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[6]="CUPS_SERVERROOT=/etc/cups"
D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[7]="CUPS_STATEDIR=/var/run/cups"
D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[8]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"
D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[9]="SERVER_ADMIN=root@mitsugu-desktop"
D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[10]="SOFTWARE=CUPS/1.3.9"
D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[11]="TMPDIR=/var/spool/cups/tmp"
D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[12]="TZ=Asia/Tokyo"
D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[13]="USER=root"
D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"
D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[15]="CUPS_ENCRYPTION=IfRequested"
D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[16]="IPP_PORT=631"
D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[17]="CHARSET=utf-8"
D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[18]="LANG=ja_JP.UTF8"
D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[19]="PPD=/etc/cups/ppd/PDF.ppd"
D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[20]="RIP_MAX_CACHE=8m"
D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[21]="CONTENT_TYPE=application/postscript"
D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[22]="DEVICE_URI=cups-pdf:/"
D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[23]="PRINTER=PDF"
D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[24]="FINAL_CONTENT_TYPE=application/vnd.cups-postscript"
I [27/Aug/2009:11:03:18 +0900] [Job 92] Started filter /usr/lib/cups/filter/pstopdf (PID 4417)
I [27/Aug/2009:11:03:18 +0900] [Job 92] Started filter /usr/lib/cups/filter/pdftopdf (PID 4418)
I [27/Aug/2009:11:03:18 +0900] [Job 92] Started filter /usr/lib/cups/filter/cpdftocps (PID 4419)
I [27/Aug/2009:11:03:18 +0900] [Job 92] Started backend /usr/lib/cups/backend/cups-pdf (PID 4425)
I [27/Aug/2009:11:03:18 +0900] Saving subscriptions.conf...
D [27/Aug/2009:11:03:18 +0900] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)
E [27/Aug/2009:11:03:18 +0900] PID 4425 (/usr/lib/cups/backend/cups-pdf) stopped with status 5!
D [27/Aug/2009:11:03:18 +0900] [Job 92] pstopdf 6 args: 92 mitsugu Test Page 1 job-uuid=urn:uuid:0a4c7592-f4da-3e2b-636c-18b152f623ff /var/spool/cups/d00092-001
D [27/Aug/2009:11:03:18 +0900] [Job 92] PPD: /etc/cups/ppd/PDF.ppd
D [27/Aug/2009:11:03:18 +0900] [Job 92] Resolution: 600
D [27/Aug/2009:11:03:18 +0900] [Job 92] Page size: A4
D [27/Aug/2009:11:03:18 +0900] [Job 92] Width: 595, height: 842, absolute margins: 0, 0, 595, 842
D [27/Aug/2009:11:03:18 +0900] [Job 92] Relative margins: 0, 0, 0, 0
D [27/Aug/2009:11:03:18 +0900] [Job 92] PPD options: -r600 -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=842
D [27/Aug/2009:11:03:18 +0900] [Job 92] PostScript to be injected:
D [27/Aug/2009:11:03:18 +0900] [Job 92] Running cat | /usr/bin/ps2pdf13 -dAutoRotatePages=/None -dAutoFilterColorImages=false -dNOPLATFONTS -dPARANOIDSAFER -sstdout=%stderr -dColorImageFilter=/FlateEncode -dDoNumCopies -dPDFSETTINGS=/printer -r600 -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=842 - -
D [27/Aug/2009:11:03:18 +0900] cupsdAcceptClient: 12 from localhost (Domain)
D [27/Aug/2009:11:03:18 +0900] cupsdReadClient: 12 POST / HTTP/1.1
D [27/Aug/2009:11:03:18 +0900] cupsdAuthorize: No authentication data provided.
D [27/Aug/2009:11:03:18 +0900] Get-Notifications /
D [27/Aug/2009:11:03:18 +0900] cupsdIsAuthorized: requesting-user-name="mitsugu"
D [27/Aug/2009:11:03:18 +0900] cupsdProcessIPPRequest: 12 status_code=0 (successful-ok)
D [27/Aug/2009:11:03:18 +0900] cupsdCloseClient: 12
D [27/Aug/2009:11:03:18 +0900] cupsdAcceptClient: 12 from localhost (Domain)
D [27/Aug/2009:11:03:18 +0900] cupsdReadClient: 12 POST / HTTP/1.1
D [27/Aug/2009:11:03:18 +0900] cupsdAuthorize: No authentication data provided.
D [27/Aug/2009:11:03:18 +0900] Get-Jobs ipp://localhost/printers/
D [27/Aug/2009:11:03:18 +0900] cupsdProcessIPPRequest: 12 status_code=0 (successful-ok)
D [27/Aug/2009:11:03:18 +0900] cupsdReadClient: 8 POST / HTTP/1.1
D [27/Aug/2009:11:03:18 +0900] cupsdAuthorize: No authentication data provided.
D [27/Aug/2009:11:03:18 +0900] Get-Notifications /
D [27/Aug/2009:11:03:18 +0900] cupsdIsAuthorized: requesting-user-name="mitsugu"
D [27/Aug/2009:11:03:18 +0900] cupsdProcessIPPRequest: 8 status_code=0 (successful-ok)
D [27/Aug/2009:11:03:18 +0900] cupsdCloseClient: 12
D [27/Aug/2009:11:03:18 +0900] cupsdAcceptClient: 12 from localhost (Domain)
D [27/Aug/2009:11:03:18 +0900] cupsdReadClient: 12 POST / HTTP/1.1
D [27/Aug/2009:11:03:18 +0900] cupsdAuthorize: No authentication data provided.
D [27/Aug/2009:11:03:18 +0900] Get-Notifications /
D [27/Aug/2009:11:03:18 +0900] cupsdIsAuthorized: requesting-user-name="mitsugu"
D [27/Aug/2009:11:03:18 +0900] cupsdProcessIPPRequest: 12 status_code=0 (successful-ok)
D [27/Aug/2009:11:03:18 +0900] cupsdReadClient: 12 POST / HTTP/1.1
D [27/Aug/2009:11:03:18 +0900] cupsdAuthorize: No authentication data provided.
D [27/Aug/2009:11:03:18 +0900] Get-Job-Attributes ipp://localhost/jobs/92
D [27/Aug/2009:11:03:18 +0900] cupsdProcessIPPRequest: 12 status_code=0 (successful-ok)
D [27/Aug/2009:11:03:18 +0900] cupsdCloseClient: 12
D [27/Aug/2009:11:03:18 +0900] [Job 92] GPL Ghostscript 8.64: Set UseCIEColor for UseDeviceIndependentColor to work properly.
D [27/Aug/2009:11:03:19 +0900] PID 4417 (/usr/lib/cups/filter/pstopdf) exited with no errors.
D [27/Aug/2009:11:03:19 +0900] PID 4418 (/usr/lib/cups/filter/pdftopdf) exited with no errors.
D [27/Aug/2009:11:03:19 +0900] [Job 92] Device copies: 1; device collate:
D [27/Aug/2009:11:03:19 +0900] [Job 92] pdftops - copying to temp print file "/tmp/4a95e9674f724"
D [27/Aug/2009:11:03:19 +0900] [Job 92] Page = 595x842; 0,0 to 595,842
D [27/Aug/2009:11:03:19 +0900] [Job 92] slow_collate=0, slow_duplex=0, slow_order=0
D [27/Aug/2009:11:03:19 +0900] [Job 92] Before copy_comments - %!PS-Adobe-3.0
D [27/Aug/2009:11:03:19 +0900] [Job 92] %!PS-Adobe-3.0
D [27/Aug/2009:11:03:19 +0900] [Job 92] %%LanguageLevel: 2
D [27/Aug/2009:11:03:19 +0900] [Job 92] %%DocumentSuppliedResources: (atend)
D [27/Aug/2009:11:03:19 +0900] [Job 92] %%DocumentMedia: plain 595 842 0 () ()
D [27/Aug/2009:11:03:19 +0900] [Job 92] %%BoundingBox: 0 0 595 842
D [27/Aug/2009:11:03:19 +0900] [Job 92] %%Pages: 1
D [27/Aug/2009:11:03:19 +0900] [Job 92] %%EndComments
D [27/Aug/2009:11:03:19 +0900] [Job 92] Before copy_prolog - %%BeginDefaults
D [27/Aug/2009:11:03:19 +0900] [Job 92] Before copy_setup - %%BeginSetup
D [27/Aug/2009:11:03:19 +0900] [Job 92] Before page loop - %%Page: 1 1
D [27/Aug/2009:11:03:19 +0900] [Job 92] Copying page 1...
I [27/Aug/2009:11:03:19 +0900] Saving subscriptions.conf...
D [27/Aug/2009:11:03:19 +0900] [Job 92] pagew = 595.0, pagel = 842.0
D [27/Aug/2009:11:03:19 +0900] [Job 92] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842
D [27/Aug/2009:11:03:19 +0900] [Job 92] PageLeft = 0.0, PageRight = 595.0
D [27/Aug/2009:11:03:19 +0900] [Job 92] PageTop = 842.0, PageBottom = 0.0
D [27/Aug/2009:11:03:19 +0900] [Job 92] PageWidth = 595.0, PageLength = 842.0
D [27/Aug/2009:11:03:19 +0900] [Job 92] Wrote 1 pages...
D [27/Aug/2009:11:03:19 +0900] PID 4419 (/usr/lib/cups/filter/cpdftocps) exited with no errors.
D [27/Aug/2009:11:03:19 +0900] [Job 92] File 0 is complete.
I [27/Aug/2009:11:03:19 +0900] [Job 92] Backend returned status 5 (cancel job)
I [27/Aug/2009:11:03:19 +0900] Saving subscriptions.conf...
I [27/Aug/2009:11:03:19 +0900] Saving subscriptions.conf...
D [27/Aug/2009:11:03:19 +0900] cupsdAcceptClient: 13 from localhost (Domain)
D [27/Aug/2009:11:03:19 +0900] cupsdAcceptClient: 14 from localhost (Domain)
D [27/Aug/2009:11:03:19 +0900] cupsdReadClient: 13 POST / HTTP/1.1
D [27/Aug/2009:11:03:19 +0900] cupsdAuthorize: No authentication data provided.
D [27/Aug/2009:11:03:19 +0900] Get-Jobs ipp://localhost/printers/
D [27/Aug/2009:11:03:19 +0900] cupsdProcessIPPRequest: 13 status_code=0 (successful-ok)
D [27/Aug/2009:11:03:19 +0900] cupsdReadClient: 14 POST / HTTP/1.1
D [27/Aug/2009:11:03:19 +0900] cupsdAuthorize: No authentication data provided.
D [27/Aug/2009:11:03:19 +0900] Get-Notifications /
D [27/Aug/2009:11:03:19 +0900] cupsdIsAuthorized: requesting-user-name="mitsugu"
D [27/Aug/2009:11:03:19 +0900] cupsdProcessIPPRequest: 14 status_code=0 (successful-ok)
D [27/Aug/2009:11:03:19 +0900] cupsdCloseClient: 13
D [27/Aug/2009:11:03:19 +0900] cupsdAcceptClient: 13 from localhost (Domain)
D [27/Aug/2009:11:03:19 +0900] cupsdCloseClient: 14
D [27/Aug/2009:11:03:19 +0900] cupsdReadClient: 13 POST / HTTP/1.1
D [27/Aug/2009:11:03:19 +0900] cupsdAuthorize: No authentication data provided.
D [27/Aug/2009:11:03:19 +0900] Get-Notifications /
D [27/Aug/2009:11:03:19 +0900] cupsdIsAuthorized: requesting-user-name="mitsugu"
D [27/Aug/2009:11:03:19 +0900] cupsdProcessIPPRequest: 13 status_code=0 (successful-ok)
D [27/Aug/2009:11:03:19 +0900] cupsdReadClient: 8 POST / HTTP/1.1
D [27/Aug/2009:11:03:19 +0900] cupsdAuthorize: No authentication data provided.
D [27/Aug/2009:11:03:19 +0900] Get-Notifications /
D [27/Aug/2009:11:03:19 +0900] cupsdIsAuthorized: requesting-user-name="mitsugu"
D [27/Aug/2009:11:03:19 +0900] cupsdProcessIPPRequest: 8 status_code=0 (successful-ok)
D [27/Aug/2009:11:03:19 +0900] cupsdCloseClient: 13
D [27/Aug/2009:11:03:20 +0900] [Job 92] Unloading...
D [27/Aug/2009:11:03:22 +0900] cupsdReadClient: 8 POST / HTTP/1.1
D [27/Aug/2009:11:03:22 +0900] cupsdAuthorize: No authentication data provided.
D [27/Aug/2009:11:03:22 +0900] Get-Job-Attributes ipp://localhost/jobs/92
D [27/Aug/2009:11:03:22 +0900] [Job 92] Loading attributes...
D [27/Aug/2009:11:03:22 +0900] cupsdProcessIPPRequest: 8 status_code=0 (successful-ok)
D [27/Aug/2009:11:03:22 +0900] cupsdReadClient: 8 POST / HTTP/1.1
D [27/Aug/2009:11:03:22 +0900] cupsdAuthorize: No authentication data provided.
D [27/Aug/2009:11:03:22 +0900] Cancel-Subscription /
D [27/Aug/2009:11:03:22 +0900] cupsdIsAuthorized: requesting-user-name="mitsugu"
I [27/Aug/2009:11:03:22 +0900] Saving subscriptions.conf...
D [27/Aug/2009:11:03:22 +0900] cupsdProcessIPPRequest: 8 status_code=0 (successful-ok)
D [27/Aug/2009:11:03:22 +0900] cupsdAcceptClient: 13 from localhost (Domain)
D [27/Aug/2009:11:03:22 +0900] cupsdCloseClient: 9
D [27/Aug/2009:11:03:22 +0900] cupsdReadClient: 13 GET /admin/log/error_log HTTP/1.1
D [27/Aug/2009:11:03:22 +0900] cupsdAuthorize: No authentication data provided.
診断の出力 による投稿:
Page 1 (Scheduler not running?):
{'cups_connection_failure': False}
Page 2 (Choose printer):
{'cups_dest': <cups.Dest PDF (default)>,
'cups_instance': None,
'cups_queue': 'PDF',
'cups_queue_listed': True}
Page 3 (Check printer sanity):
{'cups_device_uri_scheme': u'cups-pdf',
'cups_printer_dict': {'device-uri': u'cups-pdf:/',
'printer-info': u'PDF',
'printer-is-shared': False,
'printer-location': u'',
'printer-make-and-model': u'Generic CUPS-PDF Printer',
'printer-state': 3,
'printer-state-message': u'/usr/lib/cups/backend/cups-pdf failed',
'printer-state-reasons': [u'none'],
'printer-type': 2289740,
'printer-uri-supported': u'ipp://localhost:631/printers/PDF'},
'cups_printer_remote': False,
'is_cups_class': False}
Page 4 (Check PPD sanity):
{'cups_printer_ppd_defaults': {u'General': {u'PageRegion': u'A4',
u'PageSize': u'A4',
u'Resolution': u'600dpi'}},
'cups_printer_ppd_valid': True,
'missing_pkgs_and_exes': ([], [])}
Page 5 (Local or remote?):
{'printer_is_remote': False}
Page 6 (Choose device):
{'cups_device_dict': {'device-class': u'file',
'device-id': u'MFG:Generic;MDL:CUPS-PDF Printer;DES:Generic CUPS-PDF Printer;CLS:PRINTER;CMD:POSTSCRIPT;',
'device-info': u'CUPS-PDF',
'device-make-and-model': u'Virtual PDF Printer'}}
Page 7 (Printer state reasons):
{'printer-state-message': u'/usr/lib/cups/backend/cups-pdf failed',
'printer-state-reasons': [u'none']}
Page 8 (Error log checkpoint):
{'cups_server_settings': {'DefaultAuthType': 'Basic',
'MaxLogSize': '2000000',
'SystemGroup': 'lpadmin',
'_debug_logging': '0',
'_remote_admin': '0',
'_remote_any': '0',
'_remote_printers': '0',
'_share_printers': '0',
'_user_cancel_any': '0'},
'error_log_checkpoint': 47307L,
'error_log_debug_logging_set': True}
Page 9 (Print test page):
{'test_page_attempted': '27/ 8\xe6\x9c\x88/2009:11:03:18 +0000',
'test_page_completions': [(92, u'Job canceled.')],
'test_page_job_id': [92],
'test_page_job_status': [(True,
92,
'PDF',
'Test Page',
'\xe5\x8f\x96\xe3\x82\x8a\xe6\xb6\x88\xe3\x81\x95\xe3\x82\x8c\xe3\x81\xbe\xe3\x81\x97\xe3\x81\x9f',
{'attributes-charset': u'utf-8',
'attributes-natural-language': u'ja-jp',
'document-format': u'application/postscript',
'job-hold-until': u'no-hold',
'job-id': 92,
'job-k-octets': 17,
'job-media-sheets-completed': 1,
'job-more-info': u'ipp://localhost:631/jobs/92',
'job-name': u'Test Page',
'job-originating-host-name': u'localhost',
'job-originating-user-name': u'mitsugu',
'job-preserved': False,
'job-printer-state-message': u'/usr/lib/cups/backend/cups-pdf failed',
'job-printer-state-reasons': [u'none'],
'job-printer-up-time': 1251338602,
'job-printer-uri': u'ipp://mitsugu-desktop:631/printers/PDF',
'job-priority': 50,
'job-sheets': [u'none', u'none'],
'job-state': 7,
'job-state-reasons': u'job-canceled-by-user',
'job-uri': u'ipp://localhost:631/jobs/92',
'job-uuid': u'urn:uuid:0a4c7592-f4da-3e2b-636c-18b152f623ff',
'printer-uri': u'ipp://localhost/printers/PDF',
'time-at-completed': 1251338599,
'time-at-creation': 1251338598,
'time-at-processing': 1251338598})],
'test_page_successful': False}
Page 10 (Error log fetch):
{'error_log': ['D [27/Aug/2009:11:03:13 +0900] cupsdReadClient: 8 POST / HTTP/1.1',
'D [27/Aug/2009:11:03:13 +0900] cupsdAuthorize: No authentication data provided.',
'D [27/Aug/2009:11:03:13 +0900] Get-Jobs ipp://localhost/printers/',
'D [27/Aug/2009:11:03:13 +0900] cupsdProcessIPPRequest: 8 status_code=0 (successful-ok)',
'D [27/Aug/2009:11:03:13 +0900] cupsdReadClient: 8 POST / HTTP/1.1',
'D [27/Aug/2009:11:03:13 +0900] cupsdAuthorize: No authentication data provided.',
'D [27/Aug/2009:11:03:13 +0900] Get-Jobs ipp://localhost/printers/',
'D [27/Aug/2009:11:03:13 +0900] [Job 6] Loading attributes...',
'D [27/Aug/2009:11:03:13 +0900] [Job 7] Loading attributes...',
'D [27/Aug/2009:11:03:13 +0900] [Job 8] Loading attributes...',
'D [27/Aug/2009:11:03:13 +0900] [Job 9] Loading attributes...',
'D [27/Aug/2009:11:03:13 +0900] [Job 84] Loading attributes...',
'D [27/Aug/2009:11:03:13 +0900] [Job 85] Loading attributes...',
'D [27/Aug/2009:11:03:13 +0900] [Job 86] Loading attributes...',
'D [27/Aug/2009:11:03:13 +0900] [Job 87] Loading attributes...',
'D [27/Aug/2009:11:03:13 +0900] [Job 88] Loading attributes...',
'D [27/Aug/2009:11:03:13 +0900] [Job 89] Loading attributes...',
'D [27/Aug/2009:11:03:13 +0900] [Job 90] Loading attributes...',
'D [27/Aug/2009:11:03:13 +0900] [Job 91] Loading attributes...',
'D [27/Aug/2009:11:03:13 +0900] cupsdProcessIPPRequest: 8 status_code=0 (successful-ok)',
'D [27/Aug/2009:11:03:14 +0900] cupsdReadClient: 8 POST / HTTP/1.1',
'D [27/Aug/2009:11:03:14 +0900] cupsdAuthorize: No authentication data provided.',
'D [27/Aug/2009:11:03:14 +0900] Create-Printer-Subscription /',
'D [27/Aug/2009:11:03:14 +0900] cupsdCreateSubscription(con=0xb9b09eb0(8), uri="/")',
'D [27/Aug/2009:11:03:14 +0900] pullmethod="ippget"',
'D [27/Aug/2009:11:03:14 +0900] notify-lease-duration=86400',
'D [27/Aug/2009:11:03:14 +0900] notify-time-interval=0',
'D [27/Aug/2009:11:03:14 +0900] cupsdAddSubscription(mask=17800, dest=(nil)(), job=(nil)(0), uri="(null)")',
'D [27/Aug/2009:11:03:14 +0900] Added subscription 47 for server',
'I [27/Aug/2009:11:03:14 +0900] Saving subscriptions.conf...',
'D [27/Aug/2009:11:03:14 +0900] cupsdProcessIPPRequest: 8 status_code=0 (successful-ok)',
'D [27/Aug/2009:11:03:15 +0900] cupsdReadClient: 8 POST / HTTP/1.1',
'D [27/Aug/2009:11:03:15 +0900] cupsdAuthorize: No authentication data provided.',
'D [27/Aug/2009:11:03:15 +0900] Get-Notifications /',
'D [27/Aug/2009:11:03:15 +0900] cupsdIsAuthorized: requesting-user-name="mitsugu"',
'D [27/Aug/2009:11:03:15 +0900] cupsdProcessIPPRequest: 8 status_code=0 (successful-ok)',
'D [27/Aug/2009:11:03:18 +0900] cupsdAcceptClient: 9 from localhost (Domain)',
'D [27/Aug/2009:11:03:18 +0900] cupsdReadClient: 9 POST /printers/PDF HTTP/1.1',
'D [27/Aug/2009:11:03:18 +0900] cupsdAuthorize: No authentication data provided.',
'D [27/Aug/2009:11:03:18 +0900] Print-Job ipp://localhost/printers/PDF',
'D [27/Aug/2009:11:03:18 +0900] [Job ???] Auto-typing file...',
'I [27/Aug/2009:11:03:18 +0900] [Job ???] Request file type is application/postscript.',
'D [27/Aug/2009:11:03:18 +0900] add_job: requesting-user-name="mitsugu"',
'D [27/Aug/2009:11:03:18 +0900] Adding default job-sheets values "none,none"...',
'I [27/Aug/2009:11:03:18 +0900] [Job 92] Adding start banner page "none".',
'I [27/Aug/2009:11:03:18 +0900] Saving subscriptions.conf...',
'I [27/Aug/2009:11:03:18 +0900] [Job 92] Adding end banner page "none".',
'I [27/Aug/2009:11:03:18 +0900] [Job 92] File of type application/postscript queued by "mitsugu".',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] hold_until=0',
'I [27/Aug/2009:11:03:18 +0900] [Job 92] Queued on "PDF" by "mitsugu".',
'I [27/Aug/2009:11:03:18 +0900] Saving subscriptions.conf...',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] job-sheets=none,none',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] banner_page = 0',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] argv[0]="PDF"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] argv[1]="92"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] argv[2]="mitsugu"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] argv[3]="Test Page"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] argv[4]="1"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] argv[5]="job-uuid=urn:uuid:0a4c7592-f4da-3e2b-636c-18b152f623ff"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] argv[6]="/var/spool/cups/d00092-001"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[0]="CUPS_CACHEDIR=/var/cache/cups"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[1]="CUPS_DATADIR=/usr/share/cups"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[2]="CUPS_DOCROOT=/usr/share/cups/doc-root"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[3]="CUPS_FONTPATH=/usr/share/cups/fonts"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[4]="CUPS_REQUESTROOT=/var/spool/cups"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[5]="CUPS_SERVERBIN=/usr/lib/cups"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[6]="CUPS_SERVERROOT=/etc/cups"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[7]="CUPS_STATEDIR=/var/run/cups"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[8]="PATH=/usr/lib/cups/filter:/usr/bin:/usr/sbin:/bin:/usr/bin"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[9]="SERVER_ADMIN=root@mitsugu-desktop"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[10]="SOFTWARE=CUPS/1.3.9"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[11]="TMPDIR=/var/spool/cups/tmp"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[12]="TZ=Asia/Tokyo"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[13]="USER=root"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[14]="CUPS_SERVER=/var/run/cups/cups.sock"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[15]="CUPS_ENCRYPTION=IfRequested"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[16]="IPP_PORT=631"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[17]="CHARSET=utf-8"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[18]="LANG=ja_JP.UTF8"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[19]="PPD=/etc/cups/ppd/PDF.ppd"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[20]="RIP_MAX_CACHE=8m"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[21]="CONTENT_TYPE=application/postscript"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[22]="DEVICE_URI=cups-pdf:/"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[23]="PRINTER=PDF"',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] envp[24]="FINAL_CONTENT_TYPE=application/vnd.cups-postscript"',
'I [27/Aug/2009:11:03:18 +0900] [Job 92] Started filter /usr/lib/cups/filter/pstopdf (PID 4417)',
'I [27/Aug/2009:11:03:18 +0900] [Job 92] Started filter /usr/lib/cups/filter/pdftopdf (PID 4418)',
'I [27/Aug/2009:11:03:18 +0900] [Job 92] Started filter /usr/lib/cups/filter/cpdftocps (PID 4419)',
'I [27/Aug/2009:11:03:18 +0900] [Job 92] Started backend /usr/lib/cups/backend/cups-pdf (PID 4425)',
'I [27/Aug/2009:11:03:18 +0900] Saving subscriptions.conf...',
'D [27/Aug/2009:11:03:18 +0900] cupsdProcessIPPRequest: 9 status_code=0 (successful-ok)',
'E [27/Aug/2009:11:03:18 +0900] PID 4425 (/usr/lib/cups/backend/cups-pdf) stopped with status 5!',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] pstopdf 6 args: 92 mitsugu Test Page 1 job-uuid=urn:uuid:0a4c7592-f4da-3e2b-636c-18b152f623ff /var/spool/cups/d00092-001',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] PPD: /etc/cups/ppd/PDF.ppd',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] Resolution: 600',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] Page size: A4',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] Width: 595, height: 842, absolute margins: 0, 0, 595, 842',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] Relative margins: 0, 0, 0, 0',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] PPD options: -r600 -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=842',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] PostScript to be injected:',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] Running cat | /usr/bin/ps2pdf13 -dAutoRotatePages=/None -dAutoFilterColorImages=false -dNOPLATFONTS -dPARANOIDSAFER -sstdout=%stderr -dColorImageFilter=/FlateEncode -dDoNumCopies -dPDFSETTINGS=/printer -r600 -dDEVICEWIDTHPOINTS=595 -dDEVICEHEIGHTPOINTS=842 - -',
'D [27/Aug/2009:11:03:18 +0900] cupsdAcceptClient: 12 from localhost (Domain)',
'D [27/Aug/2009:11:03:18 +0900] cupsdReadClient: 12 POST / HTTP/1.1',
'D [27/Aug/2009:11:03:18 +0900] cupsdAuthorize: No authentication data provided.',
'D [27/Aug/2009:11:03:18 +0900] Get-Notifications /',
'D [27/Aug/2009:11:03:18 +0900] cupsdIsAuthorized: requesting-user-name="mitsugu"',
'D [27/Aug/2009:11:03:18 +0900] cupsdProcessIPPRequest: 12 status_code=0 (successful-ok)',
'D [27/Aug/2009:11:03:18 +0900] cupsdCloseClient: 12',
'D [27/Aug/2009:11:03:18 +0900] cupsdAcceptClient: 12 from localhost (Domain)',
'D [27/Aug/2009:11:03:18 +0900] cupsdReadClient: 12 POST / HTTP/1.1',
'D [27/Aug/2009:11:03:18 +0900] cupsdAuthorize: No authentication data provided.',
'D [27/Aug/2009:11:03:18 +0900] Get-Jobs ipp://localhost/printers/',
'D [27/Aug/2009:11:03:18 +0900] cupsdProcessIPPRequest: 12 status_code=0 (successful-ok)',
'D [27/Aug/2009:11:03:18 +0900] cupsdReadClient: 8 POST / HTTP/1.1',
'D [27/Aug/2009:11:03:18 +0900] cupsdAuthorize: No authentication data provided.',
'D [27/Aug/2009:11:03:18 +0900] Get-Notifications /',
'D [27/Aug/2009:11:03:18 +0900] cupsdIsAuthorized: requesting-user-name="mitsugu"',
'D [27/Aug/2009:11:03:18 +0900] cupsdProcessIPPRequest: 8 status_code=0 (successful-ok)',
'D [27/Aug/2009:11:03:18 +0900] cupsdCloseClient: 12',
'D [27/Aug/2009:11:03:18 +0900] cupsdAcceptClient: 12 from localhost (Domain)',
'D [27/Aug/2009:11:03:18 +0900] cupsdReadClient: 12 POST / HTTP/1.1',
'D [27/Aug/2009:11:03:18 +0900] cupsdAuthorize: No authentication data provided.',
'D [27/Aug/2009:11:03:18 +0900] Get-Notifications /',
'D [27/Aug/2009:11:03:18 +0900] cupsdIsAuthorized: requesting-user-name="mitsugu"',
'D [27/Aug/2009:11:03:18 +0900] cupsdProcessIPPRequest: 12 status_code=0 (successful-ok)',
'D [27/Aug/2009:11:03:18 +0900] cupsdReadClient: 12 POST / HTTP/1.1',
'D [27/Aug/2009:11:03:18 +0900] cupsdAuthorize: No authentication data provided.',
'D [27/Aug/2009:11:03:18 +0900] Get-Job-Attributes ipp://localhost/jobs/92',
'D [27/Aug/2009:11:03:18 +0900] cupsdProcessIPPRequest: 12 status_code=0 (successful-ok)',
'D [27/Aug/2009:11:03:18 +0900] cupsdCloseClient: 12',
'D [27/Aug/2009:11:03:18 +0900] [Job 92] GPL Ghostscript 8.64: Set UseCIEColor for UseDeviceIndependentColor to work properly.',
'D [27/Aug/2009:11:03:19 +0900] PID 4417 (/usr/lib/cups/filter/pstopdf) exited with no errors.',
'D [27/Aug/2009:11:03:19 +0900] PID 4418 (/usr/lib/cups/filter/pdftopdf) exited with no errors.',
'D [27/Aug/2009:11:03:19 +0900] [Job 92] Device copies: 1; device collate:',
'D [27/Aug/2009:11:03:19 +0900] [Job 92] pdftops - copying to temp print file "/tmp/4a95e9674f724"',
'D [27/Aug/2009:11:03:19 +0900] [Job 92] Page = 595x842; 0,0 to 595,842',
'D [27/Aug/2009:11:03:19 +0900] [Job 92] slow_collate=0, slow_duplex=0, slow_order=0',
'D [27/Aug/2009:11:03:19 +0900] [Job 92] Before copy_comments - %!PS-Adobe-3.0',
'D [27/Aug/2009:11:03:19 +0900] [Job 92] %!PS-Adobe-3.0',
'D [27/Aug/2009:11:03:19 +0900] [Job 92] %%LanguageLevel: 2',
'D [27/Aug/2009:11:03:19 +0900] [Job 92] %%DocumentSuppliedResources: (atend)',
'D [27/Aug/2009:11:03:19 +0900] [Job 92] %%DocumentMedia: plain 595 842 0 () ()',
'D [27/Aug/2009:11:03:19 +0900] [Job 92] %%BoundingBox: 0 0 595 842',
'D [27/Aug/2009:11:03:19 +0900] [Job 92] %%Pages: 1',
'D [27/Aug/2009:11:03:19 +0900] [Job 92] %%EndComments',
'D [27/Aug/2009:11:03:19 +0900] [Job 92] Before copy_prolog - %%BeginDefaults',
'D [27/Aug/2009:11:03:19 +0900] [Job 92] Before copy_setup - %%BeginSetup',
'D [27/Aug/2009:11:03:19 +0900] [Job 92] Before page loop - %%Page: 1 1',
'D [27/Aug/2009:11:03:19 +0900] [Job 92] Copying page 1...',
'I [27/Aug/2009:11:03:19 +0900] Saving subscriptions.conf...',
'D [27/Aug/2009:11:03:19 +0900] [Job 92] pagew = 595.0, pagel = 842.0',
'D [27/Aug/2009:11:03:19 +0900] [Job 92] bboxx = 0, bboxy = 0, bboxw = 595, bboxl = 842',
'D [27/Aug/2009:11:03:19 +0900] [Job 92] PageLeft = 0.0, PageRight = 595.0',
'D [27/Aug/2009:11:03:19 +0900] [Job 92] PageTop = 842.0, PageBottom = 0.0',
'D [27/Aug/2009:11:03:19 +0900] [Job 92] PageWidth = 595.0, PageLength = 842.0',
'D [27/Aug/2009:11:03:19 +0900] [Job 92] Wrote 1 pages...',
'D [27/Aug/2009:11:03:19 +0900] PID 4419 (/usr/lib/cups/filter/cpdftocps) exited with no errors.',
'D [27/Aug/2009:11:03:19 +0900] [Job 92] File 0 is complete.',
'I [27/Aug/2009:11:03:19 +0900] [Job 92] Backend returned status 5 (cancel job)',
'I [27/Aug/2009:11:03:19 +0900] Saving subscriptions.conf...',
'I [27/Aug/2009:11:03:19 +0900] Saving subscriptions.conf...',
'D [27/Aug/2009:11:03:19 +0900] cupsdAcceptClient: 13 from localhost (Domain)',
'D [27/Aug/2009:11:03:19 +0900] cupsdAcceptClient: 14 from localhost (Domain)',
'D [27/Aug/2009:11:03:19 +0900] cupsdReadClient: 13 POST / HTTP/1.1',
'D [27/Aug/2009:11:03:19 +0900] cupsdAuthorize: No authentication data provided.',
'D [27/Aug/2009:11:03:19 +0900] Get-Jobs ipp://localhost/printers/',
'D [27/Aug/2009:11:03:19 +0900] cupsdProcessIPPRequest: 13 status_code=0 (successful-ok)',
'D [27/Aug/2009:11:03:19 +0900] cupsdReadClient: 14 POST / HTTP/1.1',
'D [27/Aug/2009:11:03:19 +0900] cupsdAuthorize: No authentication data provided.',
'D [27/Aug/2009:11:03:19 +0900] Get-Notifications /',
'D [27/Aug/2009:11:03:19 +0900] cupsdIsAuthorized: requesting-user-name="mitsugu"',
'D [27/Aug/2009:11:03:19 +0900] cupsdProcessIPPRequest: 14 status_code=0 (successful-ok)',
'D [27/Aug/2009:11:03:19 +0900] cupsdCloseClient: 13',
'D [27/Aug/2009:11:03:19 +0900] cupsdAcceptClient: 13 from localhost (Domain)',
'D [27/Aug/2009:11:03:19 +0900] cupsdCloseClient: 14',
'D [27/Aug/2009:11:03:19 +0900] cupsdReadClient: 13 POST / HTTP/1.1',
'D [27/Aug/2009:11:03:19 +0900] cupsdAuthorize: No authentication data provided.',
'D [27/Aug/2009:11:03:19 +0900] Get-Notifications /',
'D [27/Aug/2009:11:03:19 +0900] cupsdIsAuthorized: requesting-user-name="mitsugu"',
'D [27/Aug/2009:11:03:19 +0900] cupsdProcessIPPRequest: 13 status_code=0 (successful-ok)',
'D [27/Aug/2009:11:03:19 +0900] cupsdReadClient: 8 POST / HTTP/1.1',
'D [27/Aug/2009:11:03:19 +0900] cupsdAuthorize: No authentication data provided.',
'D [27/Aug/2009:11:03:19 +0900] Get-Notifications /',
'D [27/Aug/2009:11:03:19 +0900] cupsdIsAuthorized: requesting-user-name="mitsugu"',
'D [27/Aug/2009:11:03:19 +0900] cupsdProcessIPPRequest: 8 status_code=0 (successful-ok)',
'D [27/Aug/2009:11:03:19 +0900] cupsdCloseClient: 13',
'D [27/Aug/2009:11:03:20 +0900] [Job 92] Unloading...',
'D [27/Aug/2009:11:03:22 +0900] cupsdReadClient: 8 POST / HTTP/1.1',
'D [27/Aug/2009:11:03:22 +0900] cupsdAuthorize: No authentication data provided.',
'D [27/Aug/2009:11:03:22 +0900] Get-Job-Attributes ipp://localhost/jobs/92',
'D [27/Aug/2009:11:03:22 +0900] [Job 92] Loading attributes...',
'D [27/Aug/2009:11:03:22 +0900] cupsdProcessIPPRequest: 8 status_code=0 (successful-ok)',
'D [27/Aug/2009:11:03:22 +0900] cupsdReadClient: 8 POST / HTTP/1.1',
'D [27/Aug/2009:11:03:22 +0900] cupsdAuthorize: No authentication data provided.',
'D [27/Aug/2009:11:03:22 +0900] Cancel-Subscription /',
'D [27/Aug/2009:11:03:22 +0900] cupsdIsAuthorized: requesting-user-name="mitsugu"',
'I [27/Aug/2009:11:03:22 +0900] Saving subscriptions.conf...',
'D [27/Aug/2009:11:03:22 +0900] cupsdProcessIPPRequest: 8 status_code=0 (successful-ok)',
'D [27/Aug/2009:11:03:22 +0900] cupsdAcceptClient: 13 from localhost (Domain)',
'D [27/Aug/2009:11:03:22 +0900] cupsdCloseClient: 9',
'D [27/Aug/2009:11:03:22 +0900] cupsdReadClient: 13 GET /admin/log/error_log HTTP/1.1',
'D [27/Aug/2009:11:03:22 +0900] cupsdAuthorize: No authentication data provided.'],
'error_log_debug_logging_unset': True}
Page 11 (Locale issues):
{'printer_page_size': u'A4',
'system_locale_lang': None,
'user_locale_ctype': 'ja_JP',
'user_locale_messages': 'ja_JP'}
解決しました。
原因はわからないままですが、 Bug #295536 のavivgoll さんのコメントにしたがって、コマンドを実行することで復旧しました。
# apparmor を設定した覚えはまったくないんだけどなぁ。
# apparmor って 9.04 ではデフォルトで有効になっているのでしょうか?
# それともなにかのひょうし ( オペチョンとか ) に有効になった?
デフォルトからapparmorは有効です。
ちなみにapparmorの作者はCanonical社員になっていたりして以下略。
オフライン
hitoさん による投稿:
デフォルトからapparmorは有効です。
cupsd を学習モードに変更することで、今回は問題を解決した訳ですが、なぜそれが必要になったのかの原因は不明のままですね。まいった。
それと本来のセキュアOSの使い方としては、ある程度学習させたら強制モードにするものと理解しているのですが、おそらく学習モードのままで放置するのはまずいのでしょうね。
# 今まで apparmor を意識したことはまったくなかったけれども、これを機会に勉強してみよう。
# 9.10 からは TOMOYO も来るし。
# オフトピ
2009年1月16日のUbuntu Weekly Topicsの「usn-707-1:cupsのセキュリティアップデート」に以下のような記載を発見しました ( ちゃんと読んでなかったのがまるわかり /// /// )。
CVE-2008-5286:6.06 LTS・7.10・8.04 LTS・8.10に影響します。PNGファイルを処理するフィルタに問題があり,悪意ある細工を施したPNGファイルをCUPSに読み込ませることで,DoSないしユーザ権限による任意のコードの実行が可能です。7.10・8.04 LTS・8.10ではAppArmorがCUPSの権限を制限しているため,任意のコードの実行による影響範囲は小さくなります。
これはやはり cups を enforce mode で動かすのが通常の運用と理解した方がいいのでしょうか。
# フォーラムで質問してもいいのかな?
# オフトピ
#5 は特定の人にお願いしているわけではありません。つまりは「教えて偉い人!!」という意味です。