Results for igt@kms_flip@plain-flip-fb-recreate@a-vga1

Machine description: shard-snb6

Result: Fail

git-log-oneline i915_display_info7 igt_runner7 runtimes7 results7.json results7-i915-load.json i915_display_info_post_exec7 boot7 dmesg7

DetailValue
Duration 10.31 seconds
Hostname
shard-snb6
Igt-Version
IGT-Version: 1.30-gcdae18aa2 (x86_64) (Linux: 6.14.0-rc5-CI_DRM_16246-gf811577f4244+ x86_64)
Out
Using IGT_SRANDOM=1741393205 for randomisation
Opened device: /dev/dri/card0
Using monotonic timestamps
Starting subtest: plain-flip-fb-recreate
Starting dynamic subtest: A-VGA1
  1024x768: 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa 
Expected frametime: 16666us; measured 16837.0us +- 5.680us accuracy 0.10%
vblank interval differs from modeline! expected 16665.6us, measured 16837us +- 5.680us, difference 171.4us (30.2 sigma)
Stack trace:
  #0 ../lib/igt_core.c:2055 __igt_fail_assert()
  #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0()
  #2 ../tests/kms_flip.c:1845 run_test()
  #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001()
  #4 ../tests/kms_flip.c:2001 main()
  #5 [__libc_init_first+0x8a]
  #6 [__libc_start_main+0x8b]
  #7 [_start+0x25]
Dynamic subtest A-VGA1: FAIL (10.312s)
Err
Starting subtest: plain-flip-fb-recreate
Starting dynamic subtest: A-VGA1
(kms_flip:2560) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674:
(kms_flip:2560) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon)
Dynamic subtest A-VGA1 failed.
**** DEBUG ****
(kms_flip:2560) DEBUG: flip ts/seq: last 152.132462/5231, current 152.149246/5232: elapsed=16793.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.149246
last_received_ts = 152.148666
last_seq = 5232
current_ts = 152.166016
current_received_ts = 152.165466
current_seq = 5233
count = 263
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.149246/5232, current 152.166016/5233: elapsed=16773.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.166016
last_received_ts = 152.165466
last_seq = 5233
current_ts = 152.182800
current_received_ts = 152.182220
current_seq = 5234
count = 264
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.166016/5233, current 152.182800/5234: elapsed=16778.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.182800
last_received_ts = 152.182220
last_seq = 5234
current_ts = 152.199585
current_received_ts = 152.199051
current_seq = 5235
count = 265
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.182800/5234, current 152.199585/5235: elapsed=16786.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.199585
last_received_ts = 152.199051
last_seq = 5235
current_ts = 152.216370
current_received_ts = 152.215790
current_seq = 5236
count = 266
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.199585/5235, current 152.216370/5236: elapsed=16778.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.216370
last_received_ts = 152.215790
last_seq = 5236
current_ts = 152.233154
current_received_ts = 152.232605
current_seq = 5237
count = 267
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.216370/5236, current 152.233154/5237: elapsed=16791.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.233154
last_received_ts = 152.232605
last_seq = 5237
current_ts = 152.249939
current_received_ts = 152.249374
current_seq = 5238
count = 268
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.233154/5237, current 152.249939/5238: elapsed=16783.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.249939
last_received_ts = 152.249374
last_seq = 5238
current_ts = 152.266724
current_received_ts = 152.266113
current_seq = 5239
count = 269
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.249939/5238, current 152.266724/5239: elapsed=16790.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.266724
last_received_ts = 152.266113
last_seq = 5239
current_ts = 152.283508
current_received_ts = 152.282928
current_seq = 5240
count = 270
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.266724/5239, current 152.283508/5240: elapsed=16773.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.283508
last_received_ts = 152.282928
last_seq = 5240
current_ts = 152.300278
current_received_ts = 152.299713
current_seq = 5241
count = 271
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.283508/5240, current 152.300278/5241: elapsed=16777.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.300278
last_received_ts = 152.299713
last_seq = 5241
current_ts = 152.317062
current_received_ts = 152.316498
current_seq = 5242
count = 272
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.300278/5241, current 152.317062/5242: elapsed=16782.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.317062
last_received_ts = 152.316498
last_seq = 5242
current_ts = 152.333862
current_received_ts = 152.333206
current_seq = 5243
count = 273
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.317062/5242, current 152.333862/5243: elapsed=16800.0us expected=16837.0us +- 84.2us, error 0.2%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.333862
last_received_ts = 152.333206
last_seq = 5243
current_ts = 152.350632
current_received_ts = 152.350067
current_seq = 5244
count = 274
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.333862/5243, current 152.350632/5244: elapsed=16767.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.350632
last_received_ts = 152.350067
last_seq = 5244
current_ts = 152.367416
current_received_ts = 152.366821
current_seq = 5245
count = 275
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.350632/5244, current 152.367416/5245: elapsed=16782.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.367416
last_received_ts = 152.366821
last_seq = 5245
current_ts = 152.384201
current_received_ts = 152.383606
current_seq = 5246
count = 276
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.367416/5245, current 152.384201/5246: elapsed=16796.0us expected=16837.0us +- 84.2us, error 0.2%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.384201
last_received_ts = 152.383606
last_seq = 5246
current_ts = 152.400970
current_received_ts = 152.400375
current_seq = 5247
count = 277
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.384201/5246, current 152.400970/5247: elapsed=16769.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.400970
last_received_ts = 152.400375
last_seq = 5247
current_ts = 152.417770
current_received_ts = 152.417206
current_seq = 5248
count = 278
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.400970/5247, current 152.417770/5248: elapsed=16798.0us expected=16837.0us +- 84.2us, error 0.2%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.417770
last_received_ts = 152.417206
last_seq = 5248
current_ts = 152.434540
current_received_ts = 152.433975
current_seq = 5249
count = 279
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.417770/5248, current 152.434540/5249: elapsed=16767.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.434540
last_received_ts = 152.433975
last_seq = 5249
current_ts = 152.451324
current_received_ts = 152.450745
current_seq = 5250
count = 280
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.434540/5249, current 152.451324/5250: elapsed=16783.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.451324
last_received_ts = 152.450745
last_seq = 5250
current_ts = 152.468124
current_received_ts = 152.467529
current_seq = 5251
count = 281
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.451324/5250, current 152.468124/5251: elapsed=16795.0us expected=16837.0us +- 84.2us, error 0.2%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.468124
last_received_ts = 152.467529
last_seq = 5251
current_ts = 152.484879
current_received_ts = 152.484299
current_seq = 5252
count = 282
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.468124/5251, current 152.484879/5252: elapsed=16767.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.484879
last_received_ts = 152.484299
last_seq = 5252
current_ts = 152.501663
current_received_ts = 152.501114
current_seq = 5253
count = 283
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.484879/5252, current 152.501663/5253: elapsed=16785.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.501663
last_received_ts = 152.501114
last_seq = 5253
current_ts = 152.518463
current_received_ts = 152.517853
current_seq = 5254
count = 284
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.501663/5253, current 152.518463/5254: elapsed=16794.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.518463
last_received_ts = 152.517853
last_seq = 5254
current_ts = 152.535248
current_received_ts = 152.534653
current_seq = 5255
count = 285
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.518463/5254, current 152.535248/5255: elapsed=16786.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.535248
last_received_ts = 152.534653
last_seq = 5255
current_ts = 152.552017
current_received_ts = 152.551453
current_seq = 5256
count = 286
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.535248/5255, current 152.552017/5256: elapsed=16767.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.552017
last_received_ts = 152.551453
last_seq = 5256
current_ts = 152.568802
current_received_ts = 152.568176
current_seq = 5257
count = 287
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.552017/5256, current 152.568802/5257: elapsed=16778.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.568802
last_received_ts = 152.568176
last_seq = 5257
current_ts = 152.585587
current_received_ts = 152.585052
current_seq = 5258
count = 288
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.568802/5257, current 152.585587/5258: elapsed=16786.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.585587
last_received_ts = 152.585052
last_seq = 5258
current_ts = 152.602371
current_received_ts = 152.601776
current_seq = 5259
count = 289
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.585587/5258, current 152.602371/5259: elapsed=16785.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.602371
last_received_ts = 152.601776
last_seq = 5259
current_ts = 152.619141
current_received_ts = 152.618591
current_seq = 5260
count = 290
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.602371/5259, current 152.619141/5260: elapsed=16782.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.619141
last_received_ts = 152.618591
last_seq = 5260
current_ts = 152.635941
current_received_ts = 152.635300
current_seq = 5261
count = 291
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.619141/5260, current 152.635941/5261: elapsed=16787.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.635941
last_received_ts = 152.635300
last_seq = 5261
current_ts = 152.652710
current_received_ts = 152.652161
current_seq = 5262
count = 292
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.635941/5261, current 152.652710/5262: elapsed=16778.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.652710
last_received_ts = 152.652161
last_seq = 5262
current_ts = 152.669495
current_received_ts = 152.668976
current_seq = 5263
count = 293
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.652710/5262, current 152.669495/5263: elapsed=16780.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.669495
last_received_ts = 152.668976
last_seq = 5263
current_ts = 152.686295
current_received_ts = 152.685745
current_seq = 5264
count = 294
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.669495/5263, current 152.686295/5264: elapsed=16796.0us expected=16837.0us +- 84.2us, error 0.2%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.686295
last_received_ts = 152.685745
last_seq = 5264
current_ts = 152.703079
current_received_ts = 152.702484
current_seq = 5265
count = 295
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.686295/5264, current 152.703079/5265: elapsed=16785.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.703079
last_received_ts = 152.702484
last_seq = 5265
current_ts = 152.719849
current_received_ts = 152.719238
current_seq = 5266
count = 296
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.703079/5265, current 152.719849/5266: elapsed=16771.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.719849
last_received_ts = 152.719238
last_seq = 5266
current_ts = 152.736618
current_received_ts = 152.736115
current_seq = 5267
count = 297
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.719849/5266, current 152.736618/5267: elapsed=16779.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.736618
last_received_ts = 152.736115
last_seq = 5267
current_ts = 152.753403
current_received_ts = 152.752838
current_seq = 5268
count = 298
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.736618/5267, current 152.753403/5268: elapsed=16779.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.753403
last_received_ts = 152.752838
last_seq = 5268
current_ts = 152.770187
current_received_ts = 152.769623
current_seq = 5269
count = 299
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.753403/5268, current 152.770187/5269: elapsed=16791.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.770187
last_received_ts = 152.769623
last_seq = 5269
current_ts = 152.786972
current_received_ts = 152.786438
current_seq = 5270
count = 300
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.770187/5269, current 152.786972/5270: elapsed=16780.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.786972
last_received_ts = 152.786438
last_seq = 5270
current_ts = 152.803757
current_received_ts = 152.803131
current_seq = 5271
count = 301
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.786972/5270, current 152.803757/5271: elapsed=16780.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.803757
last_received_ts = 152.803131
last_seq = 5271
current_ts = 152.820541
current_received_ts = 152.819992
current_seq = 5272
count = 302
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.803757/5271, current 152.820541/5272: elapsed=16785.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.820541
last_received_ts = 152.819992
last_seq = 5272
current_ts = 152.837311
current_received_ts = 152.836792
current_seq = 5273
count = 303
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.820541/5272, current 152.837311/5273: elapsed=16779.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.837311
last_received_ts = 152.836792
last_seq = 5273
current_ts = 152.854095
current_received_ts = 152.853546
current_seq = 5274
count = 304
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.837311/5273, current 152.854095/5274: elapsed=16781.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.854095
last_received_ts = 152.853546
last_seq = 5274
current_ts = 152.870880
current_received_ts = 152.870300
current_seq = 5275
count = 305
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.854095/5274, current 152.870880/5275: elapsed=16780.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.870880
last_received_ts = 152.870300
last_seq = 5275
current_ts = 152.887665
current_received_ts = 152.887115
current_seq = 5276
count = 306
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.870880/5275, current 152.887665/5276: elapsed=16786.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.887665
last_received_ts = 152.887115
last_seq = 5276
current_ts = 152.904449
current_received_ts = 152.903885
current_seq = 5277
count = 307
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.887665/5276, current 152.904449/5277: elapsed=16783.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.904449
last_received_ts = 152.903885
last_seq = 5277
current_ts = 152.921234
current_received_ts = 152.920654
current_seq = 5278
count = 308
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.904449/5277, current 152.921234/5278: elapsed=16786.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.921234
last_received_ts = 152.920654
last_seq = 5278
current_ts = 152.938004
current_received_ts = 152.937439
current_seq = 5279
count = 309
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.921234/5278, current 152.938004/5279: elapsed=16776.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.938004
last_received_ts = 152.937439
last_seq = 5279
current_ts = 152.954788
current_received_ts = 152.954178
current_seq = 5280
count = 310
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.938004/5279, current 152.954788/5280: elapsed=16784.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.954788
last_received_ts = 152.954178
last_seq = 5280
current_ts = 152.971558
current_received_ts = 152.971024
current_seq = 5281
count = 311
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.954788/5280, current 152.971558/5281: elapsed=16767.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.971558
last_received_ts = 152.971024
last_seq = 5281
current_ts = 152.988342
current_received_ts = 152.987762
current_seq = 5282
count = 312
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.971558/5281, current 152.988342/5282: elapsed=16788.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 152.988342
last_received_ts = 152.987762
last_seq = 5282
current_ts = 153.005112
current_received_ts = 153.004547
current_seq = 5283
count = 313
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 152.988342/5282, current 153.005112/5283: elapsed=16761.0us expected=16837.0us +- 84.2us, error 0.5%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.005112
last_received_ts = 153.004547
last_seq = 5283
current_ts = 153.021881
current_received_ts = 153.021301
current_seq = 5284
count = 314
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.005112/5283, current 153.021881/5284: elapsed=16775.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.021881
last_received_ts = 153.021301
last_seq = 5284
current_ts = 153.038681
current_received_ts = 153.038101
current_seq = 5285
count = 315
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.021881/5284, current 153.038681/5285: elapsed=16791.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.038681
last_received_ts = 153.038101
last_seq = 5285
current_ts = 153.055435
current_received_ts = 153.054901
current_seq = 5286
count = 316
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.038681/5285, current 153.055435/5286: elapsed=16766.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.055435
last_received_ts = 153.054901
last_seq = 5286
current_ts = 153.072220
current_received_ts = 153.071655
current_seq = 5287
count = 317
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.055435/5286, current 153.072220/5287: elapsed=16773.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.072220
last_received_ts = 153.071655
last_seq = 5287
current_ts = 153.088989
current_received_ts = 153.088425
current_seq = 5288
count = 318
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.072220/5287, current 153.088989/5288: elapsed=16775.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.088989
last_received_ts = 153.088425
last_seq = 5288
current_ts = 153.105774
current_received_ts = 153.105225
current_seq = 5289
count = 319
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.088989/5288, current 153.105774/5289: elapsed=16785.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.105774
last_received_ts = 153.105225
last_seq = 5289
current_ts = 153.122543
current_received_ts = 153.122025
current_seq = 5290
count = 320
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.105774/5289, current 153.122543/5290: elapsed=16763.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.122543
last_received_ts = 153.122025
last_seq = 5290
current_ts = 153.139313
current_received_ts = 153.138748
current_seq = 5291
count = 321
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.122543/5290, current 153.139313/5291: elapsed=16775.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.139313
last_received_ts = 153.138748
last_seq = 5291
current_ts = 153.156097
current_received_ts = 153.155518
current_seq = 5292
count = 322
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.139313/5291, current 153.156097/5292: elapsed=16788.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.156097
last_received_ts = 153.155518
last_seq = 5292
current_ts = 153.172867
current_received_ts = 153.172241
current_seq = 5293
count = 323
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.156097/5292, current 153.172867/5293: elapsed=16770.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.172867
last_received_ts = 153.172241
last_seq = 5293
current_ts = 153.189636
current_received_ts = 153.189102
current_seq = 5294
count = 324
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.172867/5293, current 153.189636/5294: elapsed=16765.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.189636
last_received_ts = 153.189102
last_seq = 5294
current_ts = 153.206421
current_received_ts = 153.205887
current_seq = 5295
count = 325
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.189636/5294, current 153.206421/5295: elapsed=16778.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.206421
last_received_ts = 153.205887
last_seq = 5295
current_ts = 153.223206
current_received_ts = 153.222580
current_seq = 5296
count = 326
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.206421/5295, current 153.223206/5296: elapsed=16791.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.223206
last_received_ts = 153.222580
last_seq = 5296
current_ts = 153.239975
current_received_ts = 153.239410
current_seq = 5297
count = 327
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.223206/5296, current 153.239975/5297: elapsed=16765.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.239975
last_received_ts = 153.239410
last_seq = 5297
current_ts = 153.256760
current_received_ts = 153.256210
current_seq = 5298
count = 328
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.239975/5297, current 153.256760/5298: elapsed=16785.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.256760
last_received_ts = 153.256210
last_seq = 5298
current_ts = 153.273529
current_received_ts = 153.272964
current_seq = 5299
count = 329
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.256760/5298, current 153.273529/5299: elapsed=16771.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.273529
last_received_ts = 153.272964
last_seq = 5299
current_ts = 153.290298
current_received_ts = 153.289658
current_seq = 5300
count = 330
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.273529/5299, current 153.290298/5300: elapsed=16766.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.290298
last_received_ts = 153.289658
last_seq = 5300
current_ts = 153.307068
current_received_ts = 153.306519
current_seq = 5301
count = 331
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.290298/5300, current 153.307068/5301: elapsed=16777.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.307068
last_received_ts = 153.306519
last_seq = 5301
current_ts = 153.323853
current_received_ts = 153.323227
current_seq = 5302
count = 332
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.307068/5301, current 153.323853/5302: elapsed=16785.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.323853
last_received_ts = 153.323227
last_seq = 5302
current_ts = 153.340622
current_received_ts = 153.340088
current_seq = 5303
count = 333
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.323853/5302, current 153.340622/5303: elapsed=16761.0us expected=16837.0us +- 84.2us, error 0.5%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.340622
last_received_ts = 153.340088
last_seq = 5303
current_ts = 153.357407
current_received_ts = 153.356812
current_seq = 5304
count = 334
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.340622/5303, current 153.357407/5304: elapsed=16786.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.357407
last_received_ts = 153.356812
last_seq = 5304
current_ts = 153.374161
current_received_ts = 153.373627
current_seq = 5305
count = 335
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.357407/5304, current 153.374161/5305: elapsed=16765.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.374161
last_received_ts = 153.373627
last_seq = 5305
current_ts = 153.390945
current_received_ts = 153.390320
current_seq = 5306
count = 336
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.374161/5305, current 153.390945/5306: elapsed=16776.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.390945
last_received_ts = 153.390320
last_seq = 5306
current_ts = 153.407730
current_received_ts = 153.407135
current_seq = 5307
count = 337
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.390945/5306, current 153.407730/5307: elapsed=16791.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.407730
last_received_ts = 153.407135
last_seq = 5307
current_ts = 153.424500
current_received_ts = 153.423935
current_seq = 5308
count = 338
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.407730/5307, current 153.424500/5308: elapsed=16759.0us expected=16837.0us +- 84.2us, error 0.5%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.424500
last_received_ts = 153.423935
last_seq = 5308
current_ts = 153.441269
current_received_ts = 153.440704
current_seq = 5309
count = 339
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.424500/5308, current 153.441269/5309: elapsed=16775.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.441269
last_received_ts = 153.440704
last_seq = 5309
current_ts = 153.458038
current_received_ts = 153.457474
current_seq = 5310
count = 340
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.441269/5309, current 153.458038/5310: elapsed=16773.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.458038
last_received_ts = 153.457474
last_seq = 5310
current_ts = 153.474823
current_received_ts = 153.474274
current_seq = 5311
count = 341
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.458038/5310, current 153.474823/5311: elapsed=16782.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.474823
last_received_ts = 153.474274
last_seq = 5311
current_ts = 153.491592
current_received_ts = 153.491058
current_seq = 5312
count = 342
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.474823/5311, current 153.491592/5312: elapsed=16771.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.491592
last_received_ts = 153.491058
last_seq = 5312
current_ts = 153.508362
current_received_ts = 153.507812
current_seq = 5313
count = 343
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.491592/5312, current 153.508362/5313: elapsed=16771.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.508362
last_received_ts = 153.507812
last_seq = 5313
current_ts = 153.525146
current_received_ts = 153.524567
current_seq = 5314
count = 344
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.508362/5313, current 153.525146/5314: elapsed=16786.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.525146
last_received_ts = 153.524567
last_seq = 5314
current_ts = 153.541931
current_received_ts = 153.541382
current_seq = 5315
count = 345
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.525146/5314, current 153.541931/5315: elapsed=16774.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.541931
last_received_ts = 153.541382
last_seq = 5315
current_ts = 153.558701
current_received_ts = 153.558151
current_seq = 5316
count = 346
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.541931/5315, current 153.558701/5316: elapsed=16770.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.558701
last_received_ts = 153.558151
last_seq = 5316
current_ts = 153.575485
current_received_ts = 153.574936
current_seq = 5317
count = 347
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.558701/5316, current 153.575485/5317: elapsed=16789.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.575485
last_received_ts = 153.574936
last_seq = 5317
current_ts = 153.592239
current_received_ts = 153.591675
current_seq = 5318
count = 348
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.575485/5317, current 153.592239/5318: elapsed=16757.0us expected=16837.0us +- 84.2us, error 0.5%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.592239
last_received_ts = 153.591675
last_seq = 5318
current_ts = 153.609024
current_received_ts = 153.608459
current_seq = 5319
count = 349
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.592239/5318, current 153.609024/5319: elapsed=16783.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.609024
last_received_ts = 153.608459
last_seq = 5319
current_ts = 153.625793
current_received_ts = 153.625229
current_seq = 5320
count = 350
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.609024/5319, current 153.625793/5320: elapsed=16776.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.625793
last_received_ts = 153.625229
last_seq = 5320
current_ts = 153.642563
current_received_ts = 153.642075
current_seq = 5321
count = 351
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.625793/5320, current 153.642563/5321: elapsed=16770.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.642563
last_received_ts = 153.642075
last_seq = 5321
current_ts = 153.659348
current_received_ts = 153.658798
current_seq = 5322
count = 352
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.642563/5321, current 153.659348/5322: elapsed=16775.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.659348
last_received_ts = 153.658798
last_seq = 5322
current_ts = 153.676132
current_received_ts = 153.675568
current_seq = 5323
count = 353
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.659348/5322, current 153.676132/5323: elapsed=16788.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.676132
last_received_ts = 153.675568
last_seq = 5323
current_ts = 153.692917
current_received_ts = 153.692307
current_seq = 5324
count = 354
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.676132/5323, current 153.692917/5324: elapsed=16779.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.692917
last_received_ts = 153.692307
last_seq = 5324
current_ts = 153.709671
current_received_ts = 153.709122
current_seq = 5325
count = 355
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.692917/5324, current 153.709671/5325: elapsed=16759.0us expected=16837.0us +- 84.2us, error 0.5%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.709671
last_received_ts = 153.709122
last_seq = 5325
current_ts = 153.726440
current_received_ts = 153.725861
current_seq = 5326
count = 356
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.709671/5325, current 153.726440/5326: elapsed=16777.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.726440
last_received_ts = 153.725861
last_seq = 5326
current_ts = 153.743225
current_received_ts = 153.742645
current_seq = 5327
count = 357
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.726440/5326, current 153.743225/5327: elapsed=16774.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.743225
last_received_ts = 153.742645
last_seq = 5327
current_ts = 153.760010
current_received_ts = 153.759430
current_seq = 5328
count = 358
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.743225/5327, current 153.760010/5328: elapsed=16783.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.760010
last_received_ts = 153.759430
last_seq = 5328
current_ts = 153.776779
current_received_ts = 153.776215
current_seq = 5329
count = 359
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.760010/5328, current 153.776779/5329: elapsed=16773.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.776779
last_received_ts = 153.776215
last_seq = 5329
current_ts = 153.793549
current_received_ts = 153.793045
current_seq = 5330
count = 360
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.776779/5329, current 153.793549/5330: elapsed=16771.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.793549
last_received_ts = 153.793045
last_seq = 5330
current_ts = 153.810333
current_received_ts = 153.809784
current_seq = 5331
count = 361
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.793549/5330, current 153.810333/5331: elapsed=16778.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.810333
last_received_ts = 153.809784
last_seq = 5331
current_ts = 153.827103
current_received_ts = 153.826553
current_seq = 5332
count = 362
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.810333/5331, current 153.827103/5332: elapsed=16772.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.827103
last_received_ts = 153.826553
last_seq = 5332
current_ts = 153.843887
current_received_ts = 153.843292
current_seq = 5333
count = 363
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.827103/5332, current 153.843887/5333: elapsed=16782.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.843887
last_received_ts = 153.843292
last_seq = 5333
current_ts = 153.860641
current_received_ts = 153.860138
current_seq = 5334
count = 364
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.843887/5333, current 153.860641/5334: elapsed=16769.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.860641
last_received_ts = 153.860138
last_seq = 5334
current_ts = 153.877441
current_received_ts = 153.876862
current_seq = 5335
count = 365
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.860641/5334, current 153.877441/5335: elapsed=16788.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.877441
last_received_ts = 153.876862
last_seq = 5335
current_ts = 153.894196
current_received_ts = 153.893616
current_seq = 5336
count = 366
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.877441/5335, current 153.894196/5336: elapsed=16760.0us expected=16837.0us +- 84.2us, error 0.5%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.894196
last_received_ts = 153.893616
last_seq = 5336
current_ts = 153.910965
current_received_ts = 153.910370
current_seq = 5337
count = 367
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.894196/5336, current 153.910965/5337: elapsed=16773.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.910965
last_received_ts = 153.910370
last_seq = 5337
current_ts = 153.927765
current_received_ts = 153.927216
current_seq = 5338
count = 368
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.910965/5337, current 153.927765/5338: elapsed=16795.0us expected=16837.0us +- 84.2us, error 0.2%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.927765
last_received_ts = 153.927216
last_seq = 5338
current_ts = 153.944534
current_received_ts = 153.943939
current_seq = 5339
count = 369
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.927765/5338, current 153.944534/5339: elapsed=16769.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.944534
last_received_ts = 153.943939
last_seq = 5339
current_ts = 153.961288
current_received_ts = 153.960739
current_seq = 5340
count = 370
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.944534/5339, current 153.961288/5340: elapsed=16756.0us expected=16837.0us +- 84.2us, error 0.5%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.961288
last_received_ts = 153.960739
last_seq = 5340
current_ts = 153.978058
current_received_ts = 153.977493
current_seq = 5341
count = 371
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.961288/5340, current 153.978058/5341: elapsed=16767.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.978058
last_received_ts = 153.977493
last_seq = 5341
current_ts = 153.994827
current_received_ts = 153.994232
current_seq = 5342
count = 372
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.978058/5341, current 153.994827/5342: elapsed=16776.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 153.994827
last_received_ts = 153.994232
last_seq = 5342
current_ts = 154.011597
current_received_ts = 154.011047
current_seq = 5343
count = 373
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 153.994827/5342, current 154.011597/5343: elapsed=16764.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 154.011597
last_received_ts = 154.011047
last_seq = 5343
current_ts = 154.028366
current_received_ts = 154.027832
current_seq = 5344
count = 374
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 154.011597/5343, current 154.028366/5344: elapsed=16769.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 154.028366
last_received_ts = 154.027832
last_seq = 5344
current_ts = 154.045151
current_received_ts = 154.044525
current_seq = 5345
count = 375
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 154.028366/5344, current 154.045151/5345: elapsed=16781.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 154.045151
last_received_ts = 154.044525
last_seq = 5345
current_ts = 154.061920
current_received_ts = 154.061249
current_seq = 5346
count = 376
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 154.045151/5345, current 154.061920/5346: elapsed=16772.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 154.061920
last_received_ts = 154.061249
last_seq = 5346
current_ts = 154.078674
current_received_ts = 154.078094
current_seq = 5347
count = 377
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 154.061920/5346, current 154.078674/5347: elapsed=16753.0us expected=16837.0us +- 84.2us, error 0.5%
(kms_flip:2560) DEBUG: name = flip
last_ts = 154.078674
last_received_ts = 154.078094
last_seq = 5347
current_ts = 154.095444
current_received_ts = 154.094864
current_seq = 5348
count = 378
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 154.078674/5347, current 154.095444/5348: elapsed=16770.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 154.095444
last_received_ts = 154.094864
last_seq = 5348
current_ts = 154.112213
current_received_ts = 154.111679
current_seq = 5349
count = 379
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 154.095444/5348, current 154.112213/5349: elapsed=16773.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 154.112213
last_received_ts = 154.111679
last_seq = 5349
current_ts = 154.128983
current_received_ts = 154.128403
current_seq = 5350
count = 380
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 154.112213/5349, current 154.128983/5350: elapsed=16766.0us expected=16837.0us +- 84.2us, error 0.4%
(kms_flip:2560) DEBUG: name = flip
last_ts = 154.128983
last_received_ts = 154.128403
last_seq = 5350
current_ts = 154.145767
current_received_ts = 154.145172
current_seq = 5351
count = 381
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 154.128983/5350, current 154.145767/5351: elapsed=16783.0us expected=16837.0us +- 84.2us, error 0.3%
(kms_flip:2560) DEBUG: name = flip
last_ts = 154.145767
last_received_ts = 154.145172
last_seq = 5351
current_ts = 154.162521
current_received_ts = 154.161942
current_seq = 5352
count = 382
seq_step = 1
(kms_flip:2560) DEBUG: flip ts/seq: last 154.145767/5351, current 154.162521/5352: elapsed=16751.0us expected=16837.0us +- 84.2us, error 0.5%
(kms_flip:2560) DEBUG: inconsistent flip ts/seq: last 154.145767/5351, current 154.162521/5352: elapsed=16751.0us expected=16837.0us
(kms_flip:2560) DEBUG: expected 152677, counted 382, encoder type 1
(kms_flip:2560) DEBUG: dropped frames, expected 152677, counted 382, encoder type 1
(kms_flip:2560) CRITICAL: Test assertion failure function __run_test_on_crtc_set, file ../tests/kms_flip.c:1674:
(kms_flip:2560) CRITICAL: Failed assertion: !retried && needs_retry_after_link_reset(mon)
(kms_flip:2560) igt_core-INFO: Stack trace:
(kms_flip:2560) igt_core-INFO:   #0 ../lib/igt_core.c:2055 __igt_fail_assert()
(kms_flip:2560) igt_core-INFO:   #1 ../tests/kms_flip.c:791 run_test_on_crtc_set.constprop.0()
(kms_flip:2560) igt_core-INFO:   #2 ../tests/kms_flip.c:1845 run_test()
(kms_flip:2560) igt_core-INFO:   #3 ../tests/kms_flip.c:2078 __igt_unique____real_main2001()
(kms_flip:2560) igt_core-INFO:   #4 ../tests/kms_flip.c:2001 main()
(kms_flip:2560) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(kms_flip:2560) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(kms_flip:2560) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest A-VGA1: FAIL (10.312s)
Dmesg
<6> [146.480321] Console: switching to colour dummy device 80x25
<6> [146.480677] [IGT] kms_flip: executing
<7> [146.488130] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [146.489163] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [146.489434] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [146.493081] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1]
<7> [146.493107] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:64:VGA-1] force=1
<7> [146.493340] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] ironlake hotplug adpa=0xf40000, result 0
<7> [146.493565] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT not detected via hotplug
<7> [146.494037] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [146.494328] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry
<7> [146.494847] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [146.495133] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [146.495144] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging
<7> [146.495432] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1
<7> [146.496771] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [146.496777] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0
<7> [146.496980] i915 0000:00:02.0: [drm:intel_crt_detect_ddc [i915]] CRT not detected via DDC:0x50 [no valid EDID found]
<7> [146.497200] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1] disconnected
<7> [146.497696] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:75:DP-1]
<7> [146.497714] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:75:DP-1]
<7> [146.501532] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.505182] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.509121] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.513084] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.517029] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.521026] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.525110] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.529032] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.533245] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.537179] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.541181] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.545144] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.549340] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.553356] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.557524] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.561547] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.565754] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.569960] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.573932] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.578089] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.582107] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.586147] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.590295] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.594273] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.598425] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.602467] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.606645] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.610665] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.614663] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.618841] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.622874] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.627021] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.627359] i915 0000:00:02.0: [drm:drm_dp_dpcd_access [drm_display_helper]] AUX D/DP D: Too many retries, giving up. First error: -110
<7> [146.627399] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:75:DP-1] disconnected
<7> [146.627853] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1]
<7> [146.627883] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] [CONNECTOR:64:VGA-1] force=1
<7> [146.628239] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] ironlake hotplug adpa=0xf40000, result 0
<7> [146.628627] i915 0000:00:02.0: [drm:intel_crt_detect [i915]] CRT not detected via hotplug
<7> [146.629168] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [146.629574] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry
<7> [146.630117] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [146.630348] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [146.630356] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging
<7> [146.630598] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1
<7> [146.631894] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [146.631901] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0
<7> [146.632107] i915 0000:00:02.0: [drm:intel_crt_detect_ddc [i915]] CRT not detected via DDC:0x50 [no valid EDID found]
<7> [146.632316] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1] disconnected
<7> [146.632584] i915 0000:00:02.0: [drm:status_store] [CONNECTOR:64:VGA-1] force updated from 0 to 2 or reprobing
<7> [146.632593] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1]
<7> [146.632610] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1] status updated from disconnected to connected
<7> [146.632637] i915 0000:00:02.0: [drm:drm_sysfs_hotplug_event] generating hotplug event
<7> [146.632721] i915 0000:00:02.0: [drm:drm_client_hotplug] fbdev: ret=0
<7> [146.632962] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [146.633236] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry
<7> [146.633638] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [146.633873] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [146.633885] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging
<7> [146.634094] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1
<7> [146.635369] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [146.635381] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0
<7> [146.635696] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1] probed modes:
<7> [146.635714] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [146.635729] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5
<7> [146.635744] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5
<7> [146.635759] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "848x480": 60 33750 848 864 976 1088 480 486 494 517 0x40 0x5
<7> [146.635773] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<7> [146.635829] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1]
<7> [146.636046] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [146.636255] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK on first message, retry
<7> [146.636676] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus vga] NAK for addr: 0050 w(1)
<7> [146.636883] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [146.636896] i915 0000:00:02.0: [drm:intel_crt_get_edid [i915]] CRT GMBUS EDID read failed, retry using GPIO bit-banging
<7> [146.637109] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] enabling bit-banging on i915 gmbus vga. force bit now 1
<7> [146.638371] [drm:drm_do_probe_ddc_edid] drm: skipping non-existent adapter i915 gmbus vga
<7> [146.638389] i915 0000:00:02.0: [drm:intel_gmbus_force_bit [i915]] disabling bit-banging on i915 gmbus vga. force bit now 0
<7> [146.638731] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:64:VGA-1] probed modes:
<7> [146.638758] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [146.638784] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5
<7> [146.638805] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 56 36000 800 824 896 1024 600 601 603 625 0x40 0x5
<7> [146.638819] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "848x480": 60 33750 848 864 976 1088 480 486 494 517 0x40 0x5
<7> [146.638832] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<7> [146.638874] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:67:HDMI-A-1]
<7> [146.638904] i915 0000:00:02.0: [drm:intel_hdmi_detect [i915]] [CONNECTOR:67:HDMI-A-1]
<7> [146.664663] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] HDMI: DVI dual 0, max TMDS clock 590000 kHz
<7> [146.664676] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] HDMI sink does deep color 30.
<7> [146.664682] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] HDMI sink does deep color 36.
<7> [146.664688] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] HDMI sink does deep color 48.
<7> [146.664693] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] Assigning HDMI sink color depth as 16 bpc.
<7> [146.664699] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] HDMI sink does YCRCB444 in deep color.
<7> [146.664707] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] ELD monitor Mi TV
<7> [146.664714] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] HDMI: latency present 0 0, video latency 0 0, audio latency 0 0
<7> [146.664721] i915 0000:00:02.0: [drm:update_display_info.part.0] [CONNECTOR:67:HDMI-A-1] ELD size 36, SAD count 3
<7> [146.664949] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpd] NAK for addr: 0040 w(1)
<7> [146.665295] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpd] NAK on first message, retry
<7> [146.665922] i915 0000:00:02.0: [drm:do_gmbus_xfer [i915]] GMBUS [i915 gmbus dpd] NAK for addr: 0040 w(1)
<7> [146.666314] i915 0000:00:02.0: [drm:drm_dp_dual_mode_detect [drm_display_helper]] DP dual mode HDMI ID: (err -6)
<7> [146.667708] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "2560x1600": 60 268500 2560 2608 2640 2720 1600 1603 1609 1646 0x40 0x5 (CLOCK_HIGH)
<7> [146.667724] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "2560x1440": 60 241500 2560 2608 2640 2720 1440 1443 1449 1481 0x40 0x5 (CLOCK_HIGH)
<7> [146.667734] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 30 297000 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [146.667743] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "4096x2160": 30 297000 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [146.667752] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "1920x1080": 120 297000 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5 (CLOCK_HIGH)
<7> [146.667762] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 25 297000 3840 4896 4984 5280 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [146.667771] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 24 297000 3840 5116 5204 5500 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [146.667779] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "4096x2160": 24 297000 4096 5116 5204 5500 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [146.667788] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 50 594000 3840 4896 4984 5280 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [146.667797] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 60 594000 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [146.667806] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "4096x2160": 50 594000 4096 5064 5152 5280 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [146.667815] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "4096x2160": 60 594000 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [146.667823] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 30 296703 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [146.667832] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "4096x2160": 30 296703 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [146.667841] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "1920x1080": 120 296703 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5 (CLOCK_HIGH)
<7> [146.667850] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 24 296703 3840 5116 5204 5500 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [146.667858] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "4096x2160": 24 296703 4096 5116 5204 5500 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [146.667868] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "3840x2160": 60 593407 3840 4016 4104 4400 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [146.667876] i915 0000:00:02.0: [drm:drm_mode_prune_invalid] Rejected mode: "4096x2160": 60 593407 4096 4184 4272 4400 2160 2168 2178 2250 0x40 0x5 (CLOCK_HIGH)
<7> [146.667891] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:67:HDMI-A-1] probed modes:
<7> [146.667910] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x48 0x5
<7> [146.667927] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "2880x1800": 30 167000 2880 2910 2920 3030 1800 1820 1828 1836 0x40 0x5
<7> [146.667943] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1200": 60 154000 1920 1968 2000 2080 1200 1203 1209 1235 0x40 0x9
<7> [146.667958] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 60 148500 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [146.667974] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 60 148352 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [146.667990] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080i": 60 74250 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x15
<7> [146.668005] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080i": 60 74250 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x20015
<7> [146.668021] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080i": 60 74176 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x15
<7> [146.668036] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080i": 60 74176 1920 2008 2052 2200 1080 1084 1094 1125 0x40 0x20015
<7> [146.668052] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 50 148500 1920 2448 2492 2640 1080 1084 1089 1125 0x40 0x5
<7> [146.668067] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080i": 50 74250 1920 2448 2492 2640 1080 1084 1094 1125 0x40 0x15
<7> [146.668083] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080i": 50 74250 1920 2448 2492 2640 1080 1084 1094 1125 0x40 0x20015
<7> [146.668098] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 30 74250 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [146.668114] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 30 74176 1920 2008 2052 2200 1080 1084 1089 1125 0x40 0x5
<7> [146.668129] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 25 74250 1920 2448 2492 2640 1080 1084 1089 1125 0x40 0x5
<7> [146.668144] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 24 74250 1920 2558 2602 2750 1080 1084 1089 1125 0x40 0x5
<7> [146.668160] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 24 74250 1920 2558 2602 2750 1080 1084 1089 1125 0x40 0x1c005
<7> [146.668175] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 24 74250 1920 2558 2602 2750 1080 1084 1089 1125 0x40 0x4005
<7> [146.668191] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 24 74176 1920 2558 2602 2750 1080 1084 1089 1125 0x40 0x5
<7> [146.668213] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 24 74176 1920 2558 2602 2750 1080 1084 1089 1125 0x40 0x1c005
<7> [146.668258] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1920x1080": 24 74176 1920 2558 2602 2750 1080 1084 1089 1125 0x40 0x4005
<7> [146.668275] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1600x1200": 60 162000 1600 1664 1856 2160 1200 1201 1204 1250 0x40 0x5
<7> [146.668295] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1680x1050": 60 119000 1680 1728 1760 1840 1050 1053 1059 1080 0x40 0x9
<7> [146.668325] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1600x900": 60 108000 1600 1624 1704 1800 900 901 904 1000 0x40 0x5
<7> [146.668354] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x1024": 60 108000 1280 1328 1440 1688 1024 1025 1028 1066 0x40 0x5
<7> [146.668383] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1440x900": 60 88750 1440 1488 1520 1600 900 903 909 926 0x40 0x9
<7> [146.668412] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1366x768": 60 85500 1366 1436 1579 1792 768 771 774 798 0x40 0x5
<7> [146.668441] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x800": 60 71000 1280 1328 1360 1440 800 803 809 823 0x40 0x9
<7> [146.668470] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [146.668500] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x1c005
<7> [146.668529] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x720": 60 74250 1280 1390 1430 1650 720 725 730 750 0x40 0x4005
<7> [146.668558] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x720": 60 74176 1280 1390 1430 1650 720 725 730 750 0x40 0x5
<7> [146.668588] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x720": 60 74176 1280 1390 1430 1650 720 725 730 750 0x40 0x1c005
<7> [146.668617] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x720": 60 74176 1280 1390 1430 1650 720 725 730 750 0x40 0x4005
<7> [146.668647] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x720": 50 74250 1280 1720 1760 1980 720 725 730 750 0x40 0x5
<7> [146.668672] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x720": 50 74250 1280 1720 1760 1980 720 725 730 750 0x40 0x1c005
<7> [146.668688] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1280x720": 50 74250 1280 1720 1760 1980 720 725 730 750 0x40 0x4005
<7> [146.668704] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [146.668719] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "800x600": 60 40000 800 840 968 1056 600 601 605 628 0x40 0x5
<7> [146.668735] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "720x576": 50 27000 720 732 796 864 576 581 586 625 0x40 0xa
<7> [146.668750] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "720x576i": 50 13500 720 732 795 864 576 580 586 625 0x40 0x101a
<7> [146.668766] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "720x480": 60 27027 720 736 798 858 480 489 495 525 0x40 0xa
<7> [146.668781] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "720x480": 60 27000 720 736 798 858 480 489 495 525 0x40 0xa
<7> [146.668797] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 60 25200 640 656 752 800 480 490 492 525 0x40 0xa
<7> [146.668812] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] Probed mode: "640x480": 60 25175 640 656 752 800 480 490 492 525 0x40 0xa
<7> [146.668875] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:75:DP-1]
<7> [146.668893] i915 0000:00:02.0: [drm:intel_dp_detect [i915]] [CONNECTOR:75:DP-1]
<7> [146.672649] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.676527] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.680329] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.684137] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.688002] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.691797] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.695736] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.699651] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.703430] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.707389] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.711285] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.715094] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.718892] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.722748] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.726557] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.730441] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.734205] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.738086] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.742038] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.746169] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.750366] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.754415] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.758618] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.762846] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.767077] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.771279] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.775490] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.779662] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.783864] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.787904] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.791879] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.795828] i915 0000:00:02.0: [drm:intel_dp_aux_xfer [i915]] AUX D/DP D: timeout (status 0x7143003f)
<7> [146.796234] i915 0000:00:02.0: [drm:drm_dp_dpcd_access [drm_display_helper]] AUX D/DP D: Too many retries, giving up. First error: -110
<7> [146.796274] i915 0000:00:02.0: [drm:drm_helper_probe_single_connector_modes [drm_kms_helper]] [CONNECTOR:75:DP-1] disconnected
<6> [146.798567] [IGT] kms_flip: starting subtest plain-flip-fb-recreate
<6> [146.800263] [IGT] kms_flip: starting dynamic subtest A-VGA1
<7> [146.800890] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [146.800982] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [146.882098] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:47:pipe A]
<7> [146.882303] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [146.882829] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [146.883511] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [146.884247] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in has_pch_encoder (expected yes, found no)
<7> [146.884995] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in fdi_lanes (expected 3, found 0)
<7> [146.885718] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in fdi_m_n (expected tu 64 data 6934582/8388608 link 288940/524288, found tu 0, data 0/0 link 0/0)
<7> [146.886248] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [146.886729] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in output_types (expected 0x00000040, found 0x00000000)
<7> [146.887085] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [146.887412] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 1920, found 0)
<7> [146.887768] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 2200, found 0)
<7> [146.888098] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 1920, found 0)
<7> [146.888426] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 2200, found 0)
<7> [146.888771] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2008, found 0)
<7> [146.889100] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2052, found 0)
<7> [146.889426] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1080, found 0)
<7> [146.889782] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1080, found 0)
<7> [146.890104] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1084, found 0)
<7> [146.890423] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1089, found 0)
<7> [146.890772] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1125, found 0)
<7> [146.891107] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1125, found 0)
<7> [146.891424] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 1920, found 0)
<7> [146.891776] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 2200, found 0)
<7> [146.892095] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 1920, found 0)
<7> [146.892412] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 2200, found 0)
<7> [146.892765] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 2008, found 0)
<7> [146.893103] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 2052, found 0)
<7> [146.893422] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 1080, found 0)
<7> [146.893772] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 1080, found 0)
<7> [146.894095] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 1084, found 0)
<7> [146.894412] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 1089, found 0)
<7> [146.894774] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 1125, found 0)
<7> [146.895118] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 1125, found 0)
<7> [146.895438] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in pixel_multiplier (expected 1, found 0)
<7> [146.895790] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.flags (1) (expected 1, found 0)
<7> [146.896125] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.flags (4) (expected 4, found 0)
<7> [146.896442] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in has_hdmi_sink (expected yes, found no)
<7> [146.896794] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in has_infoframe (expected yes, found no)
<7> [146.897115] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in pipe_bpp (expected 36, found 0)
<7> [146.897433] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 148800, found 0)
<7> [146.897783] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 148800, found 0)
<7> [146.898135] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in port_clock (expected 223200, found 0)
<7> [146.898454] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in infoframes.enable (expected 0x00000071, found 0x00000000)
<7> [146.898802] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in infoframes.gcp (expected 0x00000006, found 0x00000000)
<7> [146.899124] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in avi infoframe
<7> [146.899442] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [146.899790] i915 0000:00:02.0: HDMI infoframe: Auxiliary Video Information (AVI), version 2, length 13
<7> [146.899795] i915 0000:00:02.0: colorspace: RGB
<7> [146.899799] i915 0000:00:02.0: scan mode: Underscan
<7> [146.899804] i915 0000:00:02.0: colorimetry: No Data
<7> [146.899807] i915 0000:00:02.0: picture aspect: 16:9
<7> [146.899812] i915 0000:00:02.0: active aspect: Same as Picture
<7> [146.899816] i915 0000:00:02.0: itc: No Data
<7> [146.899820] i915 0000:00:02.0: extended colorimetry: xvYCC 601
<7> [146.899824] i915 0000:00:02.0: quantization range: Default
<7> [146.899829] i915 0000:00:02.0: nups: Unknown Non-uniform Scaling
<7> [146.899833] i915 0000:00:02.0: video code: 16
<7> [146.899837] i915 0000:00:02.0: ycc quantization range: Full
<7> [146.899841] i915 0000:00:02.0: hdmi content type: Graphics
<7> [146.899845] i915 0000:00:02.0: pixel repeat: 0
<7> [146.899849] i915 0000:00:02.0: bar top 0, bottom 0, left 0, right 0
<7> [146.899854] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [146.900185] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in spd infoframe
<7> [146.900502] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [146.900850] i915 0000:00:02.0: HDMI infoframe: Source Product Description (SPD), version 1, length 25
<7> [146.900855] i915 0000:00:02.0: vendor: Intel
<7> [146.900859] i915 0000:00:02.0: product: Integrated gfx
<7> [146.900863] i915 0000:00:02.0: source device information: PC General (0x9)
<7> [146.900868] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [146.901184] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hdmi infoframe
<7> [146.901499] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [146.901847] i915 0000:00:02.0: HDMI infoframe: Vendor, version 1, length 4
<7> [146.901852] i915 0000:00:02.0: empty frame
<7> [146.901856] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [146.902176] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:47:pipe A] fastset requirement not met, forcing full modeset
<7> [146.902509] i915 0000:00:02.0: [drm:intel_unreference_shared_dpll_crtc [i915]] [CRTC:47:pipe A] releasing PCH DPLL A
<7> [146.902913] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 400000 kHz, actual 400000 kHz
<7> [146.903232] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [146.903607] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:47:pipe A] enable: no [modeset]
<7> [146.903926] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:primary A] fb: [NOFB], visible: no
<7> [146.904306] i915 0000:00:02.0: [drm:intel_audio_codec_disable [i915]] [CONNECTOR:67:HDMI-A-1][ENCODER:66:HDMI D] Disable audio codec on [CRTC:47:pipe A]
<7> [146.930578] i915 0000:00:02.0: [drm:intel_audio_component_get_eld [i915]] Not valid for port D
<7> [146.931246] i915 0000:00:02.0: [drm:intel_disable_transcoder [i915]] disabling pipe A
<7> [146.948287] i915 0000:00:02.0: [drm:g4x_dp_port_enabled [i915]] No pipe for DP port B found
<7> [146.948735] i915 0000:00:02.0: [drm:g4x_dp_port_enabled [i915]] No pipe for DP port C found
<7> [146.949166] i915 0000:00:02.0: [drm:g4x_dp_port_enabled [i915]] No pipe for DP port D found
<7> [146.960781] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disable PCH DPLL A (active 0x1, on? 1) for [CRTC:47:pipe A]
<7> [146.961280] i915 0000:00:02.0: [drm:intel_disable_shared_dpll [i915]] disabling PCH DPLL A
<7> [146.961936] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:65:CRT]
<7> [146.962399] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:66:HDMI D]
<7> [146.963077] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:74:DP D]
<7> [146.963765] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:67:HDMI-A-1]
<7> [146.964629] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:47:pipe A]
<7> [146.965092] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:63:pipe B]
<7> [146.965349] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:47:pipe A]
<7> [146.965386] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CONNECTOR:64:VGA-1]
<7> [146.965520] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CONNECTOR:64:VGA-1] Limiting display bpp to 24 (EDID bpp 0, max requested bpp 0, max platform bpp 36)
<7> [146.965866] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:47:pipe A] hw max bpp: 24, pipe bpp: 24, dithering: 0
<7> [146.966217] i915 0000:00:02.0: [drm:intel_fdi_atomic_check_link [i915]] checking fdi config on pipe A, lanes 1
<7> [146.966532] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.enable (expected no, found yes)
<7> [146.966853] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.active (expected no, found yes)
<7> [146.967205] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in cpu_transcoder (expected -1, found 0)
<7> [146.967556] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in has_pch_encoder (expected no, found yes)
<7> [146.967874] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in fdi_lanes (expected 0, found 1)
<7> [146.968225] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in fdi_m_n (expected tu 0 data 0/0 link 0/0, found tu 64, data 6039797/8388608 link 125829/524288)
<7> [146.968545] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in output_types (expected 0x00000000, found 0x00000002)
<7> [146.968864] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in framestart_delay (expected 0, found 1)
<7> [146.969210] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 0, found 1024)
<7> [146.969545] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 0, found 1344)
<7> [146.969863] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 0, found 1024)
<7> [146.970197] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 0, found 1344)
<7> [146.970468] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 0, found 1048)
<7> [146.970786] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 0, found 1184)
<7> [146.971131] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 0, found 768)
<7> [146.971450] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 0, found 768)
<7> [146.971767] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 0, found 771)
<7> [146.972119] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 0, found 777)
<7> [146.972463] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 0, found 806)
<7> [146.972780] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 0, found 806)
<7> [146.973147] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 0, found 1024)
<7> [146.973466] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 0, found 1344)
<7> [146.973788] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 0, found 1024)
<7> [146.974141] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 0, found 1344)
<7> [146.974475] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_start (expected 0, found 1048)
<7> [146.974794] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hsync_end (expected 0, found 1184)
<7> [146.975138] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vdisplay (expected 0, found 768)
<7> [146.975459] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_start (expected 0, found 768)
<7> [146.975777] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_start (expected 0, found 771)
<7> [146.976133] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vsync_end (expected 0, found 777)
<7> [146.976467] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vtotal (expected 0, found 806)
<7> [146.976796] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_vblank_end (expected 0, found 806)
<7> [146.977144] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in pixel_multiplier (expected 0, found 1)
<7> [146.977461] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.flags (2) (expected 0, found 2)
<7> [146.977779] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.flags (8) (expected 0, found 8)
<7> [146.978127] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in dpll_hw_state
<7> [146.978477] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] expected:
<7> [146.978795] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] dpll_hw_state: dpll: 0xc4010001, dpll_md: 0x0, fp0: 0x30f06, fp1: 0x30f06
<7> [146.979140] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] found:
<7> [146.979456] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] dpll_hw_state: dpll: 0x84100010, dpll_md: 0x0, fp0: 0x10c09, fp1: 0x10c09
<7> [146.979773] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in pipe_bpp (expected 0, found 24)
<7> [146.980118] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.pipe_mode.crtc_clock (expected 0, found 64800)
<7> [146.980453] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_clock (expected 0, found 64800)
<7> [146.980770] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:47:pipe A] fastset requirement not met in port_clock (expected 0, found 64800)
<7> [146.981117] i915 0000:00:02.0: [drm:intel_atomic_check [i915]] [CRTC:47:pipe A] fastset requirement not met, forcing full modeset
<7> [146.981487] i915 0000:00:02.0: [drm:intel_plane_calc_min_cdclk [i915]] [PLANE:32:primary A] min cdclk (64800 kHz) > [CRTC:47:pipe A] min cdclk (0 kHz)
<7> [146.981806] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New cdclk calculated to be logical 400000 kHz, actual 400000 kHz
<7> [146.982160] i915 0000:00:02.0: [drm:intel_modeset_calc_cdclk [i915]] New voltage level calculated to be logical 0, actual 0
<7> [146.982492] i915 0000:00:02.0: [drm:intel_find_shared_dpll [i915]] [CRTC:47:pipe A] allocated PCH DPLL A
<7> [146.982804] i915 0000:00:02.0: [drm:intel_reference_shared_dpll_crtc [i915]] [CRTC:47:pipe A] reserving PCH DPLL A
<7> [146.983164] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling always-on
<7> [146.983157] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [CRTC:47:pipe A] enable: yes [modeset]
<7> [146.983491] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] active: yes, output_types: ANALOG (0x2), output format: RGB, sink format: RGB
<7> [146.983805] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] cpu_transcoder: A, pipe bpp: 24, dithering: 0
<7> [146.984151] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] MST master transcoder: <invalid>
<7> [146.984468] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port sync: master transcoder: <invalid>, slave transcoder bitmask = 0x0
<7> [146.984784] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] joiner: no, pipes: 0x0
<7> [146.985131] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] splitter: disabled, link count 0, overlap 0
<7> [146.985447] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] fdi: lanes: 1; data_m: 6039797, data_n: 8388608, link_m: 125829, link_n: 524288, tu: 64
<7> [146.985767] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] audio: 0, infoframes: 0, infoframes enabled: 0x0
<7> [146.986113] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] scanline offset: 1
<7> [146.986446] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vblank delay: 0, framestart delay: 1, MSA timing delay: 0
<7> [146.986763] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: no, vmin: 0, vmax: 0, flipline: 0, pipeline full: 0, guardband: 0 vsync start: 0, vsync end: 0
<7> [146.987108] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] vrr: vmin vblank: -1, vmax vblank: -2, vmin vtotal: 1, vmax vtotal: 0
<7> [146.987427] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] requested mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [146.987748] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] adjusted mode: "1024x768": 60 65000 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [146.988099] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=64800, hd=1024 hb=1024-1344 hs=1048-1184 ht=1344, vd=768 vb=768-806 vs=771-777 vt=806, flags=0xa
<7> [146.988420] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe mode: "1024x768": 60 64800 1024 1048 1184 1344 768 771 777 806 0x40 0xa
<7> [146.988736] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] crtc timings: clock=64800, hd=1024 hb=1024-1344 hs=1048-1184 ht=1344, vd=768 vb=768-806 vs=771-777 vt=806, flags=0xa
<7> [146.989082] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] port clock: 64800, pipe src: 1024x768+0+0, pixel rate 64800
<7> [146.989401] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] linetime: 0, ips linetime: 0
<7> [146.989725] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pch pfit: 0x0+0+0, disabled, force thru: no
<7> [146.990068] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] ips: 0, double wide: 0, drrs: 0
<7> [146.990386] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] dpll_hw_state: dpll: 0x84100010, dpll_md: 0x0, fp0: 0x10c09, fp1: 0x10c09
<7> [146.990703] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] csc_mode: 0x3 gamma_mode: 0x0 gamma_enable: 0 csc_enable: 0
<7> [146.991047] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pre csc lut: 0 entries, post csc lut: 0 entries
<7> [146.991365] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: pre offsets: 0x0000 0x0000 0x0000
<7> [146.991681] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [146.992029] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [146.992345] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] pipe csc: coefficients: 0x0000 0x0000 0x0000
<7> [146.992660] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] [PLANE:32:primary A] fb: [FB:82] 1024x768 format = XR24 little-endian (0x34325258) modifier = 0x0, visible: yes
<7> [146.993010] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] rotation: 0x1, scaler: -1, scaling_filter: 0
<7> [146.993326] i915 0000:00:02.0: [drm:intel_crtc_state_dump [i915]] src: 1024.000000x768.000000+0.000000+0.000000 dst: 1024x768+0+0
<7> [146.994612] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling always-on
<7> [146.994839] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:65:CRT]
<7> [146.995073] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:66:HDMI D]
<7> [146.995293] i915 0000:00:02.0: [drm:intel_modeset_verify_disabled [i915]] [ENCODER:74:DP D]
<7> [146.996048] i915 0000:00:02.0: [drm:intel_enable_transcoder [i915]] enabling pipe A
<7> [146.997090] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI_RX_IIR 0x100
<7> [146.997326] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI train 1 done.
<7> [146.998187] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI_RX_IIR 0x200
<7> [146.998401] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI train 2 done.
<7> [146.998607] i915 0000:00:02.0: [drm:gen6_fdi_link_train [i915]] FDI train done.
<7> [146.998846] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enable PCH DPLL A (active 0x1, on? 0) for [CRTC:47:pipe A]
<7> [146.999073] i915 0000:00:02.0: [drm:intel_enable_shared_dpll [i915]] enabling PCH DPLL A
<7> [147.051059] i915 0000:00:02.0: [drm:verify_connector_state [i915]] [CONNECTOR:64:VGA-1]
<7> [147.051606] i915 0000:00:02.0: [drm:intel_modeset_verify_crtc [i915]] [CRTC:47:pipe A]
<7> [147.352029] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [147.352089] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:82] from all active usage due to RMFB ioctl
<7> [147.368781] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [147.385491] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [147.402249] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [147.418952] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [147.435612] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [147.452361] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [147.469112] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [147.485803] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [147.502529] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [147.519282] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [147.535936] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [147.553954] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [147.569297] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [147.586023] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [147.602803] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [147.619462] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [147.636199] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [147.652921] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [147.669626] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [147.686284] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [147.703090] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [147.719786] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [147.736510] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [147.753586] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [147.769961] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [147.786650] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [147.803426] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [147.820115] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [147.836830] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [147.836874] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:84] from all active usage due to RMFB ioctl
<7> [147.853508] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [147.870240] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [147.887013] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [147.903759] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [147.920410] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [147.937092] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [147.953889] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [147.970515] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [147.987309] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [148.004097] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [148.020766] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [148.037465] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [148.054157] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [148.070932] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [148.087667] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [148.104314] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [148.121025] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [148.137769] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [148.154427] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [148.171189] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [148.187941] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [148.204583] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [148.221329] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [148.238082] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [148.254755] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [148.271550] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [148.288225] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [148.304935] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [148.321610] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [148.338325] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [148.355108] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [148.371784] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [148.388434] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [148.405211] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [148.421932] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [148.438591] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [148.455361] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [148.472046] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [148.488796] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [148.505405] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [148.522109] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [148.538818] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [148.555565] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [148.572263] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [148.588977] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [148.605707] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [148.622437] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [148.639179] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [148.655871] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [148.672600] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [148.689312] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [148.706030] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [148.722735] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [148.739472] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [148.756268] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [148.772904] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [148.789607] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [148.806334] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [148.823035] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [148.839879] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [148.856568] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [148.873252] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [148.889914] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [148.906745] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [148.923435] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [148.940185] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [148.956826] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [148.973509] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [148.990351] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [149.007077] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [149.023763] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [149.040484] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [149.057170] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [149.073875] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [149.090623] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [149.107332] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [149.124089] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [149.140805] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [149.157436] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [149.174284] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [149.190921] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [149.207628] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [149.224388] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [149.241100] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [149.257818] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [149.274473] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [149.291234] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [149.307955] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [149.324624] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [149.341367] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [149.358171] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [149.374769] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [149.391506] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [149.408217] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [149.424983] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [149.441693] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [149.458379] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [149.475127] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [149.491845] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [149.508528] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [149.525327] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [149.541994] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [149.558706] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [149.575404] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [149.592091] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [149.608845] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [149.625541] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [149.642305] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [149.658987] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [149.675662] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [149.692420] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [149.709189] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [149.725822] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [149.742414] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [149.759148] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [149.776068] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [149.792769] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [149.809462] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [149.826130] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [149.842851] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [149.859643] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [149.876328] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [149.893026] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [149.909730] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [149.926428] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [149.943213] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [149.959930] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [149.976648] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [149.993372] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [150.010014] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [150.026825] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [150.043476] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [150.060201] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [150.076900] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [150.093553] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [150.110373] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [150.127104] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [150.143806] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [150.160481] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [150.177221] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [150.194015] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [150.210681] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [150.227393] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [150.244111] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [150.260762] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [150.277490] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [150.294196] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [150.310935] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [150.327654] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [150.344333] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [150.361088] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [150.377775] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [150.394460] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [150.411165] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [150.427867] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [150.444719] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [150.461367] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [150.478069] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [150.494777] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [150.511466] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [150.528259] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [150.528312] i915 0000:00:02.0: [drm:drm_mode_rmfb_work_fn] Removing [FB:83] from all active usage due to RMFB ioctl
<7> [150.544939] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [150.561646] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [150.578353] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [150.595076] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [150.611859] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [150.628529] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [150.645240] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [150.661915] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [150.678683] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [150.695455] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [150.712076] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [150.728869] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [150.745546] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [150.762278] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [150.779008] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [150.795804] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [150.812450] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [150.829121] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [150.845903] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [150.862618] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [150.879363] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [150.896033] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [150.912731] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [150.929498] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [150.946225] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [150.962909] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [150.979596] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [150.996338] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [151.013125] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [151.029794] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [151.046520] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [151.063255] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [151.079973] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [151.096750] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [151.113408] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [151.130020] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [151.146739] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [151.163525] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [151.180250] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [151.196987] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [151.213634] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [151.230341] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [151.247140] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [151.263851] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [151.280534] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [151.297252] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [151.313965] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [151.330728] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [151.347422] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [151.364115] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [151.380778] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [151.397594] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [151.414340] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [151.430996] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [151.447669] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [151.464331] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [151.481139] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [151.497843] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [151.514560] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [151.531245] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [151.547916] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [151.564782] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [151.581403] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [151.598204] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [151.614887] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [151.631643] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [151.648354] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [151.664998] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [151.681787] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [151.698479] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [151.715178] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [151.731919] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [151.748618] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [151.765374] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [151.782053] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [151.798827] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [151.815478] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [151.832243] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [151.848922] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [151.865632] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [151.882411] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [151.899082] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [151.915789] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [151.932445] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [151.949225] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [151.965921] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [151.982631] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [151.999340] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [152.016096] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [152.032851] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [152.049507] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [152.066238] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [152.082938] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [152.099697] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [152.116365] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [152.133108] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [152.149831] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [152.166491] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [152.183308] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [152.199952] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [152.216699] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [152.233353] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [152.250184] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [152.266982] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [152.283642] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [152.300316] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [152.316996] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [152.333791] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [152.350474] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [152.367189] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [152.383947] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [152.400560] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [152.417420] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [152.434098] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [152.450751] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [152.467428] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [152.484175] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [152.500888] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [152.517593] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [152.534295] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [152.550983] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [152.567786] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [152.584464] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [152.601221] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [152.617920] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [152.634658] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [152.651438] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [152.668083] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [152.684813] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [152.701556] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [152.718310] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [152.734958] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [152.751671] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [152.768349] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [152.785156] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [152.801901] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [152.818494] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [152.835266] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [152.852014] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [152.868750] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [152.885351] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [152.902138] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [152.918783] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [152.935614] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [152.952267] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [152.968976] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [152.985612] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [153.002369] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [153.019153] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [153.035828] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [153.052539] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [153.069292] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [153.086003] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [153.102711] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [153.119434] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [153.136191] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [153.152908] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [153.169686] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [153.186313] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [153.203036] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [153.219748] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [153.236535] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [153.253200] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [153.269915] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [153.286580] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [153.303365] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [153.320029] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [153.336763] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [153.353494] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [153.370212] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [153.386976] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [153.403661] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [153.420369] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [153.437065] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [153.453836] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [153.470479] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [153.487163] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [153.503867] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [153.520644] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [153.537354] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [153.554061] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [153.570773] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [153.587469] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [153.604218] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [153.620941] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [153.637581] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [153.654263] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [153.671063] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [153.687769] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<7> [153.704527] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:83]
<7> [153.721200] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:84]
<7> [153.737921] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:82]
<6> [157.113268] [IGT] kms_flip: finished subtest A-VGA1, FAIL
Created at 2025-03-10 16:11:52