Hey Roberto,

thanks for the detailed response! 

The thumbnails are beeing displayed in a random order and very slow.
I have attached the logs from the worker when running with supervisor.

The performance difference is huge compared to the runserver standalone.

I really have no idea what could lead to this. I try to record a screen 
video.

Best
Sebastian

Am Mittwoch, 19. April 2017 18:00:44 UTC+2 schrieb Roberto Rosario:
>
> Hi Sebastian,
>
> I'm drawing a blank because it is the same process either way. For example 
> when running using supervisor and using a background worker you can check 
> the output of the worker servicing the converter queue and the same output 
> about `generate_image()` should be displayed. You might need to edit the 
> supervisor line of the worker to add -l DEBUG instead of -l INFO to 
> increase the verbosity. This means that the same logic is being applied to 
> the generation of thumbnails. 
>
> The only thing that comes to mind is that the speed of the message queue 
> is creating an overhead that makes it looks like the thumbnails are being 
> generated.
>
> The process is as follows: 
>
> Frontend will always ask the document model to see if a cached 
> representation (image + transformation[resize, rotation]) exists. The 
> thumbnail generation request travels from the frontend to the celery then 
> to the broker (Redis or Rabbit), then the worker's celery pickups the 
> message from the broker checks to see if a thumbnail is available, 
> generates one if not, sends back the filename of the generated of cached 
> thumbnail back to the worker's celery to the result storage (Redis), the 
> frontend's celery gets the message, decodes it and passes it to the waiting 
> frontend display code.
>
> In DEBUG mode this happens very fast because it is the same process 
> running both sides of the code (frontend and model+converter, minus the 
> broker and result storage).
>
> My guess is that there is a bottleneck in the deployment configuration, 
> broker getting choked, not enough workers, worker not running in multi 
> threaded or multi process mode (servicing messages sequentially), uWSGI 
> process servicinong HTTP requests sequentially and thus showing thumbnails 
> synchronously.
>
> Are the thumbnails being displayed in sequence with one displaying only 
> after the previous one is displayed? Or are they being displayed in random 
> order only slow?
>
> On Tuesday, April 18, 2017 at 8:38:57 AM UTC-4, Sebastian Tänzer wrote:
>>
>> Hello Roberto,
>>
>> sorry for the late response and thanks for the info. I upgraded my 
>> virtualenv/pip setup to the latest git development branch and did some 
>> tests.
>>
>> When running Mayan in the foreground using runserver and Debug=True it 
>> shows this:
>>
>> documents.models <24377> [DEBUG] "generate_image() transformations cache 
>> filename: 
>> page-cache-bd7290ba-4f11-4b1f-ad1d-5a69fdd9a619-77-163-1d20f688585d3c09"
>> documents.models <24377> [DEBUG] "generate_image() transformations cache 
>> file 
>> "page-cache-bd7290ba-4f11-4b1f-ad1d-5a69fdd9a619-77-163-1d20f688585d3c09" 
>> found"
>>
>> and thumbnails are beeing generated really fast and then loaded from 
>> cache the second time.
>>
>> When running Mayan using supervisor/nginx this is not the case. All 
>> thumbs are regenerated everytime.
>>
>> Any ideas why that is?
>>
>> Best
>> Sebastian
>>
>> Am Montag, 20. März 2017 06:43:56 UTC+1 schrieb Roberto Rosario:
>>>
>>> Nothing is needed to use the new thumbnail caching. Enable the DEBUG 
>>> mode by adding this to you settings/local.py file
>>>
>>> DEBUG=True
>>>
>>> Go to a view that shows document images and take a look at the debug 
>>> messages in the console. You should entries like this:
>>>
>>> documents.models <8408> [DEBUG] "generate_image() transformations cache 
>>> file 
>>> "page-cache-bea37f94-57c4-4789-a5b3-f501dc678fcd-24-55-118690ab21ab21be" 
>>> found"
>>>
>>> The long filename is the page UUID followed by the transformations if 
>>> serialized format (zoom, resize, rotation). This means that the page images 
>>> are being cached in their
>>> final resized dimensions. The system still uses a background process to 
>>> check is a document thumbnail is already available and this causes a slight 
>>> overhead (not realtime).
>>> If runing using the `runserver` command the task broker is disabled and 
>>> all background tasks run in the same process as the UI, this will cause the 
>>> appearance that the
>>> thumbnails are being generated from scratch. A screen refresh should 
>>> show that they are not being regenerated and will display faster than the 
>>> first time they displayed,
>>> this should indicate that they are being cached. With this in mind give 
>>> it another try to see a difference. You can also delete all cached images 
>>> using the "Clear document image cache"
>>> button in the Tools menu or by manually deleting all file in the 
>>> mayan/media/document_cache folder and doing a view refresh. The time to 
>>> display the thumbnails should be very 
>>> different in the first and subsequent refreshes.
>>>
>>>
>>>
>>>
>>> On Friday, March 17, 2017 at 8:59:04 AM UTC-4, Sebastian Tänzer wrote:
>>>>
>>>> I managed to perform an upgrade to 2.2b2. 
>>>>
>>>> Is there anything I have to do to use the new thumbnail caching or 
>>>> isn't that implemented yet?
>>>> Thumbnails are still generated with every page call.
>>>>
>>>> Best
>>>> Sebastian
>>>>
>>>>

-- 

--- 
You received this message because you are subscribed to the Google Groups 
"Mayan EDMS" group.
To unsubscribe from this group and stop receiving emails from it, send an email 
to [email protected].
For more options, visit https://groups.google.com/d/optout.
[program:mayan-worker]
command = /usr/share/mayan-edms/bin/python 
/usr/share/mayan-edms/bin/mayan-edms.py celery 
--settings=mayan.settings.production worker -Ofair -l DEBUG
directory = /usr/share/mayan-edms
user = www-data
stdout_logfile = /var/log/mayan/worker-stdout.log
stderr_logfile = /var/log/mayan/worker-stderr.log
autostart = true
autorestart = true
startsecs = 10
stopwaitsecs = 10
killasgroup = true
priority = 998

[program:mayan-beat]
command = /usr/share/mayan-edms/bin/python 
/usr/share/mayan-edms/bin/mayan-edms.py celery 
--settings=mayan.settings.production beat -l DEBUG
directory = /usr/share/mayan-edms
user = www-data
numprocs = 1
stdout_logfile = /var/log/mayan/beat-stdout.log
stderr_logfile = /var/log/mayan/beat-stderr.log
autostart = true
autorestart = true
startsecs = 10
stopwaitsecs = 1
killasgroup = true
priority = 998
root@dms:/var/log/mayan# tail -f worker-stderr.log
[2017-04-19 16:36:04,994: INFO/MainProcess] Received task: 
sources.tasks.task_check_interval_source[13945a37-4a6c-45f7-a112-3bfc5ab7a392]
[2017-04-19 16:36:04,995: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'sources.tasks.task_check_interval_source', 
u'13945a37-4a6c-45f7-a112-3bfc5ab7a392', [], {u'source_id': 4}, {u'utc': True, 
u'is_eager': False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'sources_periodic', u'exchange': u'sources_periodic'}, u'expires': None, 
u'hostname': 'celery@dms', u'task': 
u'sources.tasks.task_check_interval_source', u'callbacks': None, 
u'correlation_id': u'13945a37-4a6c-45f7-a112-3bfc5ab7a392', u'errbacks': None, 
u'timelimit': [None, None], u'taskset': None, u'kwargs': {u'source_id': 4}, 
u'eta': None, u'reply_to': u'1ef307a8-f3cd-3f83-926f-43b7bac1e024', u'id': 
u'13945a37-4a6c-45f7-a112-3bfc5ab7a392', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:04,997: DEBUG/MainProcess] Task accepted: 
sources.tasks.task_check_interval_source[13945a37-4a6c-45f7-a112-3bfc5ab7a392] 
pid:18311
[2017-04-19 16:36:05,001: INFO/MainProcess] Received task: 
sources.tasks.task_check_interval_source[723c0939-b8ec-4049-bcf6-84e7e49ca8d0]
[2017-04-19 16:36:05,002: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'sources.tasks.task_check_interval_source', 
u'723c0939-b8ec-4049-bcf6-84e7e49ca8d0', [], {u'source_id': 5}, {u'utc': True, 
u'is_eager': False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'sources_periodic', u'exchange': u'sources_periodic'}, u'expires': None, 
u'hostname': 'celery@dms', u'task': 
u'sources.tasks.task_check_interval_source', u'callbacks': None, 
u'correlation_id': u'723c0939-b8ec-4049-bcf6-84e7e49ca8d0', u'errbacks': None, 
u'timelimit': [None, None], u'taskset': None, u'kwargs': {u'source_id': 5}, 
u'eta': None, u'reply_to': u'1ef307a8-f3cd-3f83-926f-43b7bac1e024', u'id': 
u'723c0939-b8ec-4049-bcf6-84e7e49ca8d0', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:05,004: DEBUG/MainProcess] Task accepted: 
sources.tasks.task_check_interval_source[723c0939-b8ec-4049-bcf6-84e7e49ca8d0] 
pid:18312
[2017-04-19 16:36:05,008: INFO/MainProcess] Task 
sources.tasks.task_check_interval_source[794885ba-0ff3-49cb-9ea4-f3634bc7acbc] 
succeeded in 0.0288705872372s: None
[2017-04-19 16:36:05,009: INFO/MainProcess] Task 
sources.tasks.task_check_interval_source[9285db8b-1f19-435c-abad-a68e20b4d639] 
succeeded in 0.0194148332812s: None
[2017-04-19 16:36:05,017: INFO/MainProcess] Task 
sources.tasks.task_check_interval_source[13945a37-4a6c-45f7-a112-3bfc5ab7a392] 
succeeded in 0.0204632040113s: None
[2017-04-19 16:36:05,022: INFO/MainProcess] Task 
sources.tasks.task_check_interval_source[723c0939-b8ec-4049-bcf6-84e7e49ca8d0] 
succeeded in 0.018483008258s: None
[2017-04-19 16:36:14,978: INFO/MainProcess] Received task: 
sources.tasks.task_check_interval_source[0b1b0f6b-2b30-4d0d-9441-2551a88ce927]
[2017-04-19 16:36:14,979: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'sources.tasks.task_check_interval_source', 
u'0b1b0f6b-2b30-4d0d-9441-2551a88ce927', [], {u'source_id': 2}, {u'utc': True, 
u'is_eager': False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'sources_periodic', u'exchange': u'sources_periodic'}, u'expires': None, 
u'hostname': 'celery@dms', u'task': 
u'sources.tasks.task_check_interval_source', u'callbacks': None, 
u'correlation_id': u'0b1b0f6b-2b30-4d0d-9441-2551a88ce927', u'errbacks': None, 
u'timelimit': [None, None], u'taskset': None, u'kwargs': {u'source_id': 2}, 
u'eta': None, u'reply_to': u'1ef307a8-f3cd-3f83-926f-43b7bac1e024', u'id': 
u'0b1b0f6b-2b30-4d0d-9441-2551a88ce927', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:14,982: DEBUG/MainProcess] Task accepted: 
sources.tasks.task_check_interval_source[0b1b0f6b-2b30-4d0d-9441-2551a88ce927] 
pid:18312
[2017-04-19 16:36:14,989: INFO/MainProcess] Received task: 
sources.tasks.task_check_interval_source[6da593bd-9937-4d44-a5ba-a0fb68401a74]
[2017-04-19 16:36:14,990: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'sources.tasks.task_check_interval_source', 
u'6da593bd-9937-4d44-a5ba-a0fb68401a74', [], {u'source_id': 3}, {u'utc': True, 
u'is_eager': False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'sources_periodic', u'exchange': u'sources_periodic'}, u'expires': None, 
u'hostname': 'celery@dms', u'task': 
u'sources.tasks.task_check_interval_source', u'callbacks': None, 
u'correlation_id': u'6da593bd-9937-4d44-a5ba-a0fb68401a74', u'errbacks': None, 
u'timelimit': [None, None], u'taskset': None, u'kwargs': {u'source_id': 3}, 
u'eta': None, u'reply_to': u'1ef307a8-f3cd-3f83-926f-43b7bac1e024', u'id': 
u'6da593bd-9937-4d44-a5ba-a0fb68401a74', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:14,996: DEBUG/MainProcess] Task accepted: 
sources.tasks.task_check_interval_source[6da593bd-9937-4d44-a5ba-a0fb68401a74] 
pid:18313
[2017-04-19 16:36:14,997: INFO/MainProcess] Received task: 
sources.tasks.task_check_interval_source[adee0cb9-6d05-415d-ab52-00100c8688f6]
[2017-04-19 16:36:14,997: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'sources.tasks.task_check_interval_source', 
u'adee0cb9-6d05-415d-ab52-00100c8688f6', [], {u'source_id': 4}, {u'utc': True, 
u'is_eager': False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'sources_periodic', u'exchange': u'sources_periodic'}, u'expires': None, 
u'hostname': 'celery@dms', u'task': 
u'sources.tasks.task_check_interval_source', u'callbacks': None, 
u'correlation_id': u'adee0cb9-6d05-415d-ab52-00100c8688f6', u'errbacks': None, 
u'timelimit': [None, None], u'taskset': None, u'kwargs': {u'source_id': 4}, 
u'eta': None, u'reply_to': u'1ef307a8-f3cd-3f83-926f-43b7bac1e024', u'id': 
u'adee0cb9-6d05-415d-ab52-00100c8688f6', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:14,999: DEBUG/MainProcess] Task accepted: 
sources.tasks.task_check_interval_source[adee0cb9-6d05-415d-ab52-00100c8688f6] 
pid:18314
[2017-04-19 16:36:15,004: INFO/MainProcess] Task 
sources.tasks.task_check_interval_source[0b1b0f6b-2b30-4d0d-9441-2551a88ce927] 
succeeded in 0.023863018956s: None
[2017-04-19 16:36:15,006: INFO/MainProcess] Received task: 
sources.tasks.task_check_interval_source[242aa449-9713-4fbf-bdad-aa87d2fc58b2]
[2017-04-19 16:36:15,007: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'sources.tasks.task_check_interval_source', 
u'242aa449-9713-4fbf-bdad-aa87d2fc58b2', [], {u'source_id': 5}, {u'utc': True, 
u'is_eager': False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'sources_periodic', u'exchange': u'sources_periodic'}, u'expires': None, 
u'hostname': 'celery@dms', u'task': 
u'sources.tasks.task_check_interval_source', u'callbacks': None, 
u'correlation_id': u'242aa449-9713-4fbf-bdad-aa87d2fc58b2', u'errbacks': None, 
u'timelimit': [None, None], u'taskset': None, u'kwargs': {u'source_id': 5}, 
u'eta': None, u'reply_to': u'1ef307a8-f3cd-3f83-926f-43b7bac1e024', u'id': 
u'242aa449-9713-4fbf-bdad-aa87d2fc58b2', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:15,012: DEBUG/MainProcess] Task accepted: 
sources.tasks.task_check_interval_source[242aa449-9713-4fbf-bdad-aa87d2fc58b2] 
pid:18311
[2017-04-19 16:36:15,013: INFO/MainProcess] Task 
sources.tasks.task_check_interval_source[6da593bd-9937-4d44-a5ba-a0fb68401a74] 
succeeded in 0.0218216688372s: None
[2017-04-19 16:36:15,021: INFO/MainProcess] Task 
sources.tasks.task_check_interval_source[adee0cb9-6d05-415d-ab52-00100c8688f6] 
succeeded in 0.0223450893536s: None
[2017-04-19 16:36:15,028: INFO/MainProcess] Task 
sources.tasks.task_check_interval_source[242aa449-9713-4fbf-bdad-aa87d2fc58b2] 
succeeded in 0.0196546162479s: None
[2017-04-19 16:36:17,010: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[f3bd0f2b-af90-4993-84db-9fe63f9bc1cd]
[2017-04-19 16:36:17,010: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'f3bd0f2b-af90-4993-84db-9fe63f9bc1cd', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'283', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'f3bd0f2b-af90-4993-84db-9fe63f9bc1cd', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'283', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'f3bd0f2b-af90-4993-84db-9fe63f9bc1cd', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:17,014: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[f3bd0f2b-af90-4993-84db-9fe63f9bc1cd]
 pid:18312
documents.models <18312> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-1e1bf880-9cfe-489c-bf31-59284b3680d2-122-283-1d20f688585d3c09"
[2017-04-19 16:36:17,028: DEBUG/Worker-2] transformations cache filename: 
page-cache-1e1bf880-9cfe-489c-bf31-59284b3680d2-122-283-1d20f688585d3c09
documents.models <18312> [DEBUG] "generate_image() transformations cache file 
"page-cache-1e1bf880-9cfe-489c-bf31-59284b3680d2-122-283-1d20f688585d3c09" 
found"
[2017-04-19 16:36:17,028: DEBUG/Worker-2] transformations cache file 
"page-cache-1e1bf880-9cfe-489c-bf31-59284b3680d2-122-283-1d20f688585d3c09" found
[2017-04-19 16:36:17,030: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[f3bd0f2b-af90-4993-84db-9fe63f9bc1cd]
 succeeded in 0.0174716426991s: 
u'page-cache-1e1bf880-9cfe-489c-bf31-59284b3680d2-122-283-1d20f688585d3c09'
[2017-04-19 16:36:17,529: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[9c98c79c-926b-4a11-8002-4a3871aadf15]
[2017-04-19 16:36:17,530: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'9c98c79c-926b-4a11-8002-4a3871aadf15', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'281', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'9c98c79c-926b-4a11-8002-4a3871aadf15', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'281', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'9c98c79c-926b-4a11-8002-4a3871aadf15', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:17,533: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[9c98c79c-926b-4a11-8002-4a3871aadf15]
 pid:18313
documents.models <18313> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-a0386100-3a05-4333-a3c2-a51792aa3678-121-281-1d20f688585d3c09"
[2017-04-19 16:36:17,546: DEBUG/Worker-3] transformations cache filename: 
page-cache-a0386100-3a05-4333-a3c2-a51792aa3678-121-281-1d20f688585d3c09
documents.models <18313> [DEBUG] "generate_image() transformations cache file 
"page-cache-a0386100-3a05-4333-a3c2-a51792aa3678-121-281-1d20f688585d3c09" 
found"
[2017-04-19 16:36:17,547: DEBUG/Worker-3] transformations cache file 
"page-cache-a0386100-3a05-4333-a3c2-a51792aa3678-121-281-1d20f688585d3c09" found
[2017-04-19 16:36:17,549: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[9c98c79c-926b-4a11-8002-4a3871aadf15]
 succeeded in 0.0180228208192s: 
u'page-cache-a0386100-3a05-4333-a3c2-a51792aa3678-121-281-1d20f688585d3c09'
[2017-04-19 16:36:18,044: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[0980c4a7-0ec7-4636-8059-fa99df5992ff]
[2017-04-19 16:36:18,045: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'0980c4a7-0ec7-4636-8059-fa99df5992ff', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'279', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'0980c4a7-0ec7-4636-8059-fa99df5992ff', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'279', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'0980c4a7-0ec7-4636-8059-fa99df5992ff', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:18,047: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[0980c4a7-0ec7-4636-8059-fa99df5992ff]
 pid:18314
documents.models <18314> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-cb2019f8-c652-4f1f-a570-563bb0147ba4-120-279-1d20f688585d3c09"
[2017-04-19 16:36:18,062: DEBUG/Worker-4] transformations cache filename: 
page-cache-cb2019f8-c652-4f1f-a570-563bb0147ba4-120-279-1d20f688585d3c09
documents.models <18314> [DEBUG] "generate_image() transformations cache file 
"page-cache-cb2019f8-c652-4f1f-a570-563bb0147ba4-120-279-1d20f688585d3c09" 
found"
[2017-04-19 16:36:18,062: DEBUG/Worker-4] transformations cache file 
"page-cache-cb2019f8-c652-4f1f-a570-563bb0147ba4-120-279-1d20f688585d3c09" found
[2017-04-19 16:36:18,064: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[0980c4a7-0ec7-4636-8059-fa99df5992ff]
 succeeded in 0.0180127071217s: 
u'page-cache-cb2019f8-c652-4f1f-a570-563bb0147ba4-120-279-1d20f688585d3c09'
[2017-04-19 16:36:18,562: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[6b5f7f78-c00f-469d-b15e-a7fbeda648b0]
[2017-04-19 16:36:18,562: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'6b5f7f78-c00f-469d-b15e-a7fbeda648b0', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'278', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'6b5f7f78-c00f-469d-b15e-a7fbeda648b0', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'278', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'6b5f7f78-c00f-469d-b15e-a7fbeda648b0', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:18,563: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[6b5f7f78-c00f-469d-b15e-a7fbeda648b0]
 pid:18311
documents.models <18311> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-663fadc1-9229-443c-b6db-eb7601d38d37-119-278-1d20f688585d3c09"
[2017-04-19 16:36:18,578: DEBUG/Worker-1] transformations cache filename: 
page-cache-663fadc1-9229-443c-b6db-eb7601d38d37-119-278-1d20f688585d3c09
documents.models <18311> [DEBUG] "generate_image() transformations cache file 
"page-cache-663fadc1-9229-443c-b6db-eb7601d38d37-119-278-1d20f688585d3c09" 
found"
[2017-04-19 16:36:18,578: DEBUG/Worker-1] transformations cache file 
"page-cache-663fadc1-9229-443c-b6db-eb7601d38d37-119-278-1d20f688585d3c09" found
[2017-04-19 16:36:18,580: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[6b5f7f78-c00f-469d-b15e-a7fbeda648b0]
 succeeded in 0.017308622133s: 
u'page-cache-663fadc1-9229-443c-b6db-eb7601d38d37-119-278-1d20f688585d3c09'
[2017-04-19 16:36:19,079: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[9432b887-dbcc-429e-980c-2a5f2e0e782b]
[2017-04-19 16:36:19,079: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'9432b887-dbcc-429e-980c-2a5f2e0e782b', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'277', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'9432b887-dbcc-429e-980c-2a5f2e0e782b', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'277', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'9432b887-dbcc-429e-980c-2a5f2e0e782b', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:19,081: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[9432b887-dbcc-429e-980c-2a5f2e0e782b]
 pid:18312
documents.models <18312> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-d190e3bd-b857-40b6-8d07-51dc67fc0f7b-118-277-1d20f688585d3c09"
[2017-04-19 16:36:19,092: DEBUG/Worker-2] transformations cache filename: 
page-cache-d190e3bd-b857-40b6-8d07-51dc67fc0f7b-118-277-1d20f688585d3c09
documents.models <18312> [DEBUG] "generate_image() transformations cache file 
"page-cache-d190e3bd-b857-40b6-8d07-51dc67fc0f7b-118-277-1d20f688585d3c09" 
found"
[2017-04-19 16:36:19,092: DEBUG/Worker-2] transformations cache file 
"page-cache-d190e3bd-b857-40b6-8d07-51dc67fc0f7b-118-277-1d20f688585d3c09" found
[2017-04-19 16:36:19,093: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[9432b887-dbcc-429e-980c-2a5f2e0e782b]
 succeeded in 0.0136935380287s: 
u'page-cache-d190e3bd-b857-40b6-8d07-51dc67fc0f7b-118-277-1d20f688585d3c09'
[2017-04-19 16:36:19,594: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[5558e4a5-3b8d-47b4-8e2f-d35fabe36e26]
[2017-04-19 16:36:19,594: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'5558e4a5-3b8d-47b4-8e2f-d35fabe36e26', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'276', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'5558e4a5-3b8d-47b4-8e2f-d35fabe36e26', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'276', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'5558e4a5-3b8d-47b4-8e2f-d35fabe36e26', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:19,596: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[5558e4a5-3b8d-47b4-8e2f-d35fabe36e26]
 pid:18313
documents.models <18313> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-d8848eeb-5207-40a7-9ff8-bf5f0810bd95-117-276-1d20f688585d3c09"
[2017-04-19 16:36:19,608: DEBUG/Worker-3] transformations cache filename: 
page-cache-d8848eeb-5207-40a7-9ff8-bf5f0810bd95-117-276-1d20f688585d3c09
documents.models <18313> [DEBUG] "generate_image() transformations cache file 
"page-cache-d8848eeb-5207-40a7-9ff8-bf5f0810bd95-117-276-1d20f688585d3c09" 
found"
[2017-04-19 16:36:19,608: DEBUG/Worker-3] transformations cache file 
"page-cache-d8848eeb-5207-40a7-9ff8-bf5f0810bd95-117-276-1d20f688585d3c09" found
[2017-04-19 16:36:19,610: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[5558e4a5-3b8d-47b4-8e2f-d35fabe36e26]
 succeeded in 0.0139001733623s: 
u'page-cache-d8848eeb-5207-40a7-9ff8-bf5f0810bd95-117-276-1d20f688585d3c09'
[2017-04-19 16:36:20,109: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[483efc79-c7c7-43f7-9011-90d96eb30d18]
[2017-04-19 16:36:20,109: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'483efc79-c7c7-43f7-9011-90d96eb30d18', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'273', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'483efc79-c7c7-43f7-9011-90d96eb30d18', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'273', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'483efc79-c7c7-43f7-9011-90d96eb30d18', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:20,110: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[483efc79-c7c7-43f7-9011-90d96eb30d18]
 pid:18314
documents.models <18314> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-91635a70-1d0d-4879-9fb9-68a53449ea09-116-273-1d20f688585d3c09"
[2017-04-19 16:36:20,123: DEBUG/Worker-4] transformations cache filename: 
page-cache-91635a70-1d0d-4879-9fb9-68a53449ea09-116-273-1d20f688585d3c09
documents.models <18314> [DEBUG] "generate_image() transformations cache file 
"page-cache-91635a70-1d0d-4879-9fb9-68a53449ea09-116-273-1d20f688585d3c09" 
found"
[2017-04-19 16:36:20,123: DEBUG/Worker-4] transformations cache file 
"page-cache-91635a70-1d0d-4879-9fb9-68a53449ea09-116-273-1d20f688585d3c09" found
[2017-04-19 16:36:20,124: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[483efc79-c7c7-43f7-9011-90d96eb30d18]
 succeeded in 0.0139701813459s: 
u'page-cache-91635a70-1d0d-4879-9fb9-68a53449ea09-116-273-1d20f688585d3c09'
[2017-04-19 16:36:20,625: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[e505d9b2-b26c-48c3-8f86-97d446600271]
[2017-04-19 16:36:20,626: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'e505d9b2-b26c-48c3-8f86-97d446600271', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'271', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'e505d9b2-b26c-48c3-8f86-97d446600271', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'271', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'e505d9b2-b26c-48c3-8f86-97d446600271', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:20,627: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[e505d9b2-b26c-48c3-8f86-97d446600271]
 pid:18311
documents.models <18311> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-fbd35dba-94c2-4b9d-9269-f4e904d419d3-115-271-1d20f688585d3c09"
[2017-04-19 16:36:20,639: DEBUG/Worker-1] transformations cache filename: 
page-cache-fbd35dba-94c2-4b9d-9269-f4e904d419d3-115-271-1d20f688585d3c09
documents.models <18311> [DEBUG] "generate_image() transformations cache file 
"page-cache-fbd35dba-94c2-4b9d-9269-f4e904d419d3-115-271-1d20f688585d3c09" 
found"
[2017-04-19 16:36:20,639: DEBUG/Worker-1] transformations cache file 
"page-cache-fbd35dba-94c2-4b9d-9269-f4e904d419d3-115-271-1d20f688585d3c09" found
[2017-04-19 16:36:20,640: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[e505d9b2-b26c-48c3-8f86-97d446600271]
 succeeded in 0.0139702507295s: 
u'page-cache-fbd35dba-94c2-4b9d-9269-f4e904d419d3-115-271-1d20f688585d3c09'
[2017-04-19 16:36:21,144: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[2b1ed164-a4a2-42f2-a06a-5655012ab63c]
[2017-04-19 16:36:21,144: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'2b1ed164-a4a2-42f2-a06a-5655012ab63c', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'266', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'2b1ed164-a4a2-42f2-a06a-5655012ab63c', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'266', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'2b1ed164-a4a2-42f2-a06a-5655012ab63c', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:21,147: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[2b1ed164-a4a2-42f2-a06a-5655012ab63c]
 pid:18312
documents.models <18312> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-b89b7e77-949d-4d18-8644-824eb52a3ce0-114-266-1d20f688585d3c09"
[2017-04-19 16:36:21,157: DEBUG/Worker-2] transformations cache filename: 
page-cache-b89b7e77-949d-4d18-8644-824eb52a3ce0-114-266-1d20f688585d3c09
documents.models <18312> [DEBUG] "generate_image() transformations cache file 
"page-cache-b89b7e77-949d-4d18-8644-824eb52a3ce0-114-266-1d20f688585d3c09" 
found"
[2017-04-19 16:36:21,158: DEBUG/Worker-2] transformations cache file 
"page-cache-b89b7e77-949d-4d18-8644-824eb52a3ce0-114-266-1d20f688585d3c09" found
[2017-04-19 16:36:21,159: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[2b1ed164-a4a2-42f2-a06a-5655012ab63c]
 succeeded in 0.0135479071178s: 
u'page-cache-b89b7e77-949d-4d18-8644-824eb52a3ce0-114-266-1d20f688585d3c09'
[2017-04-19 16:36:21,664: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[f0cf5b62-feb1-48bb-a110-e7f5eb782ef2]
[2017-04-19 16:36:21,664: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'f0cf5b62-feb1-48bb-a110-e7f5eb782ef2', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'265', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'f0cf5b62-feb1-48bb-a110-e7f5eb782ef2', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'265', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'f0cf5b62-feb1-48bb-a110-e7f5eb782ef2', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:21,666: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[f0cf5b62-feb1-48bb-a110-e7f5eb782ef2]
 pid:18313
documents.models <18313> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-98cbbe94-5bf4-4914-ad14-a83d45e26a23-113-265-1d20f688585d3c09"
[2017-04-19 16:36:21,678: DEBUG/Worker-3] transformations cache filename: 
page-cache-98cbbe94-5bf4-4914-ad14-a83d45e26a23-113-265-1d20f688585d3c09
documents.models <18313> [DEBUG] "generate_image() transformations cache file 
"page-cache-98cbbe94-5bf4-4914-ad14-a83d45e26a23-113-265-1d20f688585d3c09" 
found"
[2017-04-19 16:36:21,678: DEBUG/Worker-3] transformations cache file 
"page-cache-98cbbe94-5bf4-4914-ad14-a83d45e26a23-113-265-1d20f688585d3c09" found
[2017-04-19 16:36:21,679: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[f0cf5b62-feb1-48bb-a110-e7f5eb782ef2]
 succeeded in 0.0137621699832s: 
u'page-cache-98cbbe94-5bf4-4914-ad14-a83d45e26a23-113-265-1d20f688585d3c09'
[2017-04-19 16:36:22,179: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[0556893c-bc9d-4c69-88e7-5f699b4d8d1c]
[2017-04-19 16:36:22,180: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'0556893c-bc9d-4c69-88e7-5f699b4d8d1c', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'264', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'0556893c-bc9d-4c69-88e7-5f699b4d8d1c', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'264', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'0556893c-bc9d-4c69-88e7-5f699b4d8d1c', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:22,183: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[0556893c-bc9d-4c69-88e7-5f699b4d8d1c]
 pid:18314
documents.models <18314> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-c6a7869b-4327-4ea3-940e-ea5970804fff-112-264-1d20f688585d3c09"
[2017-04-19 16:36:22,193: DEBUG/Worker-4] transformations cache filename: 
page-cache-c6a7869b-4327-4ea3-940e-ea5970804fff-112-264-1d20f688585d3c09
documents.models <18314> [DEBUG] "generate_image() transformations cache file 
"page-cache-c6a7869b-4327-4ea3-940e-ea5970804fff-112-264-1d20f688585d3c09" 
found"
[2017-04-19 16:36:22,194: DEBUG/Worker-4] transformations cache file 
"page-cache-c6a7869b-4327-4ea3-940e-ea5970804fff-112-264-1d20f688585d3c09" found
[2017-04-19 16:36:22,195: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[0556893c-bc9d-4c69-88e7-5f699b4d8d1c]
 succeeded in 0.0133433286101s: 
u'page-cache-c6a7869b-4327-4ea3-940e-ea5970804fff-112-264-1d20f688585d3c09'
[2017-04-19 16:36:22,694: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[04f90a9d-5174-488d-81f0-da739f5e9168]
[2017-04-19 16:36:22,694: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'04f90a9d-5174-488d-81f0-da739f5e9168', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'259', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'04f90a9d-5174-488d-81f0-da739f5e9168', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'259', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'04f90a9d-5174-488d-81f0-da739f5e9168', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:22,696: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[04f90a9d-5174-488d-81f0-da739f5e9168]
 pid:18311
documents.models <18311> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-d360c642-6df0-45c1-bb2c-4d8698eb109a-111-259-1d20f688585d3c09"
[2017-04-19 16:36:22,708: DEBUG/Worker-1] transformations cache filename: 
page-cache-d360c642-6df0-45c1-bb2c-4d8698eb109a-111-259-1d20f688585d3c09
documents.models <18311> [DEBUG] "generate_image() transformations cache file 
"page-cache-d360c642-6df0-45c1-bb2c-4d8698eb109a-111-259-1d20f688585d3c09" 
found"
[2017-04-19 16:36:22,708: DEBUG/Worker-1] transformations cache file 
"page-cache-d360c642-6df0-45c1-bb2c-4d8698eb109a-111-259-1d20f688585d3c09" found
[2017-04-19 16:36:22,709: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[04f90a9d-5174-488d-81f0-da739f5e9168]
 succeeded in 0.0140392123722s: 
u'page-cache-d360c642-6df0-45c1-bb2c-4d8698eb109a-111-259-1d20f688585d3c09'
[2017-04-19 16:36:23,212: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[2dba89d5-7e10-462d-9cb5-2cf34470d618]
[2017-04-19 16:36:23,212: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'2dba89d5-7e10-462d-9cb5-2cf34470d618', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'255', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'2dba89d5-7e10-462d-9cb5-2cf34470d618', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'255', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'2dba89d5-7e10-462d-9cb5-2cf34470d618', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:23,214: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[2dba89d5-7e10-462d-9cb5-2cf34470d618]
 pid:18312
documents.models <18312> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-121bf801-7f73-4500-a398-c838943a5ea5-110-255-1d20f688585d3c09"
[2017-04-19 16:36:23,225: DEBUG/Worker-2] transformations cache filename: 
page-cache-121bf801-7f73-4500-a398-c838943a5ea5-110-255-1d20f688585d3c09
documents.models <18312> [DEBUG] "generate_image() transformations cache file 
"page-cache-121bf801-7f73-4500-a398-c838943a5ea5-110-255-1d20f688585d3c09" 
found"
[2017-04-19 16:36:23,225: DEBUG/Worker-2] transformations cache file 
"page-cache-121bf801-7f73-4500-a398-c838943a5ea5-110-255-1d20f688585d3c09" found
[2017-04-19 16:36:23,227: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[2dba89d5-7e10-462d-9cb5-2cf34470d618]
 succeeded in 0.0135026462376s: 
u'page-cache-121bf801-7f73-4500-a398-c838943a5ea5-110-255-1d20f688585d3c09'
[2017-04-19 16:36:23,730: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[de08bccc-cb38-4e04-a3c2-75127726d394]
[2017-04-19 16:36:23,730: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'de08bccc-cb38-4e04-a3c2-75127726d394', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'241', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'de08bccc-cb38-4e04-a3c2-75127726d394', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'241', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'de08bccc-cb38-4e04-a3c2-75127726d394', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:23,732: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[de08bccc-cb38-4e04-a3c2-75127726d394]
 pid:18313
documents.models <18313> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-eae42f58-e4c1-4cd8-bdae-b1fb11aa7a46-108-241-1d20f688585d3c09"
[2017-04-19 16:36:23,743: DEBUG/Worker-3] transformations cache filename: 
page-cache-eae42f58-e4c1-4cd8-bdae-b1fb11aa7a46-108-241-1d20f688585d3c09
documents.models <18313> [DEBUG] "generate_image() transformations cache file 
"page-cache-eae42f58-e4c1-4cd8-bdae-b1fb11aa7a46-108-241-1d20f688585d3c09" 
found"
[2017-04-19 16:36:23,744: DEBUG/Worker-3] transformations cache file 
"page-cache-eae42f58-e4c1-4cd8-bdae-b1fb11aa7a46-108-241-1d20f688585d3c09" found
[2017-04-19 16:36:23,745: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[de08bccc-cb38-4e04-a3c2-75127726d394]
 succeeded in 0.0136710195802s: 
u'page-cache-eae42f58-e4c1-4cd8-bdae-b1fb11aa7a46-108-241-1d20f688585d3c09'
[2017-04-19 16:36:24,245: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[870be8a4-77e4-4b67-8672-e78079dcf9d2]
[2017-04-19 16:36:24,246: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'870be8a4-77e4-4b67-8672-e78079dcf9d2', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'240', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'870be8a4-77e4-4b67-8672-e78079dcf9d2', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'240', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'870be8a4-77e4-4b67-8672-e78079dcf9d2', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:24,248: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[870be8a4-77e4-4b67-8672-e78079dcf9d2]
 pid:18314
documents.models <18314> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-8c221e2e-b5f9-4c62-baff-76e62a69a6e2-107-240-1d20f688585d3c09"
[2017-04-19 16:36:24,259: DEBUG/Worker-4] transformations cache filename: 
page-cache-8c221e2e-b5f9-4c62-baff-76e62a69a6e2-107-240-1d20f688585d3c09
documents.models <18314> [DEBUG] "generate_image() transformations cache file 
"page-cache-8c221e2e-b5f9-4c62-baff-76e62a69a6e2-107-240-1d20f688585d3c09" 
found"
[2017-04-19 16:36:24,260: DEBUG/Worker-4] transformations cache file 
"page-cache-8c221e2e-b5f9-4c62-baff-76e62a69a6e2-107-240-1d20f688585d3c09" found
[2017-04-19 16:36:24,261: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[870be8a4-77e4-4b67-8672-e78079dcf9d2]
 succeeded in 0.0139886499383s: 
u'page-cache-8c221e2e-b5f9-4c62-baff-76e62a69a6e2-107-240-1d20f688585d3c09'
[2017-04-19 16:36:24,979: INFO/MainProcess] Received task: 
sources.tasks.task_check_interval_source[de264ff9-6fac-47a7-93f5-4dfd46240fa6]
[2017-04-19 16:36:24,979: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'sources.tasks.task_check_interval_source', 
u'de264ff9-6fac-47a7-93f5-4dfd46240fa6', [], {u'source_id': 2}, {u'utc': True, 
u'is_eager': False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'sources_periodic', u'exchange': u'sources_periodic'}, u'expires': None, 
u'hostname': 'celery@dms', u'task': 
u'sources.tasks.task_check_interval_source', u'callbacks': None, 
u'correlation_id': u'de264ff9-6fac-47a7-93f5-4dfd46240fa6', u'errbacks': None, 
u'timelimit': [None, None], u'taskset': None, u'kwargs': {u'source_id': 2}, 
u'eta': None, u'reply_to': u'1ef307a8-f3cd-3f83-926f-43b7bac1e024', u'id': 
u'de264ff9-6fac-47a7-93f5-4dfd46240fa6', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:24,981: DEBUG/MainProcess] Task accepted: 
sources.tasks.task_check_interval_source[de264ff9-6fac-47a7-93f5-4dfd46240fa6] 
pid:18311
[2017-04-19 16:36:24,990: INFO/MainProcess] Received task: 
sources.tasks.task_check_interval_source[c5c53db1-0968-4ba6-86b1-10cb3c28d32f]
[2017-04-19 16:36:24,990: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'sources.tasks.task_check_interval_source', 
u'c5c53db1-0968-4ba6-86b1-10cb3c28d32f', [], {u'source_id': 3}, {u'utc': True, 
u'is_eager': False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'sources_periodic', u'exchange': u'sources_periodic'}, u'expires': None, 
u'hostname': 'celery@dms', u'task': 
u'sources.tasks.task_check_interval_source', u'callbacks': None, 
u'correlation_id': u'c5c53db1-0968-4ba6-86b1-10cb3c28d32f', u'errbacks': None, 
u'timelimit': [None, None], u'taskset': None, u'kwargs': {u'source_id': 3}, 
u'eta': None, u'reply_to': u'1ef307a8-f3cd-3f83-926f-43b7bac1e024', u'id': 
u'c5c53db1-0968-4ba6-86b1-10cb3c28d32f', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:24,991: DEBUG/MainProcess] Task accepted: 
sources.tasks.task_check_interval_source[c5c53db1-0968-4ba6-86b1-10cb3c28d32f] 
pid:18312
[2017-04-19 16:36:25,000: INFO/MainProcess] Received task: 
sources.tasks.task_check_interval_source[453c6275-a1fa-4727-8f55-ca7e22d965e6]
[2017-04-19 16:36:25,000: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'sources.tasks.task_check_interval_source', 
u'453c6275-a1fa-4727-8f55-ca7e22d965e6', [], {u'source_id': 4}, {u'utc': True, 
u'is_eager': False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'sources_periodic', u'exchange': u'sources_periodic'}, u'expires': None, 
u'hostname': 'celery@dms', u'task': 
u'sources.tasks.task_check_interval_source', u'callbacks': None, 
u'correlation_id': u'453c6275-a1fa-4727-8f55-ca7e22d965e6', u'errbacks': None, 
u'timelimit': [None, None], u'taskset': None, u'kwargs': {u'source_id': 4}, 
u'eta': None, u'reply_to': u'1ef307a8-f3cd-3f83-926f-43b7bac1e024', u'id': 
u'453c6275-a1fa-4727-8f55-ca7e22d965e6', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:25,002: DEBUG/MainProcess] Task accepted: 
sources.tasks.task_check_interval_source[453c6275-a1fa-4727-8f55-ca7e22d965e6] 
pid:18313
[2017-04-19 16:36:25,002: INFO/MainProcess] Task 
sources.tasks.task_check_interval_source[de264ff9-6fac-47a7-93f5-4dfd46240fa6] 
succeeded in 0.0221170852892s: None
[2017-04-19 16:36:25,007: INFO/MainProcess] Received task: 
sources.tasks.task_check_interval_source[07358935-892c-4faf-8fe7-fe4ea4eff6ec]
[2017-04-19 16:36:25,008: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'sources.tasks.task_check_interval_source', 
u'07358935-892c-4faf-8fe7-fe4ea4eff6ec', [], {u'source_id': 5}, {u'utc': True, 
u'is_eager': False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'sources_periodic', u'exchange': u'sources_periodic'}, u'expires': None, 
u'hostname': 'celery@dms', u'task': 
u'sources.tasks.task_check_interval_source', u'callbacks': None, 
u'correlation_id': u'07358935-892c-4faf-8fe7-fe4ea4eff6ec', u'errbacks': None, 
u'timelimit': [None, None], u'taskset': None, u'kwargs': {u'source_id': 5}, 
u'eta': None, u'reply_to': u'1ef307a8-f3cd-3f83-926f-43b7bac1e024', u'id': 
u'07358935-892c-4faf-8fe7-fe4ea4eff6ec', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:25,010: DEBUG/MainProcess] Task accepted: 
sources.tasks.task_check_interval_source[07358935-892c-4faf-8fe7-fe4ea4eff6ec] 
pid:18314
[2017-04-19 16:36:25,014: INFO/MainProcess] Task 
sources.tasks.task_check_interval_source[c5c53db1-0968-4ba6-86b1-10cb3c28d32f] 
succeeded in 0.0234835785814s: None
[2017-04-19 16:36:25,023: INFO/MainProcess] Task 
sources.tasks.task_check_interval_source[453c6275-a1fa-4727-8f55-ca7e22d965e6] 
succeeded in 0.0213828249834s: None
[2017-04-19 16:36:25,030: INFO/MainProcess] Task 
sources.tasks.task_check_interval_source[07358935-892c-4faf-8fe7-fe4ea4eff6ec] 
succeeded in 0.0207879999653s: None
[2017-04-19 16:36:25,412: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[dcf4bcc4-146b-42b8-8555-f6f86e606bb7]
[2017-04-19 16:36:25,412: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'dcf4bcc4-146b-42b8-8555-f6f86e606bb7', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'238', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'dcf4bcc4-146b-42b8-8555-f6f86e606bb7', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'238', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'dcf4bcc4-146b-42b8-8555-f6f86e606bb7', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:25,414: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[dcf4bcc4-146b-42b8-8555-f6f86e606bb7]
 pid:18311
documents.models <18311> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-55bc63fa-8985-4690-8b69-e35a24a7407f-106-238-1d20f688585d3c09"
[2017-04-19 16:36:25,425: DEBUG/Worker-1] transformations cache filename: 
page-cache-55bc63fa-8985-4690-8b69-e35a24a7407f-106-238-1d20f688585d3c09
documents.models <18311> [DEBUG] "generate_image() transformations cache file 
"page-cache-55bc63fa-8985-4690-8b69-e35a24a7407f-106-238-1d20f688585d3c09" 
found"
[2017-04-19 16:36:25,426: DEBUG/Worker-1] transformations cache file 
"page-cache-55bc63fa-8985-4690-8b69-e35a24a7407f-106-238-1d20f688585d3c09" found
[2017-04-19 16:36:25,427: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[dcf4bcc4-146b-42b8-8555-f6f86e606bb7]
 succeeded in 0.014019377064s: 
u'page-cache-55bc63fa-8985-4690-8b69-e35a24a7407f-106-238-1d20f688585d3c09'
[2017-04-19 16:36:25,930: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[b513e8d9-92f5-4ea9-bf1b-e076d75d34d4]
[2017-04-19 16:36:25,930: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'b513e8d9-92f5-4ea9-bf1b-e076d75d34d4', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'237', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'b513e8d9-92f5-4ea9-bf1b-e076d75d34d4', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'237', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'b513e8d9-92f5-4ea9-bf1b-e076d75d34d4', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:25,933: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[b513e8d9-92f5-4ea9-bf1b-e076d75d34d4]
 pid:18312
documents.models <18312> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-d328c7f0-75d5-43ef-9792-0b302f3fe2fb-105-237-1d20f688585d3c09"
[2017-04-19 16:36:25,944: DEBUG/Worker-2] transformations cache filename: 
page-cache-d328c7f0-75d5-43ef-9792-0b302f3fe2fb-105-237-1d20f688585d3c09
documents.models <18312> [DEBUG] "generate_image() transformations cache file 
"page-cache-d328c7f0-75d5-43ef-9792-0b302f3fe2fb-105-237-1d20f688585d3c09" 
found"
[2017-04-19 16:36:25,944: DEBUG/Worker-2] transformations cache file 
"page-cache-d328c7f0-75d5-43ef-9792-0b302f3fe2fb-105-237-1d20f688585d3c09" found
[2017-04-19 16:36:25,945: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[b513e8d9-92f5-4ea9-bf1b-e076d75d34d4]
 succeeded in 0.0134031232446s: 
u'page-cache-d328c7f0-75d5-43ef-9792-0b302f3fe2fb-105-237-1d20f688585d3c09'
[2017-04-19 16:36:26,445: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[76769774-9bdc-4249-8ea5-5185f369a919]
[2017-04-19 16:36:26,445: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'76769774-9bdc-4249-8ea5-5185f369a919', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'235', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'76769774-9bdc-4249-8ea5-5185f369a919', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'235', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'76769774-9bdc-4249-8ea5-5185f369a919', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:26,448: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[76769774-9bdc-4249-8ea5-5185f369a919]
 pid:18313
documents.models <18313> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-94c80211-5658-4875-ab7c-963cd70ccd3d-104-235-1d20f688585d3c09"
[2017-04-19 16:36:26,459: DEBUG/Worker-3] transformations cache filename: 
page-cache-94c80211-5658-4875-ab7c-963cd70ccd3d-104-235-1d20f688585d3c09
documents.models <18313> [DEBUG] "generate_image() transformations cache file 
"page-cache-94c80211-5658-4875-ab7c-963cd70ccd3d-104-235-1d20f688585d3c09" 
found"
[2017-04-19 16:36:26,459: DEBUG/Worker-3] transformations cache file 
"page-cache-94c80211-5658-4875-ab7c-963cd70ccd3d-104-235-1d20f688585d3c09" found
[2017-04-19 16:36:26,460: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[76769774-9bdc-4249-8ea5-5185f369a919]
 succeeded in 0.0137441270053s: 
u'page-cache-94c80211-5658-4875-ab7c-963cd70ccd3d-104-235-1d20f688585d3c09'
[2017-04-19 16:36:26,960: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[246e71f0-647a-4c88-92ba-4d2925525787]
[2017-04-19 16:36:26,961: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'246e71f0-647a-4c88-92ba-4d2925525787', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'229', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'246e71f0-647a-4c88-92ba-4d2925525787', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'229', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'246e71f0-647a-4c88-92ba-4d2925525787', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:26,963: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[246e71f0-647a-4c88-92ba-4d2925525787]
 pid:18314
documents.models <18314> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-0f55a44b-a672-42a1-a3e1-980ff86ab27c-103-229-1d20f688585d3c09"
[2017-04-19 16:36:26,974: DEBUG/Worker-4] transformations cache filename: 
page-cache-0f55a44b-a672-42a1-a3e1-980ff86ab27c-103-229-1d20f688585d3c09
documents.models <18314> [DEBUG] "generate_image() transformations cache file 
"page-cache-0f55a44b-a672-42a1-a3e1-980ff86ab27c-103-229-1d20f688585d3c09" 
found"
[2017-04-19 16:36:26,974: DEBUG/Worker-4] transformations cache file 
"page-cache-0f55a44b-a672-42a1-a3e1-980ff86ab27c-103-229-1d20f688585d3c09" found
[2017-04-19 16:36:26,976: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[246e71f0-647a-4c88-92ba-4d2925525787]
 succeeded in 0.0138765517622s: 
u'page-cache-0f55a44b-a672-42a1-a3e1-980ff86ab27c-103-229-1d20f688585d3c09'
[2017-04-19 16:36:27,475: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[0beafa85-669b-4797-aced-b62b3fdd7e05]
[2017-04-19 16:36:27,476: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'0beafa85-669b-4797-aced-b62b3fdd7e05', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'228', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'0beafa85-669b-4797-aced-b62b3fdd7e05', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'228', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'0beafa85-669b-4797-aced-b62b3fdd7e05', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:27,479: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[0beafa85-669b-4797-aced-b62b3fdd7e05]
 pid:18311
documents.models <18311> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-05b65e94-bbf9-4854-bf6a-a5fcdd1a5427-102-228-1d20f688585d3c09"
[2017-04-19 16:36:27,489: DEBUG/Worker-1] transformations cache filename: 
page-cache-05b65e94-bbf9-4854-bf6a-a5fcdd1a5427-102-228-1d20f688585d3c09
documents.models <18311> [DEBUG] "generate_image() transformations cache file 
"page-cache-05b65e94-bbf9-4854-bf6a-a5fcdd1a5427-102-228-1d20f688585d3c09" 
found"
[2017-04-19 16:36:27,489: DEBUG/Worker-1] transformations cache file 
"page-cache-05b65e94-bbf9-4854-bf6a-a5fcdd1a5427-102-228-1d20f688585d3c09" found
[2017-04-19 16:36:27,491: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[0beafa85-669b-4797-aced-b62b3fdd7e05]
 succeeded in 0.0136286169291s: 
u'page-cache-05b65e94-bbf9-4854-bf6a-a5fcdd1a5427-102-228-1d20f688585d3c09'
[2017-04-19 16:36:27,990: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[4abd008f-d339-4de6-b9eb-06c33d0e9c30]
[2017-04-19 16:36:27,990: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'4abd008f-d339-4de6-b9eb-06c33d0e9c30', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'223', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'4abd008f-d339-4de6-b9eb-06c33d0e9c30', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'223', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'4abd008f-d339-4de6-b9eb-06c33d0e9c30', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:27,992: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[4abd008f-d339-4de6-b9eb-06c33d0e9c30]
 pid:18312
documents.models <18312> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-cddc28a9-c847-435e-80e1-454e29655234-101-223-1d20f688585d3c09"
[2017-04-19 16:36:28,004: DEBUG/Worker-2] transformations cache filename: 
page-cache-cddc28a9-c847-435e-80e1-454e29655234-101-223-1d20f688585d3c09
documents.models <18312> [DEBUG] "generate_image() transformations cache file 
"page-cache-cddc28a9-c847-435e-80e1-454e29655234-101-223-1d20f688585d3c09" 
found"
[2017-04-19 16:36:28,004: DEBUG/Worker-2] transformations cache file 
"page-cache-cddc28a9-c847-435e-80e1-454e29655234-101-223-1d20f688585d3c09" found
[2017-04-19 16:36:28,005: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[4abd008f-d339-4de6-b9eb-06c33d0e9c30]
 succeeded in 0.0139893810265s: 
u'page-cache-cddc28a9-c847-435e-80e1-454e29655234-101-223-1d20f688585d3c09'
[2017-04-19 16:36:28,509: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[9a9e0255-21cb-4449-afe1-48b2a1e4b2c3]
[2017-04-19 16:36:28,509: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'9a9e0255-21cb-4449-afe1-48b2a1e4b2c3', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'169', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'9a9e0255-21cb-4449-afe1-48b2a1e4b2c3', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'169', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'9a9e0255-21cb-4449-afe1-48b2a1e4b2c3', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:28,511: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[9a9e0255-21cb-4449-afe1-48b2a1e4b2c3]
 pid:18313
documents.models <18313> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-e9b1a775-0133-46d9-b26d-1d44093600bc-79-169-1d20f688585d3c09"
[2017-04-19 16:36:28,523: DEBUG/Worker-3] transformations cache filename: 
page-cache-e9b1a775-0133-46d9-b26d-1d44093600bc-79-169-1d20f688585d3c09
documents.models <18313> [DEBUG] "generate_image() transformations cache file 
"page-cache-e9b1a775-0133-46d9-b26d-1d44093600bc-79-169-1d20f688585d3c09" found"
[2017-04-19 16:36:28,523: DEBUG/Worker-3] transformations cache file 
"page-cache-e9b1a775-0133-46d9-b26d-1d44093600bc-79-169-1d20f688585d3c09" found
[2017-04-19 16:36:28,524: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[9a9e0255-21cb-4449-afe1-48b2a1e4b2c3]
 succeeded in 0.013572270982s: 
u'page-cache-e9b1a775-0133-46d9-b26d-1d44093600bc-79-169-1d20f688585d3c09'
[2017-04-19 16:36:29,023: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[44d4a545-d8e1-48bd-82af-185a618409c4]
[2017-04-19 16:36:29,024: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'44d4a545-d8e1-48bd-82af-185a618409c4', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'214', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'44d4a545-d8e1-48bd-82af-185a618409c4', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'214', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'44d4a545-d8e1-48bd-82af-185a618409c4', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:29,025: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[44d4a545-d8e1-48bd-82af-185a618409c4]
 pid:18314
documents.models <18314> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-6cf797b0-e292-4170-8f96-09c8756a3df1-97-214-1d20f688585d3c09"
[2017-04-19 16:36:29,037: DEBUG/Worker-4] transformations cache filename: 
page-cache-6cf797b0-e292-4170-8f96-09c8756a3df1-97-214-1d20f688585d3c09
documents.models <18314> [DEBUG] "generate_image() transformations cache file 
"page-cache-6cf797b0-e292-4170-8f96-09c8756a3df1-97-214-1d20f688585d3c09" found"
[2017-04-19 16:36:29,037: DEBUG/Worker-4] transformations cache file 
"page-cache-6cf797b0-e292-4170-8f96-09c8756a3df1-97-214-1d20f688585d3c09" found
[2017-04-19 16:36:29,038: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[44d4a545-d8e1-48bd-82af-185a618409c4]
 succeeded in 0.01345404936s: 
u'page-cache-6cf797b0-e292-4170-8f96-09c8756a3df1-97-214-1d20f688585d3c09'
[2017-04-19 16:36:29,539: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[be398104-22d4-4795-ac78-e44b80476cf2]
[2017-04-19 16:36:29,539: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'be398104-22d4-4795-ac78-e44b80476cf2', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'212', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'be398104-22d4-4795-ac78-e44b80476cf2', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'212', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'be398104-22d4-4795-ac78-e44b80476cf2', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:29,541: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[be398104-22d4-4795-ac78-e44b80476cf2]
 pid:18311
documents.models <18311> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-2e72773e-9e3d-4156-8d6f-2f964f70e2cf-96-212-1d20f688585d3c09"
[2017-04-19 16:36:29,552: DEBUG/Worker-1] transformations cache filename: 
page-cache-2e72773e-9e3d-4156-8d6f-2f964f70e2cf-96-212-1d20f688585d3c09
documents.models <18311> [DEBUG] "generate_image() transformations cache file 
"page-cache-2e72773e-9e3d-4156-8d6f-2f964f70e2cf-96-212-1d20f688585d3c09" found"
[2017-04-19 16:36:29,552: DEBUG/Worker-1] transformations cache file 
"page-cache-2e72773e-9e3d-4156-8d6f-2f964f70e2cf-96-212-1d20f688585d3c09" found
[2017-04-19 16:36:29,554: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[be398104-22d4-4795-ac78-e44b80476cf2]
 succeeded in 0.0134895821102s: 
u'page-cache-2e72773e-9e3d-4156-8d6f-2f964f70e2cf-96-212-1d20f688585d3c09'
[2017-04-19 16:36:30,053: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[b1854ee6-3dc8-4a5b-a935-aaeb78386e1f]
[2017-04-19 16:36:30,054: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'b1854ee6-3dc8-4a5b-a935-aaeb78386e1f', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'202', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'b1854ee6-3dc8-4a5b-a935-aaeb78386e1f', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'202', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'b1854ee6-3dc8-4a5b-a935-aaeb78386e1f', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:30,055: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[b1854ee6-3dc8-4a5b-a935-aaeb78386e1f]
 pid:18312
documents.models <18312> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-e50e5599-5d25-4962-8cc5-c1d4ae02713e-95-202-1d20f688585d3c09"
[2017-04-19 16:36:30,067: DEBUG/Worker-2] transformations cache filename: 
page-cache-e50e5599-5d25-4962-8cc5-c1d4ae02713e-95-202-1d20f688585d3c09
documents.models <18312> [DEBUG] "generate_image() transformations cache file 
"page-cache-e50e5599-5d25-4962-8cc5-c1d4ae02713e-95-202-1d20f688585d3c09" found"
[2017-04-19 16:36:30,067: DEBUG/Worker-2] transformations cache file 
"page-cache-e50e5599-5d25-4962-8cc5-c1d4ae02713e-95-202-1d20f688585d3c09" found
[2017-04-19 16:36:30,068: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[b1854ee6-3dc8-4a5b-a935-aaeb78386e1f]
 succeeded in 0.0139514035545s: 
u'page-cache-e50e5599-5d25-4962-8cc5-c1d4ae02713e-95-202-1d20f688585d3c09'
[2017-04-19 16:36:30,574: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[c1e7e95e-9d13-4096-aa8f-563a3ca313d0]
[2017-04-19 16:36:30,575: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'c1e7e95e-9d13-4096-aa8f-563a3ca313d0', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'200', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'c1e7e95e-9d13-4096-aa8f-563a3ca313d0', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'200', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'c1e7e95e-9d13-4096-aa8f-563a3ca313d0', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:30,577: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[c1e7e95e-9d13-4096-aa8f-563a3ca313d0]
 pid:18313
documents.models <18313> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-42caa805-1b4e-4c58-b1cd-9a9d41278b43-94-200-1d20f688585d3c09"
[2017-04-19 16:36:30,589: DEBUG/Worker-3] transformations cache filename: 
page-cache-42caa805-1b4e-4c58-b1cd-9a9d41278b43-94-200-1d20f688585d3c09
documents.models <18313> [DEBUG] "generate_image() transformations cache file 
"page-cache-42caa805-1b4e-4c58-b1cd-9a9d41278b43-94-200-1d20f688585d3c09" found"
[2017-04-19 16:36:30,589: DEBUG/Worker-3] transformations cache file 
"page-cache-42caa805-1b4e-4c58-b1cd-9a9d41278b43-94-200-1d20f688585d3c09" found
[2017-04-19 16:36:30,590: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[c1e7e95e-9d13-4096-aa8f-563a3ca313d0]
 succeeded in 0.0139389350079s: 
u'page-cache-42caa805-1b4e-4c58-b1cd-9a9d41278b43-94-200-1d20f688585d3c09'
[2017-04-19 16:36:31,089: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[00e6d928-dc39-45d1-8e3b-706d794397fd]
[2017-04-19 16:36:31,089: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'00e6d928-dc39-45d1-8e3b-706d794397fd', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'199', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'00e6d928-dc39-45d1-8e3b-706d794397fd', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'199', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'00e6d928-dc39-45d1-8e3b-706d794397fd', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:31,091: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[00e6d928-dc39-45d1-8e3b-706d794397fd]
 pid:18314
documents.models <18314> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-2e8a2fdc-532f-44a2-a0cd-c9e9d2747728-93-199-1d20f688585d3c09"
[2017-04-19 16:36:31,102: DEBUG/Worker-4] transformations cache filename: 
page-cache-2e8a2fdc-532f-44a2-a0cd-c9e9d2747728-93-199-1d20f688585d3c09
documents.models <18314> [DEBUG] "generate_image() transformations cache file 
"page-cache-2e8a2fdc-532f-44a2-a0cd-c9e9d2747728-93-199-1d20f688585d3c09" found"
[2017-04-19 16:36:31,102: DEBUG/Worker-4] transformations cache file 
"page-cache-2e8a2fdc-532f-44a2-a0cd-c9e9d2747728-93-199-1d20f688585d3c09" found
[2017-04-19 16:36:31,104: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[00e6d928-dc39-45d1-8e3b-706d794397fd]
 succeeded in 0.0141959176399s: 
u'page-cache-2e8a2fdc-532f-44a2-a0cd-c9e9d2747728-93-199-1d20f688585d3c09'
[2017-04-19 16:36:31,606: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[255c31bd-749c-4c4d-a26b-d21c958c8e03]
[2017-04-19 16:36:31,606: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'255c31bd-749c-4c4d-a26b-d21c958c8e03', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'198', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'255c31bd-749c-4c4d-a26b-d21c958c8e03', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'198', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'255c31bd-749c-4c4d-a26b-d21c958c8e03', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:31,608: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[255c31bd-749c-4c4d-a26b-d21c958c8e03]
 pid:18311
documents.models <18311> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-2a82b509-52c6-41f1-8b1b-fef2d9e18d8b-92-198-1d20f688585d3c09"
[2017-04-19 16:36:31,620: DEBUG/Worker-1] transformations cache filename: 
page-cache-2a82b509-52c6-41f1-8b1b-fef2d9e18d8b-92-198-1d20f688585d3c09
documents.models <18311> [DEBUG] "generate_image() transformations cache file 
"page-cache-2a82b509-52c6-41f1-8b1b-fef2d9e18d8b-92-198-1d20f688585d3c09" found"
[2017-04-19 16:36:31,620: DEBUG/Worker-1] transformations cache file 
"page-cache-2a82b509-52c6-41f1-8b1b-fef2d9e18d8b-92-198-1d20f688585d3c09" found
[2017-04-19 16:36:31,621: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[255c31bd-749c-4c4d-a26b-d21c958c8e03]
 succeeded in 0.0139544596896s: 
u'page-cache-2a82b509-52c6-41f1-8b1b-fef2d9e18d8b-92-198-1d20f688585d3c09'
[2017-04-19 16:36:32,126: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[389f114c-4f57-4f76-86ec-57110395ca0e]
[2017-04-19 16:36:32,127: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'389f114c-4f57-4f76-86ec-57110395ca0e', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'195', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'389f114c-4f57-4f76-86ec-57110395ca0e', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'195', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'389f114c-4f57-4f76-86ec-57110395ca0e', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:32,129: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[389f114c-4f57-4f76-86ec-57110395ca0e]
 pid:18312
documents.models <18312> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-023d1a15-d1ce-40f5-9ebc-c3bd031dafc9-91-195-1d20f688585d3c09"
[2017-04-19 16:36:32,140: DEBUG/Worker-2] transformations cache filename: 
page-cache-023d1a15-d1ce-40f5-9ebc-c3bd031dafc9-91-195-1d20f688585d3c09
documents.models <18312> [DEBUG] "generate_image() transformations cache file 
"page-cache-023d1a15-d1ce-40f5-9ebc-c3bd031dafc9-91-195-1d20f688585d3c09" found"
[2017-04-19 16:36:32,140: DEBUG/Worker-2] transformations cache file 
"page-cache-023d1a15-d1ce-40f5-9ebc-c3bd031dafc9-91-195-1d20f688585d3c09" found
[2017-04-19 16:36:32,141: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[389f114c-4f57-4f76-86ec-57110395ca0e]
 succeeded in 0.0137163647451s: 
u'page-cache-023d1a15-d1ce-40f5-9ebc-c3bd031dafc9-91-195-1d20f688585d3c09'
[2017-04-19 16:36:32,644: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[77bb8b99-c52b-44cb-9dc0-7ab224af461b]
[2017-04-19 16:36:32,644: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'77bb8b99-c52b-44cb-9dc0-7ab224af461b', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'193', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'77bb8b99-c52b-44cb-9dc0-7ab224af461b', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'193', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'77bb8b99-c52b-44cb-9dc0-7ab224af461b', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:32,646: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[77bb8b99-c52b-44cb-9dc0-7ab224af461b]
 pid:18313
documents.models <18313> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-f47d6b21-f58a-4b62-82ab-6f99a34f9328-90-193-1d20f688585d3c09"
[2017-04-19 16:36:32,657: DEBUG/Worker-3] transformations cache filename: 
page-cache-f47d6b21-f58a-4b62-82ab-6f99a34f9328-90-193-1d20f688585d3c09
documents.models <18313> [DEBUG] "generate_image() transformations cache file 
"page-cache-f47d6b21-f58a-4b62-82ab-6f99a34f9328-90-193-1d20f688585d3c09" found"
[2017-04-19 16:36:32,658: DEBUG/Worker-3] transformations cache file 
"page-cache-f47d6b21-f58a-4b62-82ab-6f99a34f9328-90-193-1d20f688585d3c09" found
[2017-04-19 16:36:32,659: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[77bb8b99-c52b-44cb-9dc0-7ab224af461b]
 succeeded in 0.0138667421415s: 
u'page-cache-f47d6b21-f58a-4b62-82ab-6f99a34f9328-90-193-1d20f688585d3c09'
[2017-04-19 16:36:33,162: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[104c4bc6-1869-4c01-a7a5-5bf7aa105178]
[2017-04-19 16:36:33,162: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'104c4bc6-1869-4c01-a7a5-5bf7aa105178', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'191', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'104c4bc6-1869-4c01-a7a5-5bf7aa105178', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'191', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'104c4bc6-1869-4c01-a7a5-5bf7aa105178', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:33,165: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[104c4bc6-1869-4c01-a7a5-5bf7aa105178]
 pid:18314
documents.models <18314> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-1081a27f-4487-49cb-b662-732f07328ccc-89-191-1d20f688585d3c09"
[2017-04-19 16:36:33,175: DEBUG/Worker-4] transformations cache filename: 
page-cache-1081a27f-4487-49cb-b662-732f07328ccc-89-191-1d20f688585d3c09
documents.models <18314> [DEBUG] "generate_image() transformations cache file 
"page-cache-1081a27f-4487-49cb-b662-732f07328ccc-89-191-1d20f688585d3c09" found"
[2017-04-19 16:36:33,176: DEBUG/Worker-4] transformations cache file 
"page-cache-1081a27f-4487-49cb-b662-732f07328ccc-89-191-1d20f688585d3c09" found
[2017-04-19 16:36:33,177: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[104c4bc6-1869-4c01-a7a5-5bf7aa105178]
 succeeded in 0.0140131260268s: 
u'page-cache-1081a27f-4487-49cb-b662-732f07328ccc-89-191-1d20f688585d3c09'
[2017-04-19 16:36:33,676: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[a2401300-90a3-4651-b1a3-5a8532e841b2]
[2017-04-19 16:36:33,676: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'a2401300-90a3-4651-b1a3-5a8532e841b2', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'189', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'a2401300-90a3-4651-b1a3-5a8532e841b2', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'189', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'a2401300-90a3-4651-b1a3-5a8532e841b2', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:33,678: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[a2401300-90a3-4651-b1a3-5a8532e841b2]
 pid:18311
documents.models <18311> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-dd40787e-4a4c-42b5-b573-b5561898abc1-88-189-1d20f688585d3c09"
[2017-04-19 16:36:33,690: DEBUG/Worker-1] transformations cache filename: 
page-cache-dd40787e-4a4c-42b5-b573-b5561898abc1-88-189-1d20f688585d3c09
documents.models <18311> [DEBUG] "generate_image() transformations cache file 
"page-cache-dd40787e-4a4c-42b5-b573-b5561898abc1-88-189-1d20f688585d3c09" found"
[2017-04-19 16:36:33,690: DEBUG/Worker-1] transformations cache file 
"page-cache-dd40787e-4a4c-42b5-b573-b5561898abc1-88-189-1d20f688585d3c09" found
[2017-04-19 16:36:33,691: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[a2401300-90a3-4651-b1a3-5a8532e841b2]
 succeeded in 0.014027165249s: 
u'page-cache-dd40787e-4a4c-42b5-b573-b5561898abc1-88-189-1d20f688585d3c09'
[2017-04-19 16:36:34,195: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[61510bb8-fc55-41fe-94f7-0036bd09f2fd]
[2017-04-19 16:36:34,196: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'61510bb8-fc55-41fe-94f7-0036bd09f2fd', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'188', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'61510bb8-fc55-41fe-94f7-0036bd09f2fd', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'188', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'61510bb8-fc55-41fe-94f7-0036bd09f2fd', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:34,197: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[61510bb8-fc55-41fe-94f7-0036bd09f2fd]
 pid:18312
documents.models <18312> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-f5a5714f-28f0-40c1-b877-80ade59a5799-87-188-1d20f688585d3c09"
[2017-04-19 16:36:34,209: DEBUG/Worker-2] transformations cache filename: 
page-cache-f5a5714f-28f0-40c1-b877-80ade59a5799-87-188-1d20f688585d3c09
documents.models <18312> [DEBUG] "generate_image() transformations cache file 
"page-cache-f5a5714f-28f0-40c1-b877-80ade59a5799-87-188-1d20f688585d3c09" found"
[2017-04-19 16:36:34,210: DEBUG/Worker-2] transformations cache file 
"page-cache-f5a5714f-28f0-40c1-b877-80ade59a5799-87-188-1d20f688585d3c09" found
[2017-04-19 16:36:34,211: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[61510bb8-fc55-41fe-94f7-0036bd09f2fd]
 succeeded in 0.0141311110929s: 
u'page-cache-f5a5714f-28f0-40c1-b877-80ade59a5799-87-188-1d20f688585d3c09'
[2017-04-19 16:36:34,710: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[d0dec9d1-6892-43f4-85a2-1c61f7a570c7]
[2017-04-19 16:36:34,710: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'd0dec9d1-6892-43f4-85a2-1c61f7a570c7', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'186', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'd0dec9d1-6892-43f4-85a2-1c61f7a570c7', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'186', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'd0dec9d1-6892-43f4-85a2-1c61f7a570c7', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:34,712: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[d0dec9d1-6892-43f4-85a2-1c61f7a570c7]
 pid:18313
documents.models <18313> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-f426f9bd-7de8-4fd4-ae71-cee9ac2c1691-86-186-1d20f688585d3c09"
[2017-04-19 16:36:34,723: DEBUG/Worker-3] transformations cache filename: 
page-cache-f426f9bd-7de8-4fd4-ae71-cee9ac2c1691-86-186-1d20f688585d3c09
documents.models <18313> [DEBUG] "generate_image() transformations cache file 
"page-cache-f426f9bd-7de8-4fd4-ae71-cee9ac2c1691-86-186-1d20f688585d3c09" found"
[2017-04-19 16:36:34,723: DEBUG/Worker-3] transformations cache file 
"page-cache-f426f9bd-7de8-4fd4-ae71-cee9ac2c1691-86-186-1d20f688585d3c09" found
[2017-04-19 16:36:34,724: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[d0dec9d1-6892-43f4-85a2-1c61f7a570c7]
 succeeded in 0.0134258610196s: 
u'page-cache-f426f9bd-7de8-4fd4-ae71-cee9ac2c1691-86-186-1d20f688585d3c09'
[2017-04-19 16:36:34,980: INFO/MainProcess] Received task: 
sources.tasks.task_check_interval_source[beb30d04-9d50-4b8c-ba28-c46e7f5def40]
[2017-04-19 16:36:34,980: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'sources.tasks.task_check_interval_source', 
u'beb30d04-9d50-4b8c-ba28-c46e7f5def40', [], {u'source_id': 2}, {u'utc': True, 
u'is_eager': False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'sources_periodic', u'exchange': u'sources_periodic'}, u'expires': None, 
u'hostname': 'celery@dms', u'task': 
u'sources.tasks.task_check_interval_source', u'callbacks': None, 
u'correlation_id': u'beb30d04-9d50-4b8c-ba28-c46e7f5def40', u'errbacks': None, 
u'timelimit': [None, None], u'taskset': None, u'kwargs': {u'source_id': 2}, 
u'eta': None, u'reply_to': u'1ef307a8-f3cd-3f83-926f-43b7bac1e024', u'id': 
u'beb30d04-9d50-4b8c-ba28-c46e7f5def40', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:34,982: DEBUG/MainProcess] Task accepted: 
sources.tasks.task_check_interval_source[beb30d04-9d50-4b8c-ba28-c46e7f5def40] 
pid:18314
[2017-04-19 16:36:34,991: INFO/MainProcess] Received task: 
sources.tasks.task_check_interval_source[47521b80-2d46-4db0-92f9-7c84130f41e6]
[2017-04-19 16:36:34,991: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'sources.tasks.task_check_interval_source', 
u'47521b80-2d46-4db0-92f9-7c84130f41e6', [], {u'source_id': 3}, {u'utc': True, 
u'is_eager': False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'sources_periodic', u'exchange': u'sources_periodic'}, u'expires': None, 
u'hostname': 'celery@dms', u'task': 
u'sources.tasks.task_check_interval_source', u'callbacks': None, 
u'correlation_id': u'47521b80-2d46-4db0-92f9-7c84130f41e6', u'errbacks': None, 
u'timelimit': [None, None], u'taskset': None, u'kwargs': {u'source_id': 3}, 
u'eta': None, u'reply_to': u'1ef307a8-f3cd-3f83-926f-43b7bac1e024', u'id': 
u'47521b80-2d46-4db0-92f9-7c84130f41e6', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:34,993: DEBUG/MainProcess] Task accepted: 
sources.tasks.task_check_interval_source[47521b80-2d46-4db0-92f9-7c84130f41e6] 
pid:18311
[2017-04-19 16:36:35,000: INFO/MainProcess] Received task: 
sources.tasks.task_check_interval_source[f15813d5-89a6-4507-8402-f273b1f96ee7]
[2017-04-19 16:36:35,000: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'sources.tasks.task_check_interval_source', 
u'f15813d5-89a6-4507-8402-f273b1f96ee7', [], {u'source_id': 4}, {u'utc': True, 
u'is_eager': False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'sources_periodic', u'exchange': u'sources_periodic'}, u'expires': None, 
u'hostname': 'celery@dms', u'task': 
u'sources.tasks.task_check_interval_source', u'callbacks': None, 
u'correlation_id': u'f15813d5-89a6-4507-8402-f273b1f96ee7', u'errbacks': None, 
u'timelimit': [None, None], u'taskset': None, u'kwargs': {u'source_id': 4}, 
u'eta': None, u'reply_to': u'1ef307a8-f3cd-3f83-926f-43b7bac1e024', u'id': 
u'f15813d5-89a6-4507-8402-f273b1f96ee7', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:35,002: INFO/MainProcess] Task 
sources.tasks.task_check_interval_source[beb30d04-9d50-4b8c-ba28-c46e7f5def40] 
succeeded in 0.0209524380043s: None
[2017-04-19 16:36:35,004: DEBUG/MainProcess] Task accepted: 
sources.tasks.task_check_interval_source[f15813d5-89a6-4507-8402-f273b1f96ee7] 
pid:18312
[2017-04-19 16:36:35,011: INFO/MainProcess] Received task: 
sources.tasks.task_check_interval_source[bd561ee8-a353-4f08-9e15-8a64022b7413]
[2017-04-19 16:36:35,011: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'sources.tasks.task_check_interval_source', 
u'bd561ee8-a353-4f08-9e15-8a64022b7413', [], {u'source_id': 5}, {u'utc': True, 
u'is_eager': False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'sources_periodic', u'exchange': u'sources_periodic'}, u'expires': None, 
u'hostname': 'celery@dms', u'task': 
u'sources.tasks.task_check_interval_source', u'callbacks': None, 
u'correlation_id': u'bd561ee8-a353-4f08-9e15-8a64022b7413', u'errbacks': None, 
u'timelimit': [None, None], u'taskset': None, u'kwargs': {u'source_id': 5}, 
u'eta': None, u'reply_to': u'1ef307a8-f3cd-3f83-926f-43b7bac1e024', u'id': 
u'bd561ee8-a353-4f08-9e15-8a64022b7413', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:35,014: DEBUG/MainProcess] Task accepted: 
sources.tasks.task_check_interval_source[bd561ee8-a353-4f08-9e15-8a64022b7413] 
pid:18313
[2017-04-19 16:36:35,018: INFO/MainProcess] Task 
sources.tasks.task_check_interval_source[47521b80-2d46-4db0-92f9-7c84130f41e6] 
succeeded in 0.0253758709878s: None
[2017-04-19 16:36:35,021: INFO/MainProcess] Task 
sources.tasks.task_check_interval_source[f15813d5-89a6-4507-8402-f273b1f96ee7] 
succeeded in 0.0190271781757s: None
[2017-04-19 16:36:35,031: INFO/MainProcess] Task 
sources.tasks.task_check_interval_source[bd561ee8-a353-4f08-9e15-8a64022b7413] 
succeeded in 0.0179538200609s: None
[2017-04-19 16:36:35,227: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[f19f83dc-0159-4b94-9b11-2271ae681683]
[2017-04-19 16:36:35,228: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'f19f83dc-0159-4b94-9b11-2271ae681683', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'185', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'f19f83dc-0159-4b94-9b11-2271ae681683', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'185', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'f19f83dc-0159-4b94-9b11-2271ae681683', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:35,229: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[f19f83dc-0159-4b94-9b11-2271ae681683]
 pid:18314
documents.models <18314> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-b427f529-dc27-480e-96a2-f018e6635bc5-85-185-1d20f688585d3c09"
[2017-04-19 16:36:35,242: DEBUG/Worker-4] transformations cache filename: 
page-cache-b427f529-dc27-480e-96a2-f018e6635bc5-85-185-1d20f688585d3c09
documents.models <18314> [DEBUG] "generate_image() transformations cache file 
"page-cache-b427f529-dc27-480e-96a2-f018e6635bc5-85-185-1d20f688585d3c09" found"
[2017-04-19 16:36:35,242: DEBUG/Worker-4] transformations cache file 
"page-cache-b427f529-dc27-480e-96a2-f018e6635bc5-85-185-1d20f688585d3c09" found
[2017-04-19 16:36:35,243: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[f19f83dc-0159-4b94-9b11-2271ae681683]
 succeeded in 0.0142088891007s: 
u'page-cache-b427f529-dc27-480e-96a2-f018e6635bc5-85-185-1d20f688585d3c09'
[2017-04-19 16:36:35,742: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[2da0df35-dc49-42f7-843d-62326ab3f805]
[2017-04-19 16:36:35,742: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'2da0df35-dc49-42f7-843d-62326ab3f805', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'184', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'2da0df35-dc49-42f7-843d-62326ab3f805', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'184', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'2da0df35-dc49-42f7-843d-62326ab3f805', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:35,745: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[2da0df35-dc49-42f7-843d-62326ab3f805]
 pid:18311
documents.models <18311> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-626f059a-1ba9-4020-833b-1d8843165419-84-184-1d20f688585d3c09"
[2017-04-19 16:36:35,756: DEBUG/Worker-1] transformations cache filename: 
page-cache-626f059a-1ba9-4020-833b-1d8843165419-84-184-1d20f688585d3c09
documents.models <18311> [DEBUG] "generate_image() transformations cache file 
"page-cache-626f059a-1ba9-4020-833b-1d8843165419-84-184-1d20f688585d3c09" found"
[2017-04-19 16:36:35,756: DEBUG/Worker-1] transformations cache file 
"page-cache-626f059a-1ba9-4020-833b-1d8843165419-84-184-1d20f688585d3c09" found
[2017-04-19 16:36:35,757: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[2da0df35-dc49-42f7-843d-62326ab3f805]
 succeeded in 0.0141480229795s: 
u'page-cache-626f059a-1ba9-4020-833b-1d8843165419-84-184-1d20f688585d3c09'
[2017-04-19 16:36:36,257: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[f8971b88-30a4-4f5e-89e3-6d60c0107af3]
[2017-04-19 16:36:36,257: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'f8971b88-30a4-4f5e-89e3-6d60c0107af3', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'183', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'f8971b88-30a4-4f5e-89e3-6d60c0107af3', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'183', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'f8971b88-30a4-4f5e-89e3-6d60c0107af3', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:36,260: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[f8971b88-30a4-4f5e-89e3-6d60c0107af3]
 pid:18312
documents.models <18312> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-c96454dd-1d15-4bfc-bef4-12cf96966dfe-83-183-1d20f688585d3c09"
[2017-04-19 16:36:36,270: DEBUG/Worker-2] transformations cache filename: 
page-cache-c96454dd-1d15-4bfc-bef4-12cf96966dfe-83-183-1d20f688585d3c09
documents.models <18312> [DEBUG] "generate_image() transformations cache file 
"page-cache-c96454dd-1d15-4bfc-bef4-12cf96966dfe-83-183-1d20f688585d3c09" found"
[2017-04-19 16:36:36,270: DEBUG/Worker-2] transformations cache file 
"page-cache-c96454dd-1d15-4bfc-bef4-12cf96966dfe-83-183-1d20f688585d3c09" found
[2017-04-19 16:36:36,272: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[f8971b88-30a4-4f5e-89e3-6d60c0107af3]
 succeeded in 0.0137103442103s: 
u'page-cache-c96454dd-1d15-4bfc-bef4-12cf96966dfe-83-183-1d20f688585d3c09'
[2017-04-19 16:36:36,773: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[b894431f-074c-4145-b678-9149751432fc]
[2017-04-19 16:36:36,773: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'b894431f-074c-4145-b678-9149751432fc', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'182', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'b894431f-074c-4145-b678-9149751432fc', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'182', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'b894431f-074c-4145-b678-9149751432fc', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:36,775: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[b894431f-074c-4145-b678-9149751432fc]
 pid:18313
documents.models <18313> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-ce1c5f5c-7685-4fe4-a4f0-7b0357bbf4b2-82-182-1d20f688585d3c09"
[2017-04-19 16:36:36,786: DEBUG/Worker-3] transformations cache filename: 
page-cache-ce1c5f5c-7685-4fe4-a4f0-7b0357bbf4b2-82-182-1d20f688585d3c09
documents.models <18313> [DEBUG] "generate_image() transformations cache file 
"page-cache-ce1c5f5c-7685-4fe4-a4f0-7b0357bbf4b2-82-182-1d20f688585d3c09" found"
[2017-04-19 16:36:36,786: DEBUG/Worker-3] transformations cache file 
"page-cache-ce1c5f5c-7685-4fe4-a4f0-7b0357bbf4b2-82-182-1d20f688585d3c09" found
[2017-04-19 16:36:36,787: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[b894431f-074c-4145-b678-9149751432fc]
 succeeded in 0.0135053396225s: 
u'page-cache-ce1c5f5c-7685-4fe4-a4f0-7b0357bbf4b2-82-182-1d20f688585d3c09'
[2017-04-19 16:36:37,290: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[5ffc07ad-237b-4661-ae75-c48db8bd0538]
[2017-04-19 16:36:37,291: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'5ffc07ad-237b-4661-ae75-c48db8bd0538', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'180', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'5ffc07ad-237b-4661-ae75-c48db8bd0538', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'180', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'5ffc07ad-237b-4661-ae75-c48db8bd0538', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:37,293: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[5ffc07ad-237b-4661-ae75-c48db8bd0538]
 pid:18314
documents.models <18314> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-531603ea-3c20-459a-93ae-34da3f778e75-81-180-1d20f688585d3c09"
[2017-04-19 16:36:37,304: DEBUG/Worker-4] transformations cache filename: 
page-cache-531603ea-3c20-459a-93ae-34da3f778e75-81-180-1d20f688585d3c09
documents.models <18314> [DEBUG] "generate_image() transformations cache file 
"page-cache-531603ea-3c20-459a-93ae-34da3f778e75-81-180-1d20f688585d3c09" found"
[2017-04-19 16:36:37,304: DEBUG/Worker-4] transformations cache file 
"page-cache-531603ea-3c20-459a-93ae-34da3f778e75-81-180-1d20f688585d3c09" found
[2017-04-19 16:36:37,306: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[5ffc07ad-237b-4661-ae75-c48db8bd0538]
 succeeded in 0.0140016917139s: 
u'page-cache-531603ea-3c20-459a-93ae-34da3f778e75-81-180-1d20f688585d3c09'
[2017-04-19 16:36:37,806: INFO/MainProcess] Received task: 
documents.tasks.task_generate_document_page_image[8df65ffd-9db6-4b80-9ce9-4bf6e1c5fab8]
[2017-04-19 16:36:37,806: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_generate_document_page_image', 
u'8df65ffd-9db6-4b80-9ce9-4bf6e1c5fab8', [], {u'rotation': None, u'zoom': None, 
u'document_page_id': u'170', u'size': u'350'}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'converter', u'exchange': u'converter'}, u'expires': None, u'hostname': 
'celery@dms', u'task': u'documents.tasks.task_generate_document_page_image', 
u'callbacks': None, u'correlation_id': u'8df65ffd-9db6-4b80-9ce9-4bf6e1c5fab8', 
u'errbacks': None, u'timelimit': [None, None], u'taskset': None, u'kwargs': 
{u'rotation': None, u'zoom': None, u'document_page_id': u'170', u'size': 
u'350'}, u'eta': None, u'reply_to': u'36e833ee-0f8d-3a8e-bdcb-d979f6dc9b18', 
u'id': u'8df65ffd-9db6-4b80-9ce9-4bf6e1c5fab8', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:37,808: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_generate_document_page_image[8df65ffd-9db6-4b80-9ce9-4bf6e1c5fab8]
 pid:18311
documents.models <18311> [DEBUG] "generate_image() transformations cache 
filename: 
page-cache-c99ab6b1-13c2-44e4-a0cc-cc6b882d4d93-80-170-1d20f688585d3c09"
[2017-04-19 16:36:37,819: DEBUG/Worker-1] transformations cache filename: 
page-cache-c99ab6b1-13c2-44e4-a0cc-cc6b882d4d93-80-170-1d20f688585d3c09
documents.models <18311> [DEBUG] "generate_image() transformations cache file 
"page-cache-c99ab6b1-13c2-44e4-a0cc-cc6b882d4d93-80-170-1d20f688585d3c09" found"
[2017-04-19 16:36:37,819: DEBUG/Worker-1] transformations cache file 
"page-cache-c99ab6b1-13c2-44e4-a0cc-cc6b882d4d93-80-170-1d20f688585d3c09" found
[2017-04-19 16:36:37,820: INFO/MainProcess] Task 
documents.tasks.task_generate_document_page_image[8df65ffd-9db6-4b80-9ce9-4bf6e1c5fab8]
 succeeded in 0.0134410448372s: 
u'page-cache-c99ab6b1-13c2-44e4-a0cc-cc6b882d4d93-80-170-1d20f688585d3c09'
[2017-04-19 16:36:44,963: INFO/MainProcess] Received task: 
checkouts.tasks.task_check_expired_check_outs[6dc3d270-2104-4ce7-8954-52b58ec41a1c]
[2017-04-19 16:36:44,963: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'checkouts.tasks.task_check_expired_check_outs', 
u'6dc3d270-2104-4ce7-8954-52b58ec41a1c', [], {}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'checkouts_periodic', u'exchange': u'checkouts_periodic'}, u'expires': None, 
u'hostname': 'celery@dms', u'task': 
u'checkouts.tasks.task_check_expired_check_outs', u'callbacks': None, 
u'correlation_id': u'6dc3d270-2104-4ce7-8954-52b58ec41a1c', u'errbacks': None, 
u'timelimit': [None, None], u'taskset': None, u'kwargs': {}, u'eta': None, 
u'reply_to': u'1ef307a8-f3cd-3f83-926f-43b7bac1e024', u'id': 
u'6dc3d270-2104-4ce7-8954-52b58ec41a1c', u'headers': {}}) kwargs:{})
checkouts.tasks <18312> [DEBUG] "task_check_expired_check_outs() executing..."
[2017-04-19 16:36:44,964: DEBUG/Worker-2] executing...
checkouts.tasks <18312> [DEBUG] "task_check_expired_check_outs() trying to 
acquire lock: task_expired_check_outs"
[2017-04-19 16:36:44,964: DEBUG/Worker-2] trying to acquire lock: 
task_expired_check_outs
checkouts.tasks <18312> [DEBUG] "task_check_expired_check_outs() acquired lock: 
task_expired_check_outs"
[2017-04-19 16:36:44,965: DEBUG/Worker-2] acquired lock: task_expired_check_outs
[2017-04-19 16:36:44,966: DEBUG/MainProcess] Task accepted: 
checkouts.tasks.task_check_expired_check_outs[6dc3d270-2104-4ce7-8954-52b58ec41a1c]
 pid:18312
[2017-04-19 16:36:44,974: INFO/MainProcess] Received task: 
documents.tasks.task_check_delete_periods[08c59b12-9a8c-4116-9e8e-61f00b88d523]
[2017-04-19 16:36:44,975: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_check_delete_periods', 
u'08c59b12-9a8c-4116-9e8e-61f00b88d523', [], {}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'documents_periodic', u'exchange': u'documents_periodic'}, u'expires': None, 
u'hostname': 'celery@dms', u'task': 
u'documents.tasks.task_check_delete_periods', u'callbacks': None, 
u'correlation_id': u'08c59b12-9a8c-4116-9e8e-61f00b88d523', u'errbacks': None, 
u'timelimit': [None, None], u'taskset': None, u'kwargs': {}, u'eta': None, 
u'reply_to': u'1ef307a8-f3cd-3f83-926f-43b7bac1e024', u'id': 
u'08c59b12-9a8c-4116-9e8e-61f00b88d523', u'headers': {}}) kwargs:{})
documents.managers <18313> [INFO] "check_delete_periods() Executing"
[2017-04-19 16:36:44,976: INFO/Worker-3] Executing
[2017-04-19 16:36:44,977: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_check_delete_periods[08c59b12-9a8c-4116-9e8e-61f00b88d523] 
pid:18313
[2017-04-19 16:36:44,979: INFO/MainProcess] Received task: 
documents.tasks.task_check_trash_periods[1b9cdffa-5d74-4b5a-a2ea-cc2798411efd]
[2017-04-19 16:36:44,980: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'documents.tasks.task_check_trash_periods', 
u'1b9cdffa-5d74-4b5a-a2ea-cc2798411efd', [], {}, {u'utc': True, u'is_eager': 
False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'documents_periodic', u'exchange': u'documents_periodic'}, u'expires': None, 
u'hostname': 'celery@dms', u'task': 
u'documents.tasks.task_check_trash_periods', u'callbacks': None, 
u'correlation_id': u'1b9cdffa-5d74-4b5a-a2ea-cc2798411efd', u'errbacks': None, 
u'timelimit': [None, None], u'taskset': None, u'kwargs': {}, u'eta': None, 
u'reply_to': u'1ef307a8-f3cd-3f83-926f-43b7bac1e024', u'id': 
u'1b9cdffa-5d74-4b5a-a2ea-cc2798411efd', u'headers': {}}) kwargs:{})
documents.managers <18314> [INFO] "check_trash_periods() Executing"
[2017-04-19 16:36:44,982: INFO/Worker-4] Executing
[2017-04-19 16:36:44,983: DEBUG/MainProcess] Task accepted: 
documents.tasks.task_check_trash_periods[1b9cdffa-5d74-4b5a-a2ea-cc2798411efd] 
pid:18314
[2017-04-19 16:36:44,984: INFO/MainProcess] Received task: 
sources.tasks.task_check_interval_source[3ca60897-e1fd-4a0c-85a8-399a4f486129]
[2017-04-19 16:36:44,984: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'sources.tasks.task_check_interval_source', 
u'3ca60897-e1fd-4a0c-85a8-399a4f486129', [], {u'source_id': 2}, {u'utc': True, 
u'is_eager': False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'sources_periodic', u'exchange': u'sources_periodic'}, u'expires': None, 
u'hostname': 'celery@dms', u'task': 
u'sources.tasks.task_check_interval_source', u'callbacks': None, 
u'correlation_id': u'3ca60897-e1fd-4a0c-85a8-399a4f486129', u'errbacks': None, 
u'timelimit': [None, None], u'taskset': None, u'kwargs': {u'source_id': 2}, 
u'eta': None, u'reply_to': u'1ef307a8-f3cd-3f83-926f-43b7bac1e024', u'id': 
u'3ca60897-e1fd-4a0c-85a8-399a4f486129', u'headers': {}}) kwargs:{})
checkouts.managers <18312> [DEBUG] "expired_check_outs() expired_list: 
<QuerySet []>"
[2017-04-19 16:36:44,966: DEBUG/Worker-2] expired_list: <QuerySet []>
documents.managers <18313> [INFO] "check_delete_periods() Checking deletion 
period of document type: Belege"
[2017-04-19 16:36:44,990: INFO/Worker-3] Checking deletion period of document 
type: Belege
documents.managers <18313> [INFO] "check_delete_periods() Document type: 
Belege, has a deletion period delta of: 30 days, 0:00:00"
[2017-04-19 16:36:44,990: INFO/Worker-3] Document type: Belege, has a deletion 
period delta of: 30 days, 0:00:00
[2017-04-19 16:36:44,994: DEBUG/MainProcess] Task accepted: 
sources.tasks.task_check_interval_source[3ca60897-e1fd-4a0c-85a8-399a4f486129] 
pid:18311
documents.managers <18313> [INFO] "check_delete_periods() Checking deletion 
period of document type: Kunden"
[2017-04-19 16:36:44,995: INFO/Worker-3] Checking deletion period of document 
type: Kunden
documents.managers <18313> [INFO] "check_delete_periods() Document type: 
Kunden, has a deletion period delta of: 30 days, 0:00:00"
[2017-04-19 16:36:44,995: INFO/Worker-3] Document type: Kunden, has a deletion 
period delta of: 30 days, 0:00:00
[2017-04-19 16:36:44,997: INFO/MainProcess] Task 
checkouts.tasks.task_check_expired_check_outs[6dc3d270-2104-4ce7-8954-52b58ec41a1c]
 succeeded in 0.0332658132538s: None
documents.managers <18313> [INFO] "check_delete_periods() Checking deletion 
period of document type: Privat"
[2017-04-19 16:36:44,998: INFO/Worker-3] Checking deletion period of document 
type: Privat
documents.managers <18313> [INFO] "check_delete_periods() Document type: 
Privat, has a deletion period delta of: 30 days, 0:00:00"
[2017-04-19 16:36:44,999: INFO/Worker-3] Document type: Privat, has a deletion 
period delta of: 30 days, 0:00:00
documents.managers <18314> [INFO] "check_trash_periods() Checking trash period 
of document type: Belege"
[2017-04-19 16:36:45,000: INFO/Worker-4] Checking trash period of document 
type: Belege
documents.managers <18314> [INFO] "check_trash_periods() Document type: Belege, 
has a no retention delta"
[2017-04-19 16:36:45,001: INFO/Worker-4] Document type: Belege, has a no 
retention delta
documents.managers <18314> [INFO] "check_trash_periods() Checking trash period 
of document type: Kunden"
[2017-04-19 16:36:45,001: INFO/Worker-4] Checking trash period of document 
type: Kunden
documents.managers <18314> [INFO] "check_trash_periods() Document type: Kunden, 
has a no retention delta"
[2017-04-19 16:36:45,001: INFO/Worker-4] Document type: Kunden, has a no 
retention delta
documents.managers <18314> [INFO] "check_trash_periods() Checking trash period 
of document type: Privat"
[2017-04-19 16:36:45,001: INFO/Worker-4] Checking trash period of document 
type: Privat
documents.managers <18314> [INFO] "check_trash_periods() Document type: Privat, 
has a no retention delta"
[2017-04-19 16:36:45,001: INFO/Worker-4] Document type: Privat, has a no 
retention delta
documents.managers <18314> [INFO] "check_trash_periods() Checking trash period 
of document type: Sonstiges"
[2017-04-19 16:36:45,001: INFO/MainProcess] Received task: 
sources.tasks.task_check_interval_source[16ff19b8-1f85-44b0-86a3-7481bd03b125]
[2017-04-19 16:36:45,001: INFO/Worker-4] Checking trash period of document 
type: Sonstiges
documents.managers <18314> [INFO] "check_trash_periods() Document type: 
Sonstiges, has a no retention delta"
[2017-04-19 16:36:45,001: INFO/Worker-4] Document type: Sonstiges, has a no 
retention delta
[2017-04-19 16:36:45,001: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'sources.tasks.task_check_interval_source', 
u'16ff19b8-1f85-44b0-86a3-7481bd03b125', [], {u'source_id': 3}, {u'utc': True, 
u'is_eager': False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'sources_periodic', u'exchange': u'sources_periodic'}, u'expires': None, 
u'hostname': 'celery@dms', u'task': 
u'sources.tasks.task_check_interval_source', u'callbacks': None, 
u'correlation_id': u'16ff19b8-1f85-44b0-86a3-7481bd03b125', u'errbacks': None, 
u'timelimit': [None, None], u'taskset': None, u'kwargs': {u'source_id': 3}, 
u'eta': None, u'reply_to': u'1ef307a8-f3cd-3f83-926f-43b7bac1e024', u'id': 
u'16ff19b8-1f85-44b0-86a3-7481bd03b125', u'headers': {}}) kwargs:{})
documents.managers <18313> [INFO] "check_delete_periods() Checking deletion 
period of document type: Sonstiges"
documents.managers <18314> [INFO] "check_trash_periods() Checking trash period 
of document type: Verträge"
[2017-04-19 16:36:45,002: INFO/Worker-4] Checking trash period of document 
type: Verträge
[2017-04-19 16:36:45,002: INFO/Worker-3] Checking deletion period of document 
type: Sonstiges
documents.managers <18314> [INFO] "check_trash_periods() Document type: 
Verträge, has a no retention delta"
documents.managers <18313> [INFO] "check_delete_periods() Document type: 
Sonstiges, has a deletion period delta of: 30 days, 0:00:00"
[2017-04-19 16:36:45,002: INFO/Worker-4] Document type: Verträge, has a no 
retention delta
[2017-04-19 16:36:45,002: INFO/Worker-3] Document type: Sonstiges, has a 
deletion period delta of: 30 days, 0:00:00
documents.managers <18314> [INFO] "check_trash_periods() Finshed"
[2017-04-19 16:36:45,002: INFO/Worker-4] Finshed
[2017-04-19 16:36:45,003: INFO/MainProcess] Task 
documents.tasks.task_check_trash_periods[1b9cdffa-5d74-4b5a-a2ea-cc2798411efd] 
succeeded in 0.0210350798443s: None
documents.managers <18313> [INFO] "check_delete_periods() Checking deletion 
period of document type: Verträge"
[2017-04-19 16:36:45,005: INFO/Worker-3] Checking deletion period of document 
type: Verträge
documents.managers <18313> [INFO] "check_delete_periods() Document type: 
Verträge, has a deletion period delta of: 30 days, 0:00:00"
[2017-04-19 16:36:45,005: INFO/Worker-3] Document type: Verträge, has a 
deletion period delta of: 30 days, 0:00:00
documents.managers <18313> [INFO] "check_delete_periods() Finshed"
[2017-04-19 16:36:45,009: INFO/Worker-3] Finshed
[2017-04-19 16:36:45,011: DEBUG/MainProcess] Task accepted: 
sources.tasks.task_check_interval_source[16ff19b8-1f85-44b0-86a3-7481bd03b125] 
pid:18312
[2017-04-19 16:36:45,013: INFO/MainProcess] Received task: 
sources.tasks.task_check_interval_source[be3cfa2f-51b6-4afe-82e5-96c0b71a935a]
[2017-04-19 16:36:45,013: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'sources.tasks.task_check_interval_source', 
u'be3cfa2f-51b6-4afe-82e5-96c0b71a935a', [], {u'source_id': 4}, {u'utc': True, 
u'is_eager': False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'sources_periodic', u'exchange': u'sources_periodic'}, u'expires': None, 
u'hostname': 'celery@dms', u'task': 
u'sources.tasks.task_check_interval_source', u'callbacks': None, 
u'correlation_id': u'be3cfa2f-51b6-4afe-82e5-96c0b71a935a', u'errbacks': None, 
u'timelimit': [None, None], u'taskset': None, u'kwargs': {u'source_id': 4}, 
u'eta': None, u'reply_to': u'1ef307a8-f3cd-3f83-926f-43b7bac1e024', u'id': 
u'be3cfa2f-51b6-4afe-82e5-96c0b71a935a', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:45,015: INFO/MainProcess] Received task: 
sources.tasks.task_check_interval_source[b74d5b9e-2cf6-4eb0-9c29-facc14f603bf]
[2017-04-19 16:36:45,016: DEBUG/MainProcess] TaskPool: Apply <function 
_fast_trace_task at 0x7fef86ba0050> 
(args:(u'sources.tasks.task_check_interval_source', 
u'b74d5b9e-2cf6-4eb0-9c29-facc14f603bf', [], {u'source_id': 5}, {u'utc': True, 
u'is_eager': False, u'chord': None, u'group': None, u'args': [], u'retries': 0, 
u'delivery_info': {u'priority': 0, u'redelivered': None, u'routing_key': 
u'sources_periodic', u'exchange': u'sources_periodic'}, u'expires': None, 
u'hostname': 'celery@dms', u'task': 
u'sources.tasks.task_check_interval_source', u'callbacks': None, 
u'correlation_id': u'b74d5b9e-2cf6-4eb0-9c29-facc14f603bf', u'errbacks': None, 
u'timelimit': [None, None], u'taskset': None, u'kwargs': {u'source_id': 5}, 
u'eta': None, u'reply_to': u'1ef307a8-f3cd-3f83-926f-43b7bac1e024', u'id': 
u'b74d5b9e-2cf6-4eb0-9c29-facc14f603bf', u'headers': {}}) kwargs:{})
[2017-04-19 16:36:45,017: INFO/MainProcess] Task 
documents.tasks.task_check_delete_periods[08c59b12-9a8c-4116-9e8e-61f00b88d523] 
succeeded in 0.0405464610085s: None
[2017-04-19 16:36:45,019: DEBUG/MainProcess] Task accepted: 
sources.tasks.task_check_interval_source[b74d5b9e-2cf6-4eb0-9c29-facc14f603bf] 
pid:18313
[2017-04-19 16:36:45,019: INFO/MainProcess] Task 
sources.tasks.task_check_interval_source[3ca60897-e1fd-4a0c-85a8-399a4f486129] 
succeeded in 0.0286133619957s: None
[2017-04-19 16:36:45,020: DEBUG/MainProcess] Task accepted: 
sources.tasks.task_check_interval_source[be3cfa2f-51b6-4afe-82e5-96c0b71a935a] 
pid:18314
[2017-04-19 16:36:45,030: INFO/MainProcess] Task 
sources.tasks.task_check_interval_source[16ff19b8-1f85-44b0-86a3-7481bd03b125] 
succeeded in 0.02566263685s: None
[2017-04-19 16:36:45,034: INFO/MainProcess] Task 
sources.tasks.task_check_interval_source[b74d5b9e-2cf6-4eb0-9c29-facc14f603bf] 
succeeded in 0.0165892806835s: None
[2017-04-19 16:36:45,037: INFO/MainProcess] Task 
sources.tasks.task_check_interval_source[be3cfa2f-51b6-4afe-82e5-96c0b71a935a] 
succeeded in 0.0197966410778s: Noneworker-stderr.log

Reply via email to