お知らせ

  • 利用規約を守って投稿してください。また、よくある質問および投稿の手引きも参照してください。
  • メッセージの投稿にはアカウントが必要です。未登録の方は、ユーザ登録ページからアカウントを作成することができます。

#1 2009-08-27 11:21:52

avidya
ゲスト

cups-pdfによるpdf出力ができなくなった

 以下の現象について、おわかりになる方はいらっしゃらないでしょうか。

【現象】
 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'}

 

#2 2009-08-27 16:20:22

avidya
ゲスト

Re: cups-pdfによるpdf出力ができなくなった

 解決しました。
 原因はわからないままですが、  Bug #295536 のavivgoll さんのコメントにしたがって、コマンドを実行することで復旧しました。

# apparmor を設定した覚えはまったくないんだけどなぁ。
# apparmor って 9.04 ではデフォルトで有効になっているのでしょうか?
# それともなにかのひょうし ( オペチョンとか ) に有効になった?

 

#3 2009-08-27 16:30:30

hito
管理者
登録日: 2007-03-18

Re: cups-pdfによるpdf出力ができなくなった

デフォルトからapparmorは有効です。

ちなみにapparmorの作者はCanonical社員になっていたりして以下略。

オフライン

 

#4 2009-08-27 16:47:25

avidya
ゲスト

Re: cups-pdfによるpdf出力ができなくなった

hitoさん による投稿:

デフォルトからapparmorは有効です。

 cupsd を学習モードに変更することで、今回は問題を解決した訳ですが、なぜそれが必要になったのかの原因は不明のままですね。まいった。
 それと本来のセキュアOSの使い方としては、ある程度学習させたら強制モードにするものと理解しているのですが、おそらく学習モードのままで放置するのはまずいのでしょうね。

# 今まで apparmor を意識したことはまったくなかったけれども、これを機会に勉強してみよう。
# 9.10 からは TOMOYO も来るし。

 

#5 2009-08-27 19:03:20

avidya
ゲスト

Re: cups-pdfによるpdf出力ができなくなった

# オフトピ

 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 で動かすのが通常の運用と理解した方がいいのでしょうか。

# フォーラムで質問してもいいのかな?

 

#6 2009-08-27 19:10:10

avidya
ゲスト

Re: cups-pdfによるpdf出力ができなくなった

# オフトピ
 #5 は特定の人にお願いしているわけではありません。つまりは「教えて偉い人!!」という意味です。

 

Board footer

Powered by FluxBB