D [07/Dec/2017:11:21:45 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:45 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:45 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:45 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3902 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3903 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3904 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3905 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3906 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3907 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3908 D [07/Dec/2017:11:21:45 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:45 +0000] [Job 825] Read 6156 bytes of print data... d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3909 D [07/Dec/2017:11:21:45 +0000] [Job 825] Wrote 6156 bytes of print data... d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3910 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3911 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3912 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3913 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3914 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3915 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 I [07/Dec/2017:11:21:45 +0000] [Job 825] Printing page 1, 93% D [07/Dec/2017:11:21:45 +0000] cupsdMarkDirty(---J-) D [07/Dec/2017:11:21:45 +0000] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [07/Dec/2017:11:21:45 +0000] [Job 825] Set job-printer-state-message to "Printing page 1, 93%", current level=INFO D [07/Dec/2017:11:21:45 +0000] [Job 825] ATTR: job-media-progress=93 d [07/Dec/2017:11:21:45 +0000] cupsdAddEvent(event=job-progress, dest=0x2005ece0(P50), job=0x20294a80(825), text="Printing page %d, %d%%", ...) D [07/Dec/2017:11:21:45 +0000] Discarding unused job-progress event... d [07/Dec/2017:11:21:45 +0000] cupsdAddEvent(event=job-progress, dest=0x2005ece0(P50), job=0x20294a80(825), text="%s", ...) D [07/Dec/2017:11:21:45 +0000] Discarding unused job-progress event... d [07/Dec/2017:11:21:45 +0000] cupsdAddEvent(event=printer-state-changed, dest=0x2005ece0(P50), job=0(0), text="Printer \"%s\" state changed.", ...) D [07/Dec/2017:11:21:45 +0000] Discarding unused printer-state-changed event... d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3916 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3917 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3918 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3919 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3920 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3921 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3922 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3923 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:45 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:45 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:45 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:45 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:45 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:45 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:45 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:45 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:45 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3924 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3925 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3926 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3927 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3928 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3929 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3931 D [07/Dec/2017:11:21:45 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:45 +0000] [Job 825] Read 5343 bytes of print data... d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3932 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3933 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3934 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3935 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3936 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3937 D [07/Dec/2017:11:21:45 +0000] [Job 825] Wrote 5343 bytes of print data... d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3938 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3939 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3940 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3941 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3942 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3943 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3944 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3945 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3946 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:45 +0000] [Job 825] Gutenprint: Reading 17850 3947 d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:45 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:45 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:45 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:45 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:45 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:45 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:45 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:45 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:46 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:46 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3948 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3949 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3950 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3951 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3952 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3953 D [07/Dec/2017:11:21:46 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:46 +0000] [Job 825] Read 4405 bytes of print data... d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3954 D [07/Dec/2017:11:21:46 +0000] [Job 825] Wrote 4405 bytes of print data... d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3955 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3956 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3957 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 I [07/Dec/2017:11:21:46 +0000] [Job 825] Printing page 1, 94% D [07/Dec/2017:11:21:46 +0000] cupsdMarkDirty(---J-) D [07/Dec/2017:11:21:46 +0000] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [07/Dec/2017:11:21:46 +0000] [Job 825] Set job-printer-state-message to "Printing page 1, 94%", current level=INFO D [07/Dec/2017:11:21:46 +0000] [Job 825] ATTR: job-media-progress=94 d [07/Dec/2017:11:21:46 +0000] cupsdAddEvent(event=job-progress, dest=0x2005ece0(P50), job=0x20294a80(825), text="Printing page %d, %d%%", ...) D [07/Dec/2017:11:21:46 +0000] Discarding unused job-progress event... d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3958 d [07/Dec/2017:11:21:46 +0000] cupsdAddEvent(event=job-progress, dest=0x2005ece0(P50), job=0x20294a80(825), text="%s", ...) D [07/Dec/2017:11:21:46 +0000] Discarding unused job-progress event... d [07/Dec/2017:11:21:46 +0000] cupsdAddEvent(event=printer-state-changed, dest=0x2005ece0(P50), job=0(0), text="Printer \"%s\" state changed.", ...) D [07/Dec/2017:11:21:46 +0000] Discarding unused printer-state-changed event... d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3959 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3960 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3961 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3962 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3963 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3964 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3965 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3966 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3967 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3968 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3969 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:46 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:46 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:46 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:46 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:46 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:46 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:46 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:46 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:46 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3970 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3971 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3972 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3973 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3974 D [07/Dec/2017:11:21:46 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:46 +0000] [Job 825] Read 5470 bytes of print data... d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3975 D [07/Dec/2017:11:21:46 +0000] [Job 825] Wrote 5470 bytes of print data... d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3976 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3977 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3978 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3979 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3980 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3981 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3982 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3983 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3984 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3985 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3986 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3987 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3988 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3989 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3990 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3991 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3992 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3993 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3994 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3995 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3996 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3997 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3998 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:46 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:46 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:46 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:46 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:46 +0000] [Job 825] Read 6660 bytes of print data... d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:46 +0000] [Job 825] Wrote 6660 bytes of print data... D [07/Dec/2017:11:21:46 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:46 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:46 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:46 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:46 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 3999 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 I [07/Dec/2017:11:21:46 +0000] [Job 825] Printing page 1, 95% D [07/Dec/2017:11:21:46 +0000] cupsdMarkDirty(---J-) D [07/Dec/2017:11:21:46 +0000] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [07/Dec/2017:11:21:46 +0000] [Job 825] Set job-printer-state-message to "Printing page 1, 95%", current level=INFO D [07/Dec/2017:11:21:46 +0000] [Job 825] ATTR: job-media-progress=95 d [07/Dec/2017:11:21:46 +0000] cupsdAddEvent(event=job-progress, dest=0x2005ece0(P50), job=0x20294a80(825), text="Printing page %d, %d%%", ...) D [07/Dec/2017:11:21:46 +0000] Discarding unused job-progress event... d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 4000 d [07/Dec/2017:11:21:46 +0000] cupsdAddEvent(event=job-progress, dest=0x2005ece0(P50), job=0x20294a80(825), text="%s", ...) D [07/Dec/2017:11:21:46 +0000] Discarding unused job-progress event... d [07/Dec/2017:11:21:46 +0000] cupsdAddEvent(event=printer-state-changed, dest=0x2005ece0(P50), job=0(0), text="Printer \"%s\" state changed.", ...) D [07/Dec/2017:11:21:46 +0000] Discarding unused printer-state-changed event... d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:46 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:46 +0000] [Job 825] Read 6305 bytes of print data... d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 4001 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:46 +0000] [Job 825] Wrote 6305 bytes of print data... d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 4002 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 4003 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 4004 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 4005 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 4006 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 4007 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 4008 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 4009 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 4010 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 4011 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 4012 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 4013 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 4014 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 4015 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 4016 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 4017 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 4018 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 4019 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:46 +0000] [Job 825] Gutenprint: Reading 17850 4020 d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:46 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:46 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:46 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:46 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:46 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:46 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:47 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:47 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:47 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:47 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:47 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:47 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:47 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:47 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4021 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4022 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4024 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4025 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4026 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4027 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4028 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4029 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4030 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4031 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4032 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4033 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4034 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4035 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4036 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4037 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4038 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4039 D [07/Dec/2017:11:21:47 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:47 +0000] [Job 825] Read 5092 bytes of print data... d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4040 D [07/Dec/2017:11:21:47 +0000] [Job 825] Wrote 5092 bytes of print data... d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4041 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 I [07/Dec/2017:11:21:47 +0000] [Job 825] Printing page 1, 96% D [07/Dec/2017:11:21:47 +0000] cupsdMarkDirty(---J-) D [07/Dec/2017:11:21:47 +0000] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [07/Dec/2017:11:21:47 +0000] [Job 825] Set job-printer-state-message to "Printing page 1, 96%", current level=INFO D [07/Dec/2017:11:21:47 +0000] [Job 825] ATTR: job-media-progress=96 d [07/Dec/2017:11:21:47 +0000] cupsdAddEvent(event=job-progress, dest=0x2005ece0(P50), job=0x20294a80(825), text="Printing page %d, %d%%", ...) D [07/Dec/2017:11:21:47 +0000] Discarding unused job-progress event... d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4042 d [07/Dec/2017:11:21:47 +0000] cupsdAddEvent(event=job-progress, dest=0x2005ece0(P50), job=0x20294a80(825), text="%s", ...) D [07/Dec/2017:11:21:47 +0000] Discarding unused job-progress event... d [07/Dec/2017:11:21:47 +0000] cupsdAddEvent(event=printer-state-changed, dest=0x2005ece0(P50), job=0(0), text="Printer \"%s\" state changed.", ...) D [07/Dec/2017:11:21:47 +0000] Discarding unused printer-state-changed event... d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4043 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4044 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:47 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:47 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:47 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:47 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:47 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:47 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:47 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:47 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:47 +0000] [Job 825] Read 7215 bytes of print data... d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:47 +0000] [Job 825] Wrote 7215 bytes of print data... D [07/Dec/2017:11:21:47 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:47 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:47 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:47 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:47 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4045 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4046 D [07/Dec/2017:11:21:47 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:47 +0000] [Job 825] Read 5177 bytes of print data... d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4047 D [07/Dec/2017:11:21:47 +0000] [Job 825] Wrote 5177 bytes of print data... d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4048 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4049 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4050 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4051 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4052 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4053 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4054 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4055 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4056 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4057 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4058 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4059 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4060 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4061 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4062 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4063 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4064 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4065 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:47 +0000] [Job 825] Gutenprint: Reading 17850 4066 d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:47 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:47 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:47 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:47 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:48 +0000] cupsdCheckJobs: 1 active jobs, sleeping=0, ac-power=-1, reload=0, curtime=1512645708 d [07/Dec/2017:11:21:48 +0000] cupsdCheckJobs: Job 825 - dest="P50", printer=0x2005ece0, state=5, cancel_time=1512656457, hold_until=1512645956, kill_time=0, pending_cost=0, pending_timeout=0 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4067 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4068 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4069 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4070 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4071 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4072 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4073 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 2590 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4074 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4075 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 2590 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4076 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4077 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4078 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4079 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4080 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4081 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4082 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4083 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 I [07/Dec/2017:11:21:48 +0000] [Job 825] Printing page 1, 97% D [07/Dec/2017:11:21:48 +0000] cupsdMarkDirty(---J-) D [07/Dec/2017:11:21:48 +0000] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [07/Dec/2017:11:21:48 +0000] [Job 825] Set job-printer-state-message to "Printing page 1, 97%", current level=INFO D [07/Dec/2017:11:21:48 +0000] [Job 825] ATTR: job-media-progress=97 d [07/Dec/2017:11:21:48 +0000] cupsdAddEvent(event=job-progress, dest=0x2005ece0(P50), job=0x20294a80(825), text="Printing page %d, %d%%", ...) D [07/Dec/2017:11:21:48 +0000] Discarding unused job-progress event... d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4084 d [07/Dec/2017:11:21:48 +0000] cupsdAddEvent(event=job-progress, dest=0x2005ece0(P50), job=0x20294a80(825), text="%s", ...) D [07/Dec/2017:11:21:48 +0000] Discarding unused job-progress event... d [07/Dec/2017:11:21:48 +0000] cupsdAddEvent(event=printer-state-changed, dest=0x2005ece0(P50), job=0(0), text="Printer \"%s\" state changed.", ...) D [07/Dec/2017:11:21:48 +0000] Discarding unused printer-state-changed event... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4085 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4086 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4087 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4088 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4089 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4090 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4091 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4092 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4093 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4094 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4095 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4096 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4097 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4098 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4099 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4100 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4101 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4102 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4103 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4104 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4105 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4106 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 1376 bytes of print data... d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4107 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4108 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 1376 bytes of print data... d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4109 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 7691 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 7691 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4110 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4111 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4112 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4113 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4114 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4115 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 791 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4116 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Wrote 791 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4118 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4119 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4120 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4121 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4122 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4123 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4124 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4125 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 I [07/Dec/2017:11:21:48 +0000] [Job 825] Printing page 1, 98% D [07/Dec/2017:11:21:48 +0000] cupsdMarkDirty(---J-) D [07/Dec/2017:11:21:48 +0000] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [07/Dec/2017:11:21:48 +0000] [Job 825] Set job-printer-state-message to "Printing page 1, 98%", current level=INFO D [07/Dec/2017:11:21:48 +0000] [Job 825] ATTR: job-media-progress=98 d [07/Dec/2017:11:21:48 +0000] cupsdAddEvent(event=job-progress, dest=0x2005ece0(P50), job=0x20294a80(825), text="Printing page %d, %d%%", ...) D [07/Dec/2017:11:21:48 +0000] Discarding unused job-progress event... d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4126 d [07/Dec/2017:11:21:48 +0000] cupsdAddEvent(event=job-progress, dest=0x2005ece0(P50), job=0x20294a80(825), text="%s", ...) D [07/Dec/2017:11:21:48 +0000] Discarding unused job-progress event... d [07/Dec/2017:11:21:48 +0000] cupsdAddEvent(event=printer-state-changed, dest=0x2005ece0(P50), job=0(0), text="Printer \"%s\" state changed.", ...) D [07/Dec/2017:11:21:48 +0000] Discarding unused printer-state-changed event... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4127 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4128 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4129 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4130 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4131 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4132 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:48 +0000] [Job 825] Gutenprint: Reading 17850 4133 d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:48 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:48 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 7512 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 7512 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4134 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4135 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4136 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4137 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4138 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4139 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4140 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4141 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4142 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4143 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4144 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4145 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4146 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4147 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4148 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4149 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4150 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4151 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4152 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4153 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 247 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4154 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4155 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 247 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4156 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4157 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4158 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4159 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4160 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4161 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 2727 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4162 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4163 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4164 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4165 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4166 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4167 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 I [07/Dec/2017:11:21:49 +0000] [Job 825] Printing page 1, 99% D [07/Dec/2017:11:21:49 +0000] cupsdMarkDirty(---J-) D [07/Dec/2017:11:21:49 +0000] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [07/Dec/2017:11:21:49 +0000] [Job 825] Set job-printer-state-message to "Printing page 1, 99%", current level=INFO D [07/Dec/2017:11:21:49 +0000] [Job 825] ATTR: job-media-progress=99 d [07/Dec/2017:11:21:49 +0000] cupsdAddEvent(event=job-progress, dest=0x2005ece0(P50), job=0x20294a80(825), text="Printing page %d, %d%%", ...) D [07/Dec/2017:11:21:49 +0000] Discarding unused job-progress event... d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4168 d [07/Dec/2017:11:21:49 +0000] cupsdAddEvent(event=job-progress, dest=0x2005ece0(P50), job=0x20294a80(825), text="%s", ...) D [07/Dec/2017:11:21:49 +0000] Discarding unused job-progress event... d [07/Dec/2017:11:21:49 +0000] cupsdAddEvent(event=printer-state-changed, dest=0x2005ece0(P50), job=0(0), text="Printer \"%s\" state changed.", ...) D [07/Dec/2017:11:21:49 +0000] Discarding unused printer-state-changed event... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4169 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4170 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4171 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4172 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4173 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 2727 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4174 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4175 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4176 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 8191 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 8191 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4177 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4178 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4179 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 7847 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4180 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4181 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4182 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 7847 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4183 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4184 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4185 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4186 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4187 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4188 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4189 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4190 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4191 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4192 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4193 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4194 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4195 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4196 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4197 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:49 +0000] [Job 825] Gutenprint: Reading 17850 4198 d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:49 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:49 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:49 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:50 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:50 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:50 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:50 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:50 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:50 +0000] [Job 825] Read 6689 bytes of print data... d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:50 +0000] [Job 825] Wrote 6689 bytes of print data... D [07/Dec/2017:11:21:50 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:50 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:50 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:50 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:50 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:50 +0000] [Job 825] Gutenprint: Reading 17850 4199 d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:50 +0000] [Job 825] Gutenprint: Reading 17850 4200 d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:50 +0000] [Job 825] Gutenprint: Reading 17850 4201 d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:50 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:50 +0000] [Job 825] Read 6556 bytes of print data... d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:50 +0000] [Job 825] Gutenprint: Reading 17850 4202 d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:50 +0000] [Job 825] Gutenprint: Reading 17850 4203 d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:50 +0000] [Job 825] Gutenprint: Reading 17850 4204 D [07/Dec/2017:11:21:50 +0000] [Job 825] Wrote 6556 bytes of print data... d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:50 +0000] [Job 825] Gutenprint: Reading 17850 4205 d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:50 +0000] [Job 825] Gutenprint: Reading 17850 4206 d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:50 +0000] [Job 825] Gutenprint: Reading 17850 4207 d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:50 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:50 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:50 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:50 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:50 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:50 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:50 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:50 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:50 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:50 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:50 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:50 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:50 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:50 +0000] [Job 825] Gutenprint: Reading 17850 4208 d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:50 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:50 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:50 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:50 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:50 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:50 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:50 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:50 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:50 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:50 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:50 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:51 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:51 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:51 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:51 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:51 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:51 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:51 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:51 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:51 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:51 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:51 +0000] [Job 825] Read 8122 bytes of print data... d [07/Dec/2017:11:21:51 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:51 +0000] [Job 825] Wrote 8122 bytes of print data... D [07/Dec/2017:11:21:51 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:51 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:51 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:51 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:51 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:51 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:51 +0000] [Job 825] Read 6660 bytes of print data... d [07/Dec/2017:11:21:51 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:51 +0000] [Job 825] Wrote 6660 bytes of print data... D [07/Dec/2017:11:21:51 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:51 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:51 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:51 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:51 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:51 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:51 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:51 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:51 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:51 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:51 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:51 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:51 +0000] [Job 825] Read 6770 bytes of print data... d [07/Dec/2017:11:21:51 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:51 +0000] [Job 825] Wrote 6770 bytes of print data... D [07/Dec/2017:11:21:51 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:51 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:51 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:51 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:51 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:52 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:52 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:52 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:52 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:52 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:52 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:52 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:52 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:52 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:52 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:52 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:52 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:52 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:52 +0000] [Job 825] Read 8131 bytes of print data... d [07/Dec/2017:11:21:52 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:52 +0000] [Job 825] Wrote 8131 bytes of print data... D [07/Dec/2017:11:21:52 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:52 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:52 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:52 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:52 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:52 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:52 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:52 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:52 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:52 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:52 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:52 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:52 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:52 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:52 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:52 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:52 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:52 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:52 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:52 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:52 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:52 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:52 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:52 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:52 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:52 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:52 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:52 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:52 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:52 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:52 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:52 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:52 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:52 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:52 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:52 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:52 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:52 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:53 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:53 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:53 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:53 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:53 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:53 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:53 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:53 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:53 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:53 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:53 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:53 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:53 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:53 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:53 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:53 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:53 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:53 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:53 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:53 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:53 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:53 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:53 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:53 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:53 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:53 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:53 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:53 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:53 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:53 +0000] select_timeout: JobHistoryUpdate=1512722455 I [07/Dec/2017:11:21:53 +0000] [Job 825] Finished page 1... D [07/Dec/2017:11:21:53 +0000] cupsdMarkDirty(---J-) D [07/Dec/2017:11:21:53 +0000] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [07/Dec/2017:11:21:53 +0000] [Job 825] Set job-printer-state-message to "Finished page 1...", current level=INFO d [07/Dec/2017:11:21:53 +0000] cupsdAddEvent(event=job-progress, dest=0x2005ece0(P50), job=0x20294a80(825), text="%s", ...) D [07/Dec/2017:11:21:53 +0000] Discarding unused job-progress event... d [07/Dec/2017:11:21:53 +0000] cupsdAddEvent(event=printer-state-changed, dest=0x2005ece0(P50), job=0(0), text="Printer \"%s\" state changed.", ...) D [07/Dec/2017:11:21:53 +0000] Discarding unused printer-state-changed event... d [07/Dec/2017:11:21:53 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:53 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:53 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:53 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:53 +0000] [Job 825] Gutenprint: Purging 1 row d [07/Dec/2017:11:21:53 +0000] select_timeout: JobHistoryUpdate=1512722455 I [07/Dec/2017:11:21:53 +0000] [Job 825] Processing page 2... D [07/Dec/2017:11:21:53 +0000] cupsdMarkDirty(---J-) D [07/Dec/2017:11:21:53 +0000] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [07/Dec/2017:11:21:53 +0000] [Job 825] Set job-printer-state-message to "Processing page 2...", current level=INFO D [07/Dec/2017:11:21:53 +0000] [Job 825] Gutenprint: ================ Done printing page 1 ================ d [07/Dec/2017:11:21:53 +0000] cupsdAddEvent(event=job-progress, dest=0x2005ece0(P50), job=0x20294a80(825), text="%s", ...) D [07/Dec/2017:11:21:53 +0000] Discarding unused job-progress event... d [07/Dec/2017:11:21:53 +0000] cupsdAddEvent(event=printer-state-changed, dest=0x2005ece0(P50), job=0(0), text="Printer \"%s\" state changed.", ...) D [07/Dec/2017:11:21:53 +0000] Discarding unused printer-state-changed event... d [07/Dec/2017:11:21:53 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:53 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:53 +0000] [Job 825] Read 8192 bytes of print data... d [07/Dec/2017:11:21:53 +0000] select_timeout: JobHistoryUpdate=1512722455 I [07/Dec/2017:11:21:53 +0000] [Job 825] Rendering completed D [07/Dec/2017:11:21:53 +0000] cupsdMarkDirty(---J-) D [07/Dec/2017:11:21:53 +0000] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [07/Dec/2017:11:21:53 +0000] [Job 825] Set job-printer-state-message to "Rendering completed", current level=INFO d [07/Dec/2017:11:21:53 +0000] cupsdAddEvent(event=job-progress, dest=0x2005ece0(P50), job=0x20294a80(825), text="%s", ...) D [07/Dec/2017:11:21:53 +0000] Discarding unused job-progress event... d [07/Dec/2017:11:21:53 +0000] cupsdAddEvent(event=printer-state-changed, dest=0x2005ece0(P50), job=0(0), text="Printer \"%s\" state changed.", ...) D [07/Dec/2017:11:21:53 +0000] Discarding unused printer-state-changed event... d [07/Dec/2017:11:21:53 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:53 +0000] [Job 825] Wrote 8192 bytes of print data... D [07/Dec/2017:11:21:53 +0000] [Job 825] Read 1714 bytes of print data... d [07/Dec/2017:11:21:53 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:53 +0000] [Job 825] Wrote 1714 bytes of print data... d [07/Dec/2017:11:21:53 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:53 +0000] [Job 825] Gutenprint: Ending job D [07/Dec/2017:11:21:53 +0000] [Job 825] Gutenprint: stats 4989116B, 56.410u, 0.000s, 55.947el D [07/Dec/2017:11:21:53 +0000] [Job 825] Gutenprint: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ D [07/Dec/2017:11:21:53 +0000] [Job 825] Gutenprint: ============================================================ d [07/Dec/2017:11:21:53 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:53 +0000] [Job 825] Read 28 bytes of print data... d [07/Dec/2017:11:21:53 +0000] select_timeout: JobHistoryUpdate=1512722455 D [07/Dec/2017:11:21:53 +0000] [Job 825] Wrote 28 bytes of print data... D [07/Dec/2017:11:21:53 +0000] [Job 825] Sent 4989116 bytes... D [07/Dec/2017:11:21:53 +0000] [Job 825] Waiting for read thread to exit... d [07/Dec/2017:11:21:53 +0000] select_timeout: JobHistoryUpdate=1512722455 W [07/Dec/2017:11:21:53 +0000] cupsdDoSelect: select() returned -1... pause and retry select() d [07/Dec/2017:11:21:54 +0000] process_children() d [07/Dec/2017:11:21:54 +0000] cupsdFinishProcess(pid=74, name=0x17f6e0, namelen=1024, job_id=0x17f6dc(825)) = "/@unixroot/usr/lib/cups/filter/gstoraster.exe" D [07/Dec/2017:11:21:54 +0000] [Job 825] PID 74 (/@unixroot/usr/lib/cups/filter/gstoraster.exe) exited with no errors. d [07/Dec/2017:11:21:54 +0000] cupsdFinishProcess(pid=77, name=0x17f6e0, namelen=1024, job_id=0x17f6dc(825)) = "/@unixroot/usr/lib/cups/filter/rastertogutenprint.5.2.exe" D [07/Dec/2017:11:21:54 +0000] [Job 825] PID 77 (/@unixroot/usr/lib/cups/filter/rastertogutenprint.5.2.exe) exited with no errors. d [07/Dec/2017:11:21:54 +0000] cupsdFinishProcess(pid=82, name=0x17f6e0, namelen=1024, job_id=0x17f6dc(825)) = "/@unixroot/usr/lib/cups/backend/usb.exe" D [07/Dec/2017:11:21:54 +0000] [Job 825] PID 82 (/@unixroot/usr/lib/cups/backend/usb.exe) exited with no errors. d [07/Dec/2017:11:21:54 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:54 +0000] finalize_job(job=0x20294a80(825)) d [07/Dec/2017:11:21:54 +0000] cupsdSetPrinterReasons(p=0x2005ece0(P50),s="-connecting-to-device,cups-waiting-for-job-completed,cups-remote-pending,cups-remote-pending-held,cups-remote-processing,cups-remote-stopped,cups-remote-canceled,cups-remote-aborted,cups-remote-completed" d [07/Dec/2017:11:21:54 +0000] cupsdDeleteProfile(profile="(null)") d [07/Dec/2017:11:21:54 +0000] cupsdDeleteProfile(profile="(null)") d [07/Dec/2017:11:21:54 +0000] cupsdRemoveSelect(fd=11) d [07/Dec/2017:11:21:54 +0000] cupsdSetJobState(job=0x20294a80(825), state=5, newstate=9, action=0, message="%s") d [07/Dec/2017:11:21:54 +0000] stop_job(job=0x20294a80(825), action=0) D [07/Dec/2017:11:21:54 +0000] [Job 825] time-at-completed=1512645714 d [07/Dec/2017:11:21:54 +0000] set_time: JobHistoryUpdate=118370951 d [07/Dec/2017:11:21:54 +0000] cupsdAddEvent(event=job-completed, dest=0x2005ece0(P50), job=0x20294a80(825), text="%s", ...) D [07/Dec/2017:11:21:54 +0000] Discarding unused job-completed event... I [07/Dec/2017:11:21:54 +0000] [Job 825] Job completed. I [07/Dec/2017:11:21:54 +0000] Expiring subscriptions... D [07/Dec/2017:11:21:54 +0000] cupsdMarkDirty(---J-) D [07/Dec/2017:11:21:54 +0000] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" D [07/Dec/2017:11:21:54 +0000] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" d [07/Dec/2017:11:21:54 +0000] cupsdAddEvent(event=printer-state-changed, dest=0x2005ece0(P50), job=0(0), text="%s \"%s\" state changed to %s.", ...) D [07/Dec/2017:11:21:54 +0000] Discarding unused printer-state-changed event... d [07/Dec/2017:11:21:54 +0000] cupsdSetPrinterReasons(p=0x2005ece0(P50),s="-paused" D [07/Dec/2017:11:21:54 +0000] cupsdMarkDirty(---J-) D [07/Dec/2017:11:21:54 +0000] cupsdSetBusyState: newbusy="Printing jobs and dirty files", busy="Printing jobs and dirty files" d [07/Dec/2017:11:21:54 +0000] cupsdCheckJobs: 0 active jobs, sleeping=0, ac-power=-1, reload=0, curtime=1512645714 d [07/Dec/2017:11:21:54 +0000] cupsdCleanJobs: MaxJobs=500, JobHistory=2147483647, JobFiles=86400 D [07/Dec/2017:11:21:54 +0000] [Job 326] Removing from history. D [07/Dec/2017:11:21:54 +0000] [Job 825] Removing document files. D [07/Dec/2017:11:21:54 +0000] cupsdMarkDirty(---J-) D [07/Dec/2017:11:21:54 +0000] cupsdSetBusyState: newbusy="Dirty files", busy="Printing jobs and dirty files" d [07/Dec/2017:11:21:54 +0000] cupsdCleanJobs: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:54 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:55 +0000] cupsdSaveJob(job=0x20294a80(825)): job->attrs=0x20061a20 D [07/Dec/2017:11:21:55 +0000] [Job 825] Unloading... d [07/Dec/2017:11:21:55 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:55 +0000] select_timeout(0): 2 seconds to write dirty config/state files I [07/Dec/2017:11:21:57 +0000] Saving job.cache... D [07/Dec/2017:11:21:57 +0000] cupsdSetBusyState: newbusy="Not busy", busy="Dirty files" D [07/Dec/2017:11:21:57 +0000] Report: clients=0 D [07/Dec/2017:11:21:57 +0000] Report: jobs=499 D [07/Dec/2017:11:21:57 +0000] Report: jobs-active=0 D [07/Dec/2017:11:21:57 +0000] Report: printers=1 D [07/Dec/2017:11:21:57 +0000] Report: stringpool-string-count=29982 D [07/Dec/2017:11:21:57 +0000] Report: stringpool-alloc-bytes=9664 D [07/Dec/2017:11:21:57 +0000] Report: stringpool-total-bytes=549816 d [07/Dec/2017:11:21:57 +0000] select_timeout: JobHistoryUpdate=1512722455 d [07/Dec/2017:11:21:57 +0000] select_timeout(0): 76739 seconds to update job history