search

signalapp / Signal-Android

A private messenger for Android.
https://signal.org
GNU Affero General Public License v3.0
25.59k stars 6.14k forks source link

Missing/empty thumbnail for some pictures #6704

Closed motatuc closed 6 years ago

motatuc commented 7 years ago

I have:

Bug description

The pictures sent by one of my chat partners are shown as empty thumbnails. I can however open them. Only the thumbnail is the problem. Pictures from other contacts show just fine. The pictures in question were taken by the senders phone, no modifications were made.

Before sending me the first picture, the contact sent me a video. Maybe that is related to the problem.

Steps to reproduce

Actual result: Thumbnail of the picture is empty Expected result: There should be thumbnails

Screenshots

example

Device info

Android version: 7.1.2 Signal version: 4.6.1

Debug log

06-05 10:53:22.541  1420  3029 I ActivityManager: START u0 {cmp=org.thoughtcrime.securesms/.ConversationActivity (has extras)} from uid 10068 on display 0
06-05 10:53:22.555  4856  4856 W PassphraseRequiredActionBarActivity: onPause()
06-05 10:53:22.571  4856  4856 W KeyCachingService: onStartCommand, org.thoughtcrime.securesms.service.action.ACTIVITY_STOP_EVENT
06-05 10:53:22.571  4856  4856 W KeyCachingService: Decrementing activity count...
06-05 10:53:22.571  4856  4856 W MessageRetrievalService: Active Count: 0
06-05 10:53:22.577  4856  4856 W PassphraseRequiredActionBarActivity: onCreate(null)
06-05 10:53:22.579  4856  4856 W ExperienceUpgradeActivity: getExperienceUpgrade(262)
06-05 10:53:22.579  4856  4856 W PassphraseRequiredActionBarActivity: routeApplicationState(), state: 0
06-05 10:53:22.581  4856  4856 W PassphraseRequiredActionBarActivity: initializeClearKeyReceiver()
06-05 10:53:22.583  4856  4856 W ConversationActivity: onCreate()
06-05 10:53:22.583  4856  4856 I AppCompatDelegate: You should now use the AppCompatDelegate.FEATURE_SUPPORT_ACTION_BAR_OVERLAY id when requesting this feature.
06-05 10:53:22.596  4856  4856 W QuickAttachmentDrawer: updateControlsView()
06-05 10:53:22.692  4856 19719 W PhoneNumberFormatter: Got local CC: DE
06-05 10:53:22.714  4856  5061 W MmsSmsDatabase: Executing query: SELECT _id, unique_row_id, body, type, thread_id, address, address_device_id, subject, date_sent, date_received, m_type, msg_box, status, part_count, ct_l, tr_id, m_size, exp, st, delivery_receipt_count, mismatched_identities, network_failures, subscription_id, expires_in, expire_started, notified, transport_type, attachment_id, unique_id, mid, data_size, file_name, _data, thumbnail, ct, cl, digest, fast_preflight_id, voice_note, cd, name, pending_push FROM (SELECT DISTINCT date_sent AS date_sent, date AS date_received, _id, 'SMS::' || _id || '::' || date_sent AS unique_row_id, NULL AS attachment_id, body, read, thread_id, type, address, address_device_id, subject, NULL AS m_type, NULL AS msg_box, status, NULL AS part_count, NULL AS ct_l, NULL AS tr_id, NULL AS m_size, NULL AS exp, NULL AS st, delivery_receipt_count, mismatched_identities, subscription_id, expires_in, expire_started, notified, NULL AS network_failures, 'sms' AS transport_type, NULL AS unique_id, NULL AS mid, NULL AS data_size, NULL AS file_name, NULL AS _data, NULL AS thumbnail, NULL AS ct, NULL AS cl, NULL AS digest, NULL AS fast_preflight_id, NULL AS voice_note, NULL AS cd, NULL AS name, NULL AS pending_push FROM sms WHERE (thread_id = 5) UNION ALL SELECT DISTINCT date AS date_sent, date_received AS date_received, mms._id AS _id, 'MMS::' || mms._id || '::' || date AS unique_row_id, part._id AS attachment_id, body, read, thread_id, NULL AS type, address, address_device_id, NULL AS subject, m_type, msg_box, NULL AS status, part_count, ct_l, tr_id, m_size, exp, st, delivery_receipt_count, mismatched_identities, subscription_id, expires_in, expire_started, notified, network_failures, 'mms' AS transport_type, unique_id, mid, data_size, file_name, _data, thumbnail, ct, cl, digest, fast_preflight_id, voice_note, cd, name, pending_push FROM mms LEFT OUTER JOIN part ON part._id =  (SELECT part._id FROM part WHERE part.mid = mms._id LIMIT 1) WHERE (thread_id = 5) ORDER BY date_received DESC LIMIT 500)
06-05 10:53:22.718  4856  4876 W PhoneNumberFormatter: Got local CC: DE
06-05 10:53:22.724   285  1433 E NetlinkEvent: NetlinkEvent::FindParam(): Parameter 'UID' not found
06-05 10:53:22.725  4856  4856 W PassphraseRequiredActionBarActivity: onResume()
06-05 10:53:22.742  4856  4856 W ConversationActivity: onResume() Finished: 1496652802742
06-05 10:53:22.756  4856  4856 W KeyboardAwareLinearLayout: rotation changed
06-05 10:53:22.756  4856  4856 W KeyboardAwareLinearLayout: onKeyboardClose()
06-05 10:53:22.767  4856 19702 W MmsSmsDatabase: Executing query: SELECT _id, unique_row_id, body, type, thread_id, address, address_device_id, subject, date_sent, date_received, m_type, msg_box, status, part_count, ct_l, tr_id, m_size, exp, st, delivery_receipt_count, mismatched_identities, network_failures, subscription_id, expires_in, expire_started, notified, transport_type, attachment_id, unique_id, mid, data_size, file_name, _data, thumbnail, ct, cl, digest, fast_preflight_id, voice_note, cd, name, pending_push FROM (SELECT DISTINCT date_sent AS date_sent, date AS date_received, _id, 'SMS::' || _id || '::' || date_sent AS unique_row_id, NULL AS attachment_id, body, read, thread_id, type, address, address_device_id, subject, NULL AS m_type, NULL AS msg_box, status, NULL AS part_count, NULL AS ct_l, NULL AS tr_id, NULL AS m_size, NULL AS exp, NULL AS st, delivery_receipt_count, mismatched_identities, subscription_id, expires_in, expire_started, notified, NULL AS network_failures, 'sms' AS transport_type, NULL AS unique_id, NULL AS mid, NULL AS data_size, NULL AS file_name, NULL AS _data, NULL AS thumbnail, NULL AS ct, NULL AS cl, NULL AS digest, NULL AS fast_preflight_id, NULL AS voice_note, NULL AS cd, NULL AS name, NULL AS pending_push FROM sms WHERE (read = 0 AND notified = 0) UNION ALL SELECT DISTINCT date AS date_sent, date_received AS date_received, mms._id AS _id, 'MMS::' || mms._id || '::' || date AS unique_row_id, part._id AS attachment_id, body, read, thread_id, NULL AS type, address, address_device_id, NULL AS subject, m_type, msg_box, NULL AS status, part_count, ct_l, tr_id, m_size, exp, st, delivery_receipt_count, mismatched_identities, subscription_id, expires_in, expire_started, notified, network_failures, 'mms' AS transport_type, unique_id, mid, data_size, file_name, _data, thumbnail, ct, cl, digest, fast_preflight_id, voice_note, cd, name, pending_push FROM mms LEFT OUTER JOIN part ON part._id =  (SELECT part._id FROM part WHERE part.mid = mms._id LIMIT 1) WHERE (read = 0 AND notified = 0) ORDER BY date_received ASC)
06-05 10:53:22.775  4856 19702 W IdentityDatabase: Setting seen to current time: 3
06-05 10:53:22.778  4856  4856 W CameraView: skipping layout due to zero-width/height preview size
06-05 10:53:22.781  4856  4856 W KeyCachingService: onStartCommand, org.thoughtcrime.securesms.service.action.ACTIVITY_START_EVENT
06-05 10:53:22.781  4856  4856 W KeyCachingService: Incrementing activity count...
06-05 10:53:22.809  4856  4856 W MessageRetrievalService: Active Count: 1
06-05 10:53:22.810  4856  4856 W ConversationFragment: onLoadFinished
06-05 10:53:22.845  4856  4856 W ConversationAdapter: Inflate time: 14
06-05 10:53:22.847  4856  4856 W ConversationAdapter: Bind time: 2
06-05 10:53:22.869  4856  4856 W ConversationAdapter: Inflate time: 17
06-05 10:53:22.877  4856  4856 W ThumbnailView: loading part with id content://org.thoughtcrime.securesms/part/1496595547205/29, progress 0, fast preflight id: null
06-05 10:53:22.886  4856  4856 W ConversationAdapter: Bind time: 17
06-05 10:53:22.905  4856  4856 W ConversationAdapter: Inflate time: 15
06-05 10:53:22.910  4856  4856 W ThumbnailView: loading part with id content://org.thoughtcrime.securesms/part/1496595504335/28, progress 0, fast preflight id: null
06-05 10:53:22.918  4856  4856 W ConversationAdapter: Bind time: 13
06-05 10:53:22.951  4856  4856 W ConversationActivity: updateInviteReminder(false)
06-05 10:53:22.952  1420  1521 I ActivityManager: Displayed org.thoughtcrime.securesms/.ConversationActivity: +395ms
06-05 10:53:22.952  4856  4856 W ConversationActivity: updateDefaultSubscriptionId(null)
06-05 10:53:22.997  4856  4989 D OpenGLRenderer: endAllActiveAnimators on 0xcf39b180 (RippleDrawable) with handle 0xce1686d0
06-05 10:53:23.018  4856 19609 W WebSocketConnection: WSC onMessage()
06-05 10:53:23.018  4856 19609 W WebSocketConnection: Message Type: 2
06-05 10:55:44.083  4856  4856 W KeyCachingService: onStartCommand, org.thoughtcrime.securesms.service.action.ACTIVITY_STOP_EVENT
06-05 10:55:44.083  4856  4856 W KeyCachingService: Decrementing activity count...
06-05 10:55:44.083  4856  4856 W MessageRetrievalService: Active Count: 0
06-05 10:55:44.087  4856  4856 W PassphraseRequiredActionBarActivity: onCreate(null)
06-05 10:55:44.089  4856  4856 W ExperienceUpgradeActivity: getExperienceUpgrade(262)
06-05 10:55:44.090  4856  4856 W PassphraseRequiredActionBarActivity: routeApplicationState(), state: 0
06-05 10:55:44.092  4856  4856 W PassphraseRequiredActionBarActivity: initializeClearKeyReceiver()
06-05 10:55:44.131  4856  4856 W PassphraseRequiredActionBarActivity: onResume()
06-05 10:55:44.134  4856  4856 W MediaPreviewActivity: Loading Part URI: content://org.thoughtcrime.securesms/part/1496595547205/29
06-05 10:55:44.135  4856  4856 W org.thoughtcrime.securesms.components.ZoomingImageView: Max texture size: 4096
06-05 10:55:44.158  4856  4856 W KeyCachingService: onStartCommand, org.thoughtcrime.securesms.service.action.ACTIVITY_START_EVENT
06-05 10:55:44.158  4856  4856 W KeyCachingService: Incrementing activity count...
06-05 10:55:44.158  4856  4856 W MessageRetrievalService: Active Count: 1
06-05 10:55:44.203  1420  1521 I ActivityManager: Displayed org.thoughtcrime.securesms/.MediaPreviewActivity: +148ms
06-05 10:55:44.209  4856  4856 W IInputConnectionWrapper: finishComposingText on inactive InputConnection
06-05 10:55:44.237  4856  4856 W org.thoughtcrime.securesms.components.ZoomingImageView: Dimensions: 3264, 2448
06-05 10:55:44.237  4856  4856 W org.thoughtcrime.securesms.components.ZoomingImageView: Loading in standard image view...
06-05 10:55:44.597  4856  4856 W EventBus: Subscriber to unregister was not registered before: class org.thoughtcrime.securesms.ConversationActivity
06-05 10:55:48.854  2526  2526 I SlideTouchEvent: vel=0.0, MinimumFlingVelocity=100
06-05 10:55:48.862  4856  4856 W PassphraseRequiredActionBarActivity: onPause()
06-05 10:55:48.873  4856  4856 W KeyCachingService: onStartCommand, org.thoughtcrime.securesms.service.action.ACTIVITY_STOP_EVENT
06-05 10:55:48.873  4856  4856 W KeyCachingService: Decrementing activity count...
06-05 10:55:48.873  4856  4856 W MessageRetrievalService: Active Count: 0
06-05 10:55:48.881  4856  4856 W PassphraseRequiredActionBarActivity: onResume()
06-05 10:55:48.873 18291 18291 W kworker/u8:1: type=1400 audit(0.0:1810841): avc: denied { setsched } for scontext=u:r:kernel:s0 tcontext=u:r:priv_app:s0:c512,c768 tclass=process permissive=0
06-05 10:55:48.873 18291 18291 W kworker/u8:1: type=1400 audit(0.0:1810842): avc: denied { setsched } for scontext=u:r:kernel:s0 tcontext=u:r:system_app:s0 tclass=process permissive=0
06-05 10:55:48.873 18291 18291 W kworker/u8:1: type=1400 audit(0.0:1810843): avc: denied { setsched } for scontext=u:r:kernel:s0 tcontext=u:r:system_app:s0 tclass=process permissive=0
06-05 10:55:48.873 18291 18291 W kworker/u8:1: type=1400 audit(0.0:1810844): avc: denied { setsched } for scontext=u:r:kernel:s0 tcontext=u:r:untrusted_app:s0:c512,c768 tclass=process permissive=0
06-05 10:55:48.873 18291 18291 W kworker/u8:1: type=1400 audit(0.0:1810845): avc: denied { setsched } for scontext=u:r:kernel:s0 tcontext=u:r:system_app:s0 tclass=process permissive=0
06-05 10:55:48.873 18291 18291 W kworker/u8:1: type=1400 audit(0.0:1810846): avc: denied { setsched } for scontext=u:r:kernel:s0 tcontext=u:r:system_app:s0 tclass=process permissive=0
06-05 10:55:48.873 18291 18291 W kworker/u8:1: type=1400 audit(0.0:1810847): avc: denied { setsched } for scontext=u:r:kernel:s0 tcontext=u:r:system_app:s0 tclass=process permissive=0
06-05 10:55:48.873 18291 18291 W kworker/u8:1: type=1400 audit(0.0:1810848): avc: denied { setsched } for scontext=u:r:kernel:s0 tcontext=u:r:system_app:s0 tclass=process permissive=0
06-05 10:55:48.873 18291 18291 W kworker/u8:1: type=1400 audit(0.0:1810849): avc: denied { setsched } for scontext=u:r:kernel:s0 tcontext=u:r:untrusted_app:s0:c512,c768 tclass=process permissive=0
06-05 10:55:48.873 18291 18291 W kworker/u8:1: type=1400 audit(0.0:1810850): avc: denied { setsched } for scontext=u:r:kernel:s0 tcontext=u:r:system_app:s0 tclass=process permissive=0
06-05 10:55:48.873 18291 18291 W kworker/u8:1: type=1400 audit(0.0:1810851): avc: denied { setsched } for scontext=u:r:kernel:s0 tcontext=u:r:system_app:s0 tclass=process permissive=0
06-05 10:55:48.873 18291 18291 W kworker/u8:1: type=1400 audit(0.0:1810852): avc: denied { setsched } for scontext=u:r:kernel:s0 tcontext=u:r:system_app:s0 tclass=process permissive=0
06-05 10:55:48.873 18291 18291 W kworker/u8:1: type=1400 audit(0.0:1810853): avc: denied { setsched } for scontext=u:r:kernel:s0 tcontext=u:r:system_app:s0 tclass=process permissive=0
06-05 10:55:48.873 18291 18291 W kworker/u8:1: type=1400 audit(0.0:1810854): avc: denied { setsched } for scontext=u:r:kernel:s0 tcontext=u:r:system_app:s0 tclass=process permissive=0
06-05 10:55:48.873 18291 18291 W kworker/u8:1: type=1400 audit(0.0:1810855): avc: denied { setsched } for scontext=u:r:kernel:s0 tcontext=u:r:system_app:s0 tclass=process permissive=0
06-05 10:55:48.873 18291 18291 W kworker/u8:1: type=1400 audit(0.0:1810856): avc: denied { setsched } for scontext=u:r:kernel:s0 tcontext=u:r:system_app:s0 tclass=process permissive=0
06-05 10:55:48.873 18291 18291 W kworker/u8:1: type=1400 audit(0.0:1810857): avc: denied { setsched } for scontext=u:r:kernel:s0 tcontext=u:r:untrusted_app:s0:c512,c768 tclass=process permissive=0
06-05 10:55:48.873 18291 18291 W kworker/u8:1: type=1400 audit(0.0:1810858): avc: denied { setsched } for scontext=u:r:kernel:s0 tcontext=u:r:untrusted_app:s0:c512,c768 tclass=process permissive=0
06-05 10:55:48.873 18291 18291 W kworker/u8:1: type=1400 audit(0.0:1810859): avc: denied { setsched } for scontext=u:r:kernel:s0 tcontext=u:r:untrusted_app:s0:c512,c768 tclass=process permissive=0
06-05 10:55:48.873 18291 18291 W kworker/u8:1: type=1400 audit(0.0:1810860): avc: denied { setsched } for scontext=u:r:kernel:s0 tcontext=u:r:untrusted_app:s0:c512,c768 tclass=process permissive=0
06-05 10:55:48.893  4856  4856 W ConversationActivity: onResume() Finished: 1496652948893
06-05 10:55:48.908  4856  4856 W CameraView: skipping layout due to zero-width/height preview size
06-05 10:55:48.910  4856  4856 W ConversationAdapter: Bind time: 1
06-05 10:55:48.912  4856  4856 W ThumbnailView: Not re-loading slide content://org.thoughtcrime.securesms/part/1496595547205/29
06-05 10:55:48.920  4856  4856 W ConversationAdapter: Bind time: 8
06-05 10:55:48.922  4856  4856 W ThumbnailView: Not re-loading slide content://org.thoughtcrime.securesms/part/1496595504335/28
06-05 10:55:48.928  4856 19813 W MmsSmsDatabase: Executing query: SELECT _id, unique_row_id, body, type, thread_id, address, address_device_id, subject, date_sent, date_received, m_type, msg_box, status, part_count, ct_l, tr_id, m_size, exp, st, delivery_receipt_count, mismatched_identities, network_failures, subscription_id, expires_in, expire_started, notified, transport_type, attachment_id, unique_id, mid, data_size, file_name, _data, thumbnail, ct, cl, digest, fast_preflight_id, voice_note, cd, name, pending_push FROM (SELECT DISTINCT date_sent AS date_sent, date AS date_received, _id, 'SMS::' || _id || '::' || date_sent AS unique_row_id, NULL AS attachment_id, body, read, thread_id, type, address, address_device_id, subject, NULL AS m_type, NULL AS msg_box, status, NULL AS part_count, NULL AS ct_l, NULL AS tr_id, NULL AS m_size, NULL AS exp, NULL AS st, delivery_receipt_count, mismatched_identities, subscription_id, expires_in, expire_started, notified, NULL AS network_failures, 'sms' AS transport_type, NULL AS unique_id, NULL AS mid, NULL AS data_size, NULL AS file_name, NULL AS _data, NULL AS thumbnail, NULL AS ct, NULL AS cl, NULL AS digest, NULL AS fast_preflight_id, NULL AS voice_note, NULL AS cd, NULL AS name, NULL AS pending_push FROM sms WHERE (read = 0 AND notified = 0) UNION ALL SELECT DISTINCT date AS date_sent, date_received AS date_received, mms._id AS _id, 'MMS::' || mms._id || '::' || date AS unique_row_id, part._id AS attachment_id, body, read, thread_id, NULL AS type, address, address_device_id, NULL AS subject, m_type, msg_box, NULL AS status, part_count, ct_l, tr_id, m_size, exp, st, delivery_receipt_count, mismatched_identities, subscription_id, expires_in, expire_started, notified, network_failures, 'mms' AS transport_type, unique_id, mid, data_size, file_name, _data, thumbnail, ct, cl, digest, fast_preflight_id, voice_note, cd, name, pending_push FROM mms LEFT OUTER JOIN part ON part._id =  (SELECT part._id FROM part WHERE part.mid = mms._id LIMIT 1) WHERE (read = 0 AND notified = 0) ORDER BY date_received ASC)
06-05 10:55:48.930  4856  4856 W ConversationAdapter: Bind time: 9
06-05 10:55:48.934  4856  4856 W KeyCachingService: onStartCommand, org.thoughtcrime.securesms.service.action.ACTIVITY_START_EVENT
06-05 10:55:48.934  4856  4856 W KeyCachingService: Incrementing activity count...
06-05 10:55:48.935  4856  4856 W MessageRetrievalService: Active Count: 1
06-05 10:55:48.937  4856 19813 W IdentityDatabase: Setting seen to current time: 3
06-05 10:55:48.992  4856  4856 W CameraView: skipping layout due to zero-width/height preview size
06-05 10:55:49.256  4856  4856 W PassphraseRequiredActionBarActivity: onDestroy()
06-05 10:55:52.595  4856 19620 W WebSocketConnection: Sending keep alive...
scottnonnenberg commented 6 years ago

This happened to me when I tried to send a .tif image to 4.17.4, testing this Signal Desktop change https://github.com/WhisperSystems/Signal-Desktop/pull/1901

ghost commented 6 years ago

It indeed seems to be related with receiving a video. I got a video from one of my contacts, and from that time all previews in that conversation are empty.

automated-signal commented 6 years ago

GitHub Issue Cleanup: See #7598 for more information.