[48.181293] Initializing watchdogs [48.181481] /dev/watchdog0 [48.192291] [001/170] (960s left) i915_module_load (load) [48.350555] Starting subtest: load [50.164217] Subtest load: SUCCESS (1.807s) [50.213091] [002/170] (958s left) core_auth (basic-auth) [50.506320] Starting subtest: basic-auth [50.508758] Subtest basic-auth: SUCCESS (0.005s) [50.602266] [003/170] (958s left) debugfs_test (read_all_entries) [50.888499] Starting subtest: read_all_entries [51.025700] Subtest read_all_entries: SUCCESS (0.136s) [51.149434] [004/170] (957s left) debugfs_test (basic-hwmon) [51.300183] Starting subtest: basic-hwmon [51.302296] Subtest basic-hwmon: SKIP (0.000s) [51.449059] [005/170] (957s left) fbdev (eof) [51.607245] Starting subtest: eof [51.608349] Subtest eof: SUCCESS (0.000s) [51.667342] [006/170] (957s left) fbdev (info) [51.806317] Starting subtest: info [51.807710] Subtest info: SUCCESS (0.000s) [51.882058] [007/170] (957s left) fbdev (nullptr) [52.040111] Starting subtest: nullptr [52.041213] Subtest nullptr: SUCCESS (0.001s) [52.098941] [008/170] (956s left) fbdev (read) [52.240153] Starting subtest: read [53.860119] Subtest read: SUCCESS (1.618s) [53.919990] [009/170] (955s left) fbdev (write) [54.076943] Starting subtest: write [54.881699] Subtest write: SUCCESS (0.804s) [54.936420] [010/170] (954s left) gem_basic (bad-close) [55.087923] Starting subtest: bad-close [55.090320] Subtest bad-close: SUCCESS (0.000s) [55.151328] [011/170] (953s left) gem_basic (create-close) [55.295412] Starting subtest: create-close [55.297727] Subtest create-close: SUCCESS (0.000s) [55.368834] [012/170] (953s left) gem_basic (create-fd-close) [55.510660] Starting subtest: create-fd-close [55.512980] Subtest create-fd-close: SUCCESS (0.000s) [55.588851] [013/170] (953s left) gem_busy (busy@all-engines) [55.752064] Starting subtest: busy [55.756752] Starting dynamic subtest: all-engines [55.822696] Dynamic subtest all-engines: SUCCESS (0.068s) [55.824077] Subtest busy: SUCCESS (0.069s) [56.169260] [014/170] (952s left) gem_close_race (basic-process) [56.336287] Starting subtest: basic-process [56.399127] Subtest basic-process: SUCCESS (0.066s) [56.587273] [015/170] (952s left) gem_close_race (basic-threads) [56.754196] Starting subtest: basic-threads [57.888658] Subtest basic-threads: SUCCESS (1.136s) [58.070412] [016/170] (951s left) gem_ctx_create (basic) [58.228140] Starting subtest: basic [58.229288] Subtest basic: SUCCESS (0.000s) [58.420224] [017/170] (950s left) gem_ctx_create (basic-files) [58.578603] Starting subtest: basic-files [60.605527] Subtest basic-files: SUCCESS (2.028s) [60.804774] [018/170] (948s left) gem_ctx_exec (basic) [60.951811] Starting subtest: basic [60.958604] Subtest basic: SUCCESS (0.007s) [61.055122] [019/170] (948s left) gem_exec_basic (basic) [61.205422] Starting subtest: basic [61.207078] Starting dynamic subtest: rcs0-smem [61.212555] Dynamic subtest rcs0-smem: SUCCESS (0.005s) [61.222765] Starting dynamic subtest: bcs0-smem [61.224336] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [61.234512] Starting dynamic subtest: vcs0-smem [61.236056] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [61.245899] Starting dynamic subtest: vecs0-smem [61.247121] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [61.248361] Subtest basic: SUCCESS (0.009s) [61.419604] [020/170] (947s left) gem_exec_create (basic) [61.582899] Starting subtest: basic [61.584764] Starting dynamic subtest: smem [63.628922] Dynamic subtest smem: SUCCESS (2.046s) [63.630476] Subtest basic: SUCCESS (2.047s) [63.820239] [021/170] (945s left) gem_exec_fence (basic-busy) [64.107989] Starting subtest: basic-busy [64.109241] Starting dynamic subtest: rcs0 [64.123182] Dynamic subtest rcs0: SUCCESS (0.017s) [64.135984] Starting dynamic subtest: bcs0 [64.139264] Dynamic subtest bcs0: SUCCESS (0.016s) [64.150835] Starting dynamic subtest: vcs0 [64.156700] Dynamic subtest vcs0: SUCCESS (0.014s) [64.167721] Starting dynamic subtest: vecs0 [64.169938] Dynamic subtest vecs0: SUCCESS (0.012s) [64.171218] Subtest basic-busy: SUCCESS (0.060s) [64.824416] [022/170] (944s left) gem_exec_fence (basic-wait) [65.118188] Starting subtest: basic-wait [65.120811] Starting dynamic subtest: rcs0 [65.134299] Dynamic subtest rcs0: SUCCESS (0.017s) [65.147147] Starting dynamic subtest: bcs0 [65.153646] Dynamic subtest bcs0: SUCCESS (0.017s) [65.167288] Starting dynamic subtest: vcs0 [65.168362] Dynamic subtest vcs0: SUCCESS (0.013s) [65.180340] Starting dynamic subtest: vecs0 [65.181455] Dynamic subtest vecs0: SUCCESS (0.013s) [65.182558] Subtest basic-wait: SUCCESS (0.062s) [65.753310] [023/170] (943s left) gem_exec_fence (basic-await) [66.055963] Starting subtest: basic-await [66.057097] Starting dynamic subtest: rcs0 [66.182171] Dynamic subtest rcs0: SUCCESS (0.125s) [66.197903] Starting dynamic subtest: bcs0 [66.305189] Dynamic subtest bcs0: SUCCESS (0.120s) [66.322898] Starting dynamic subtest: vcs0 [66.424693] Dynamic subtest vcs0: SUCCESS (0.119s) [66.435678] Starting dynamic subtest: vecs0 [66.531630] Dynamic subtest vecs0: SUCCESS (0.105s) [66.532857] Subtest basic-await: SUCCESS (0.473s) [67.103201] [024/170] (942s left) gem_exec_fence (nb-await) [67.389510] Starting subtest: nb-await [67.391817] Starting dynamic subtest: rcs0 [67.458790] Dynamic subtest rcs0: SUCCESS (0.070s) [67.468769] Starting dynamic subtest: bcs0 [67.527979] Dynamic subtest bcs0: SUCCESS (0.068s) [67.540496] Starting dynamic subtest: vcs0 [67.591177] Dynamic subtest vcs0: SUCCESS (0.063s) [67.603444] Starting dynamic subtest: vecs0 [67.654807] Dynamic subtest vecs0: SUCCESS (0.064s) [67.655992] Subtest nb-await: SUCCESS (0.266s) [68.236989] [025/170] (941s left) gem_exec_gttfill (basic) [68.402092] Starting subtest: basic [80.534035] Subtest basic: SUCCESS (12.133s) [80.738980] [026/170] (928s left) gem_exec_parallel (engines) [80.998200] Starting subtest: engines [80.999264] Starting dynamic subtest: basic [83.975593] Dynamic subtest basic: SUCCESS (2.977s) [83.987922] Starting dynamic subtest: contexts [87.690462] Dynamic subtest contexts: SUCCESS (3.712s) [87.702467] Starting dynamic subtest: fds [91.868830] Dynamic subtest fds: SUCCESS (4.182s) [91.886905] Starting dynamic subtest: userptr [94.959552] Dynamic subtest userptr: SUCCESS (3.090s) [94.960886] Subtest engines: SUCCESS (13.962s) [95.158949] [027/170] (914s left) gem_exec_store (basic) [95.320933] Starting subtest: basic [95.365521] Subtest basic: SUCCESS (0.045s) [95.554530] [028/170] (913s left) gem_flink_basic (bad-flink) [95.695740] Starting subtest: bad-flink [95.696939] Subtest bad-flink: SUCCESS (0.000s) [95.779316] [029/170] (913s left) gem_flink_basic (bad-open) [95.923073] Starting subtest: bad-open [95.925537] Subtest bad-open: SUCCESS (0.000s) [95.987306] [030/170] (913s left) gem_flink_basic (basic) [96.126438] Starting subtest: basic [96.127652] Subtest basic: SUCCESS (0.000s) [96.203123] [031/170] (913s left) gem_flink_basic (double-flink) [96.343391] Starting subtest: double-flink [96.344568] Subtest double-flink: SUCCESS (0.000s) [96.421584] [032/170] (913s left) gem_flink_basic (flink-lifetime) [96.564708] Starting subtest: flink-lifetime [96.566123] Subtest flink-lifetime: SUCCESS (0.002s) [96.654426] [033/170] (912s left) gem_huc_copy (huc-copy) [96.800736] Starting subtest: huc-copy [96.803306] Subtest huc-copy: SKIP (0.000s) [96.888764] [034/170] (912s left) gem_linear_blits (basic) [97.182827] Starting subtest: basic [97.198375] Subtest basic: SUCCESS (0.014s) [97.338917] [035/170] (912s left) gem_mmap (basic) [97.580604] Starting subtest: basic [97.586350] Subtest basic: SUCCESS (0.001s) [97.671631] [036/170] (911s left) gem_mmap_gtt (basic) [97.816573] Starting subtest: basic [97.818908] Subtest basic: SUCCESS (0.001s) [97.873942] [037/170] (911s left) gem_render_linear_blits (basic) [98.020996] Starting subtest: basic [98.084157] Subtest basic: SUCCESS (0.059s) [98.139763] [038/170] (911s left) gem_render_tiled_blits (basic) [98.284071] Starting subtest: basic [98.363654] Subtest basic: SUCCESS (0.075s) [98.407303] [039/170] (911s left) gem_ringfill (basic-all) [98.753999] Starting subtest: basic-all [99.945135] Subtest basic-all: SUCCESS (1.186s) [100.036722] [040/170] (909s left) gem_softpin (allocator-basic) [100.185275] Starting subtest: allocator-basic [100.363545] Subtest allocator-basic: SUCCESS (0.177s) [100.471845] [041/170] (909s left) gem_softpin (allocator-basic-reserve) [100.619245] Starting subtest: allocator-basic-reserve [100.798957] Subtest allocator-basic-reserve: SUCCESS (0.178s) [100.904081] [042/170] (908s left) gem_softpin (safe-alignment) [101.051136] Starting subtest: safe-alignment [101.073483] Subtest safe-alignment: SUCCESS (0.022s) [101.172404] [043/170] (908s left) gem_sync (basic-all) [101.334795] Starting subtest: basic-all [103.869693] Subtest basic-all: SUCCESS (2.534s) [104.054043] [044/170] (905s left) gem_sync (basic-each) [104.221896] Starting subtest: basic-each [106.644240] Subtest basic-each: SUCCESS (2.425s) [106.838836] [045/170] (903s left) gem_tiled_blits (basic) [107.116680] Starting subtest: basic [107.153160] Subtest basic: SUCCESS (0.035s) [107.286456] [046/170] (902s left) gem_tiled_fence_blits (basic) [107.667229] Starting subtest: basic [107.696358] Subtest basic: SUCCESS (0.031s) [107.839375] [047/170] (902s left) gem_tiled_pread_basic [108.388705] [048/170] (901s left) gem_wait (busy@all-engines) [108.557524] Starting subtest: busy [108.558695] Starting dynamic subtest: all-engines [109.076217] Dynamic subtest all-engines: SUCCESS (0.518s) [109.077329] Subtest busy: SUCCESS (0.519s) [109.287454] [049/170] (900s left) gem_wait (wait@all-engines) [109.455411] Starting subtest: wait [109.457729] Starting dynamic subtest: all-engines [110.485280] Dynamic subtest all-engines: SUCCESS (1.029s) [110.486425] Subtest wait: SUCCESS (1.029s) [110.705286] [050/170] (899s left) i915_getparams_basic (basic-eu-total) [110.847415] Starting subtest: basic-eu-total [110.849755] Subtest basic-eu-total: SUCCESS (0.000s) [110.920746] [051/170] (899s left) i915_getparams_basic (basic-subslice-total) [111.063081] Starting subtest: basic-subslice-total [111.065276] Subtest basic-subslice-total: SUCCESS (0.000s) [111.139452] [052/170] (898s left) i915_hangman (error-state-basic) [111.299132] Starting subtest: error-state-basic [111.315538] Subtest error-state-basic: SUCCESS (0.014s) [111.404733] [053/170] (898s left) i915_pciid [111.621541] [054/170] (898s left) kms_addfb_basic (addfb25-bad-modifier) [111.767408] Starting subtest: addfb25-bad-modifier [111.768563] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [111.919259] [055/170] (898s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [112.062156] Starting subtest: addfb25-framebuffer-vs-set-tiling [112.063278] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [112.219518] [056/170] (897s left) kms_addfb_basic (addfb25-modifier-no-flag) [112.364384] Starting subtest: addfb25-modifier-no-flag [112.365602] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [112.519469] [057/170] (897s left) kms_addfb_basic (addfb25-x-tiled-legacy) [112.666935] Starting subtest: addfb25-x-tiled-legacy [112.668055] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [112.802279] [058/170] (897s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [112.948420] Starting subtest: addfb25-x-tiled-mismatch-legacy [112.949520] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [113.086289] [059/170] (897s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [113.293461] Starting subtest: addfb25-yf-tiled-legacy [113.294930] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [113.369263] [060/170] (896s left) kms_addfb_basic (addfb25-y-tiled-legacy) [113.575575] Starting subtest: addfb25-y-tiled-legacy [113.576736] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [113.656730] [061/170] (896s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [113.867402] Starting subtest: addfb25-y-tiled-small-legacy [113.868578] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [113.952596] [062/170] (896s left) kms_addfb_basic (bad-pitch-0) [114.094916] Starting subtest: bad-pitch-0 [114.096193] Subtest bad-pitch-0: SUCCESS (0.000s) [114.253295] [063/170] (896s left) kms_addfb_basic (bad-pitch-1024) [114.396409] Starting subtest: bad-pitch-1024 [114.397584] Subtest bad-pitch-1024: SUCCESS (0.000s) [114.552685] [064/170] (895s left) kms_addfb_basic (bad-pitch-128) [114.697189] Starting subtest: bad-pitch-128 [114.698327] Subtest bad-pitch-128: SUCCESS (0.000s) [114.853275] [065/170] (895s left) kms_addfb_basic (bad-pitch-256) [114.995354] Starting subtest: bad-pitch-256 [114.996519] Subtest bad-pitch-256: SUCCESS (0.000s) [115.152646] [066/170] (895s left) kms_addfb_basic (bad-pitch-32) [115.296938] Starting subtest: bad-pitch-32 [115.298405] Subtest bad-pitch-32: SUCCESS (0.000s) [115.436859] [067/170] (895s left) kms_addfb_basic (bad-pitch-63) [115.582407] Starting subtest: bad-pitch-63 [115.583558] Subtest bad-pitch-63: SUCCESS (0.000s) [115.719388] [068/170] (894s left) kms_addfb_basic (bad-pitch-65536) [115.863541] Starting subtest: bad-pitch-65536 [115.864634] Subtest bad-pitch-65536: SUCCESS (0.000s) [116.002779] [069/170] (894s left) kms_addfb_basic (bad-pitch-999) [116.142430] Starting subtest: bad-pitch-999 [116.143639] Subtest bad-pitch-999: SUCCESS (0.000s) [116.285619] [070/170] (894s left) kms_addfb_basic (basic) [116.432217] Starting subtest: basic [116.433322] Subtest basic: SUCCESS (0.000s) [116.591363] [071/170] (894s left) kms_addfb_basic (basic-x-tiled-legacy) [116.735283] Starting subtest: basic-x-tiled-legacy [116.736358] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [116.868959] [072/170] (893s left) kms_addfb_basic (basic-y-tiled-legacy) [117.013686] Starting subtest: basic-y-tiled-legacy [117.014930] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [117.152599] [073/170] (893s left) kms_addfb_basic (bo-too-small) [117.364891] Starting subtest: bo-too-small [117.366317] Subtest bo-too-small: SUCCESS (0.001s) [117.453133] [074/170] (893s left) kms_addfb_basic (bo-too-small-due-to-tiling) [117.667305] Starting subtest: bo-too-small-due-to-tiling [117.668469] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [117.752806] [075/170] (892s left) kms_addfb_basic (clobberred-modifier) [117.894478] Starting subtest: clobberred-modifier [117.895591] Subtest clobberred-modifier: SUCCESS (0.000s) [118.052653] [076/170] (892s left) kms_addfb_basic (framebuffer-vs-set-tiling) [118.196037] Starting subtest: framebuffer-vs-set-tiling [118.197129] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [118.352426] [077/170] (892s left) kms_addfb_basic (invalid-get-prop) [118.494436] Starting subtest: invalid-get-prop [118.495631] Subtest invalid-get-prop: SUCCESS (0.000s) [118.635918] [078/170] (892s left) kms_addfb_basic (invalid-get-prop-any) [118.777505] Starting subtest: invalid-get-prop-any [118.778745] Subtest invalid-get-prop-any: SUCCESS (0.000s) [118.935965] [079/170] (891s left) kms_addfb_basic (invalid-set-prop) [119.094174] Starting subtest: invalid-set-prop [119.095249] Subtest invalid-set-prop: SUCCESS (0.000s) [119.258657] [080/170] (891s left) kms_addfb_basic (invalid-set-prop-any) [119.403490] Starting subtest: invalid-set-prop-any [119.404831] Subtest invalid-set-prop-any: SUCCESS (0.000s) [119.567201] [081/170] (891s left) kms_addfb_basic (no-handle) [119.710466] Starting subtest: no-handle [119.711750] Subtest no-handle: SUCCESS (0.000s) [119.852669] [082/170] (891s left) kms_addfb_basic (size-max) [120.116378] Starting subtest: size-max [120.117557] Subtest size-max: SUCCESS (0.000s) [120.202497] [083/170] (890s left) kms_addfb_basic (small-bo) [120.438498] Starting subtest: small-bo [120.439606] Subtest small-bo: SUCCESS (0.000s) [120.519150] [084/170] (890s left) kms_addfb_basic (tile-pitch-mismatch) [120.666240] Starting subtest: tile-pitch-mismatch [120.667382] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [120.835980] [085/170] (890s left) kms_addfb_basic (too-high) [121.063593] Starting subtest: too-high [121.064788] Subtest too-high: SUCCESS (0.002s) [121.152769] [086/170] (889s left) kms_addfb_basic (too-wide) [121.386373] Starting subtest: too-wide [121.387460] Subtest too-wide: SUCCESS (0.000s) [121.493685] [087/170] (889s left) kms_addfb_basic (unused-handle) [121.657229] Starting subtest: unused-handle [121.658308] Subtest unused-handle: SUCCESS (0.000s) [121.802544] [088/170] (889s left) kms_addfb_basic (unused-modifier) [121.964922] Starting subtest: unused-modifier [121.966197] Subtest unused-modifier: SUCCESS (0.000s) [122.136187] [089/170] (889s left) kms_addfb_basic (unused-offsets) [122.315733] Starting subtest: unused-offsets [122.317154] Subtest unused-offsets: SUCCESS (0.000s) [122.469413] [090/170] (888s left) kms_addfb_basic (unused-pitches) [122.611741] Starting subtest: unused-pitches [122.613265] Subtest unused-pitches: SUCCESS (0.000s) [122.802389] [091/170] (888s left) kms_busy (basic) [123.049174] Starting subtest: basic [123.053665] Starting dynamic subtest: flip [123.929294] Dynamic subtest flip: SUCCESS (0.875s) [123.955895] Starting dynamic subtest: modeset [125.335764] Dynamic subtest modeset: SUCCESS (1.401s) [125.337047] Subtest basic: SUCCESS (2.281s) [125.533282] [092/170] (885s left) kms_chamelium_hpd (dp-hpd-fast) [125.975112] Subtest dp-hpd-fast: SKIP (0.000s) [126.094486] [093/170] (885s left) kms_chamelium_edid (dp-edid-read) [126.536925] Subtest dp-edid-read: SKIP (0.000s) [126.686930] [094/170] (884s left) kms_chamelium_frames (dp-crc-fast) [127.096105] Subtest dp-crc-fast: SKIP (0.000s) [127.246574] [095/170] (884s left) kms_chamelium_hpd (hdmi-hpd-fast) [127.669460] Subtest hdmi-hpd-fast: SKIP (0.000s) [127.791102] [096/170] (883s left) kms_chamelium_edid (hdmi-edid-read) [128.207297] Subtest hdmi-edid-read: SKIP (0.000s) [128.322403] [097/170] (883s left) kms_chamelium_frames (hdmi-crc-fast) [128.729840] Subtest hdmi-crc-fast: SKIP (0.000s) [128.862408] [098/170] (882s left) kms_chamelium_hpd (vga-hpd-fast) [129.290115] Subtest vga-hpd-fast: SKIP (0.000s) [129.418861] [099/170] (882s left) kms_chamelium_edid (vga-edid-read) [129.856856] Subtest vga-edid-read: SKIP (0.000s) [130.025376] [100/170] (881s left) kms_prop_blob (basic) [130.176380] Starting subtest: basic [130.177730] Subtest basic: SUCCESS (0.000s) [130.260698] [101/170] (881s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [130.469698] Starting subtest: basic-busy-flip-before-cursor-atomic [130.472122] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [130.544728] [102/170] (880s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [130.755681] Starting subtest: basic-busy-flip-before-cursor-legacy [130.757922] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [130.844383] [103/170] (880s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [131.047392] Starting subtest: basic-flip-after-cursor-atomic [132.239952] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.193s) [132.441519] [104/170] (879s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [132.652265] Starting subtest: basic-flip-after-cursor-legacy [133.881768] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.230s) [134.082844] [105/170] (877s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [134.298402] Starting subtest: basic-flip-after-cursor-varying-size [135.527454] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.230s) [135.731579] [106/170] (875s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [135.945411] Starting subtest: basic-flip-before-cursor-atomic [137.143646] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.198s) [137.327592] [107/170] (874s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [137.540600] Starting subtest: basic-flip-before-cursor-legacy [138.737960] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.197s) [138.936892] [108/170] (872s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [139.152078] Starting subtest: basic-flip-before-cursor-varying-size [140.376575] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.225s) [140.576069] [109/170] (871s left) kms_flip (basic-flip-vs-dpms) [140.768073] Starting subtest: basic-flip-vs-dpms [140.774071] Starting dynamic subtest: A-HDMI-A2 [142.170125] Dynamic subtest A-HDMI-A2: SUCCESS (1.396s) [142.194905] Starting dynamic subtest: B-HDMI-A2 [143.165715] Dynamic subtest B-HDMI-A2: SUCCESS (0.982s) [143.187039] Starting dynamic subtest: C-HDMI-A2 [144.301457] Dynamic subtest C-HDMI-A2: SUCCESS (1.134s) [144.304049] Subtest basic-flip-vs-dpms: SUCCESS (3.534s) [144.561848] [110/170] (867s left) kms_flip (basic-flip-vs-modeset) [144.749698] Starting subtest: basic-flip-vs-modeset [144.757912] Starting dynamic subtest: A-HDMI-A2 [146.225354] Dynamic subtest A-HDMI-A2: SUCCESS (1.462s) [146.247907] Starting dynamic subtest: B-HDMI-A2 [147.391244] Dynamic subtest B-HDMI-A2: SUCCESS (1.156s) [147.415885] Starting dynamic subtest: C-HDMI-A2 [148.587369] Dynamic subtest C-HDMI-A2: SUCCESS (1.184s) [148.588377] Subtest basic-flip-vs-modeset: SUCCESS (3.838s) [148.809737] [111/170] (862s left) kms_flip (basic-flip-vs-wf_vblank) [149.003799] Starting subtest: basic-flip-vs-wf_vblank [149.010220] Starting dynamic subtest: A-HDMI-A2 [150.527321] Dynamic subtest A-HDMI-A2: SUCCESS (1.516s) [150.556540] Starting dynamic subtest: B-HDMI-A2 [151.969623] Dynamic subtest B-HDMI-A2: SUCCESS (1.437s) [151.994879] Starting dynamic subtest: C-HDMI-A2 [153.417672] Dynamic subtest C-HDMI-A2: SUCCESS (1.432s) [153.418904] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.409s) [153.878706] [112/170] (857s left) kms_flip (basic-plain-flip) [154.072729] Starting subtest: basic-plain-flip [154.079282] Starting dynamic subtest: A-HDMI-A2 [155.323892] Dynamic subtest A-HDMI-A2: SUCCESS (1.234s) [155.347823] Starting dynamic subtest: B-HDMI-A2 [156.484078] Dynamic subtest B-HDMI-A2: SUCCESS (1.164s) [156.504900] Starting dynamic subtest: C-HDMI-A2 [157.644574] Dynamic subtest C-HDMI-A2: SUCCESS (1.152s) [157.647969] Subtest basic-plain-flip: SUCCESS (3.572s) [158.069767] [113/170] (853s left) kms_force_connector_basic (force-connector-state) [158.306154] Starting subtest: force-connector-state [159.878991] Subtest force-connector-state: SUCCESS (1.573s) [160.538288] [114/170] (851s left) kms_force_connector_basic (force-edid) [160.771751] Starting subtest: force-edid [160.832471] Subtest force-edid: SUCCESS (0.070s) [161.204490] [115/170] (850s left) kms_force_connector_basic (force-load-detect) [161.435731] Starting subtest: force-load-detect [161.438716] Subtest force-load-detect: SKIP (0.000s) [161.704862] [116/170] (850s left) kms_force_connector_basic (prune-stale-modes) [161.991708] Starting subtest: prune-stale-modes [162.067870] Subtest prune-stale-modes: SUCCESS (0.075s) [162.404638] [117/170] (849s left) kms_frontbuffer_tracking (basic) [162.635873] Starting subtest: basic [165.432524] Subtest basic: SUCCESS (2.792s) [165.522098] [118/170] (846s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [165.768948] Starting subtest: compare-crc-sanitycheck [165.775131] Starting dynamic subtest: pipe-A-HDMI-A-2 [166.397415] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.584s) [166.417104] Starting dynamic subtest: pipe-B-HDMI-A-2 [167.137838] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.769s) [167.164878] Starting dynamic subtest: pipe-C-HDMI-A-2 [168.622440] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.470s) [168.626205] Subtest compare-crc-sanitycheck: SUCCESS (2.853s) [168.824997] [119/170] (843s left) kms_pipe_crc_basic (hang-read-crc) [169.055146] Starting subtest: hang-read-crc [169.061320] Starting dynamic subtest: pipe-A-HDMI-A-2 [170.614015] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.551s) [170.641897] Starting dynamic subtest: pipe-B-HDMI-A-2 [172.952110] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.323s) [172.979880] Starting dynamic subtest: pipe-C-HDMI-A-2 [175.814797] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.846s) [175.815881] Subtest hang-read-crc: SUCCESS (6.760s) [176.040807] [120/170] (835s left) kms_pipe_crc_basic (nonblocking-crc) [176.261507] Starting subtest: nonblocking-crc [176.267081] Starting dynamic subtest: pipe-A-HDMI-A-2 [177.034909] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.768s) [177.060929] Starting dynamic subtest: pipe-B-HDMI-A-2 [178.326330] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.275s) [178.355091] Starting dynamic subtest: pipe-C-HDMI-A-2 [179.861424] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.515s) [179.863961] Subtest nonblocking-crc: SUCCESS (3.596s) [180.057845] [121/170] (832s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [180.288739] Starting subtest: nonblocking-crc-frame-sequence [180.295051] Starting dynamic subtest: pipe-A-HDMI-A-2 [181.097252] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.802s) [181.130899] Starting dynamic subtest: pipe-B-HDMI-A-2 [182.096768] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.977s) [182.122901] Starting dynamic subtest: pipe-C-HDMI-A-2 [183.446419] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.335s) [183.447549] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.157s) [183.655965] [122/170] (828s left) kms_pipe_crc_basic (read-crc) [183.888363] Starting subtest: read-crc [183.893028] Starting dynamic subtest: pipe-A-HDMI-A-2 [184.576480] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.683s) [184.602899] Starting dynamic subtest: pipe-B-HDMI-A-2 [185.705118] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.114s) [185.732896] Starting dynamic subtest: pipe-C-HDMI-A-2 [186.938787] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.218s) [186.939924] Subtest read-crc: SUCCESS (3.050s) [187.154489] [123/170] (824s left) kms_pipe_crc_basic (read-crc-frame-sequence) [187.383155] Starting subtest: read-crc-frame-sequence [187.391079] Starting dynamic subtest: pipe-A-HDMI-A-2 [188.080273] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.690s) [188.106892] Starting dynamic subtest: pipe-B-HDMI-A-2 [189.317838] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.223s) [189.344931] Starting dynamic subtest: pipe-C-HDMI-A-2 [190.431865] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.096s) [190.433201] Subtest read-crc-frame-sequence: SUCCESS (3.047s) [190.643627] [124/170] (821s left) kms_psr (primary_page_flip) [190.797093] Subtest primary_page_flip: SKIP (0.000s) [190.847032] [125/170] (821s left) kms_psr (cursor_plane_move) [190.990524] Subtest cursor_plane_move: SKIP (0.000s) [191.047082] [126/170] (821s left) kms_psr (sprite_plane_onoff) [191.190165] Subtest sprite_plane_onoff: SKIP (0.000s) [191.230208] [127/170] (821s left) kms_psr (primary_mmap_gtt) [191.372338] Subtest primary_mmap_gtt: SKIP (0.000s) [191.430186] [128/170] (820s left) kms_setmode (basic-clone-single-crtc) [191.577731] Starting subtest: basic-clone-single-crtc [191.581374] Subtest basic-clone-single-crtc: SKIP (0.000s) [191.660593] [129/170] (820s left) i915_pm_backlight (basic-brightness) [191.888568] Subtest basic-brightness: SKIP (0.000s) [191.946364] [130/170] (820s left) i915_pm_rpm (basic-pci-d3-state) [193.866244] Starting subtest: basic-pci-d3-state [194.548384] Subtest basic-pci-d3-state: SUCCESS (0.682s) [194.784638] [131/170] (817s left) i915_pm_rpm (basic-rte) [194.927645] Starting subtest: basic-rte [197.278611] Subtest basic-rte: SUCCESS (2.345s) [198.072140] [132/170] (814s left) i915_pm_rps (basic-api) [198.230951] Starting subtest: basic-api [198.241739] Subtest basic-api: SUCCESS (0.010s) [198.320634] [133/170] (814s left) prime_self_import (basic-llseek-bad) [198.464123] Starting subtest: basic-llseek-bad [198.472837] Subtest basic-llseek-bad: SUCCESS (0.008s) [198.555017] [134/170] (813s left) prime_self_import (basic-llseek-size) [198.696549] Starting subtest: basic-llseek-size [198.705327] Subtest basic-llseek-size: SUCCESS (0.009s) [198.786998] [135/170] (813s left) prime_self_import (basic-with_fd_dup) [198.927695] Starting subtest: basic-with_fd_dup [198.938154] Subtest basic-with_fd_dup: SUCCESS (0.010s) [199.020543] [136/170] (813s left) prime_self_import (basic-with_one_bo) [199.160764] Starting subtest: basic-with_one_bo [199.170084] Subtest basic-with_one_bo: SUCCESS (0.009s) [199.241284] [137/170] (813s left) prime_self_import (basic-with_one_bo_two_files) [199.379938] Starting subtest: basic-with_one_bo_two_files [199.389529] Subtest basic-with_one_bo_two_files: SUCCESS (0.009s) [199.472195] [138/170] (813s left) prime_self_import (basic-with_two_bos) [199.613393] Starting subtest: basic-with_two_bos [199.624184] Subtest basic-with_two_bos: SUCCESS (0.011s) [199.703961] [139/170] (812s left) prime_vgem (basic-fence-flip) [199.874700] Starting subtest: basic-fence-flip [200.382681] Subtest basic-fence-flip: SUCCESS (0.507s) [200.471661] [140/170] (812s left) prime_vgem (basic-fence-mmap) [200.643783] Starting subtest: basic-fence-mmap [200.703186] Subtest basic-fence-mmap: SUCCESS (0.058s) [200.788075] [141/170] (811s left) prime_vgem (basic-fence-read) [200.955419] Starting subtest: basic-fence-read [201.052889] Subtest basic-fence-read: SUCCESS (0.095s) [201.138260] [142/170] (811s left) prime_vgem (basic-gtt) [201.305257] Starting subtest: basic-gtt [201.335925] Subtest basic-gtt: SUCCESS (0.028s) [201.420751] [143/170] (811s left) prime_vgem (basic-read) [201.588829] Starting subtest: basic-read [201.637470] Subtest basic-read: SUCCESS (0.049s) [201.720750] [144/170] (811s left) prime_vgem (basic-write) [201.888874] Starting subtest: basic-write [201.943190] Subtest basic-write: SUCCESS (0.054s) [202.037384] [145/170] (810s left) vgem_basic (setversion) [202.190166] Starting subtest: setversion [202.192360] Subtest setversion: SUCCESS (0.000s) [202.254751] [146/170] (810s left) vgem_basic (create) [202.406674] Starting subtest: create [202.407826] Subtest create: SUCCESS (0.001s) [202.470979] [147/170] (810s left) vgem_basic (debugfs) [202.623442] Starting subtest: debugfs [202.626526] Subtest debugfs: SUCCESS (0.003s) [202.687246] [148/170] (810s left) vgem_basic (dmabuf-export) [202.840633] Starting subtest: dmabuf-export [202.849753] Subtest dmabuf-export: SUCCESS (0.009s) [202.937436] [149/170] (809s left) vgem_basic (dmabuf-fence) [203.090386] Starting subtest: dmabuf-fence [203.093650] Subtest dmabuf-fence: SUCCESS (0.003s) [203.154026] [150/170] (809s left) vgem_basic (dmabuf-fence-before) [203.306894] Starting subtest: dmabuf-fence-before [203.309950] Subtest dmabuf-fence-before: SUCCESS (0.003s) [203.370525] [151/170] (809s left) vgem_basic (dmabuf-mmap) [203.523469] Starting subtest: dmabuf-mmap [203.555087] Subtest dmabuf-mmap: SUCCESS (0.031s) [203.620730] [152/170] (809s left) vgem_basic (mmap) [203.773528] Starting subtest: mmap [203.794383] Subtest mmap: SUCCESS (0.021s) [203.854781] [153/170] (809s left) vgem_basic (second-client) [204.007253] Starting subtest: second-client [204.055684] Subtest second-client: SUCCESS (0.049s) [204.120490] [154/170] (808s left) vgem_basic (sysfs) [204.273423] Starting subtest: sysfs [204.278178] Subtest sysfs: SUCCESS (0.004s) [204.337356] [155/170] (808s left) core_hotunplug (unbind-rebind) [204.556914] Starting subtest: unbind-rebind [206.312124] Subtest unbind-rebind: SUCCESS (1.754s) [206.408156] [156/170] (806s left) vgem_basic (unload) [206.682988] Starting subtest: unload [235.663788] Subtest unload: SUCCESS (28.979s) [235.798419] [157/170] (777s left) i915_module_load (reload) [235.944797] Starting subtest: reload [238.765915] Subtest reload: SUCCESS (2.820s) [238.815133] [158/170] (774s left) gem_lmem_swapping (basic) [239.200616] Subtest basic: SKIP (0.000s) [239.281128] [159/170] (773s left) gem_lmem_swapping (parallel-random-engines) [239.522483] Subtest parallel-random-engines: SKIP (0.000s) [239.578228] [160/170] (773s left) gem_lmem_swapping (random-engines) [239.727384] Subtest random-engines: SKIP (0.000s) [239.777557] [161/170] (773s left) gem_lmem_swapping (verify-random) [239.926287] Subtest verify-random: SKIP (0.000s) [239.961278] [162/170] (773s left) i915_pm_rpm (module-reload) [241.994213] Starting subtest: module-reload [251.278305] Subtest module-reload: SUCCESS (9.283s) [251.307656] [163/170] (762s left) i915_selftest (live) [251.470387] Starting subtest: live [251.473756] Starting dynamic subtest: sanitycheck [252.420513] Dynamic subtest sanitycheck: SUCCESS (0.946s) [252.433856] Starting dynamic subtest: uncore [253.225369] Dynamic subtest uncore: SUCCESS (0.804s) [253.244148] Starting dynamic subtest: workarounds [254.362181] Dynamic subtest workarounds: SUCCESS (1.134s) [254.376991] Starting dynamic subtest: gt_engines [255.673397] Dynamic subtest gt_engines: SUCCESS (1.309s) [255.686849] Starting dynamic subtest: gt_timelines [267.811950] Dynamic subtest gt_timelines: SUCCESS (12.136s) [267.822334] Starting dynamic subtest: gt_contexts [268.752277] Dynamic subtest gt_contexts: SUCCESS (0.939s) [268.766868] Starting dynamic subtest: gt_lrc [272.418097] Dynamic subtest gt_lrc: SUCCESS (3.662s) [272.428342] Starting dynamic subtest: gt_mocs [273.306433] Dynamic subtest gt_mocs: SUCCESS (0.888s) [273.321089] Starting dynamic subtest: gt_pm [280.125816] Dynamic subtest gt_pm: SUCCESS (6.815s) [280.136357] Starting dynamic subtest: gt_heartbeat [281.222065] Dynamic subtest gt_heartbeat: SUCCESS (1.095s) [281.233231] Starting dynamic subtest: gt_tlb [283.029056] Dynamic subtest gt_tlb: SUCCESS (1.804s) [283.039641] Starting dynamic subtest: requests [290.296957] Dynamic subtest requests: SUCCESS (7.266s) [290.307626] Starting dynamic subtest: migrate [294.172835] Dynamic subtest migrate: SUCCESS (3.874s) [294.183341] Starting dynamic subtest: active [294.983684] Dynamic subtest active: SUCCESS (0.810s) [295.000355] Starting dynamic subtest: objects [297.913072] Dynamic subtest objects: SUCCESS (2.927s) [297.924395] Starting dynamic subtest: mman [304.722771] Dynamic subtest mman: SUCCESS (6.807s) [304.733678] Starting dynamic subtest: dmabuf [305.583647] Dynamic subtest dmabuf: SUCCESS (0.861s) [305.601076] Starting dynamic subtest: vma [306.511401] Dynamic subtest vma: SUCCESS (0.926s) [306.525986] Starting dynamic subtest: coherency [309.157895] Dynamic subtest coherency: SUCCESS (2.643s) [309.168524] Starting dynamic subtest: gtt [317.533702] Dynamic subtest gtt: SUCCESS (8.374s) [317.544379] Starting dynamic subtest: gem [318.457379] Dynamic subtest gem: SUCCESS (0.923s) [318.471862] Starting dynamic subtest: evict [321.696019] Dynamic subtest evict: SUCCESS (3.236s) [321.707240] Starting dynamic subtest: hugepages [328.520140] Dynamic subtest hugepages: SUCCESS (6.822s) [328.530848] Starting dynamic subtest: gem_contexts [345.263208] Dynamic subtest gem_contexts: SUCCESS (16.741s) [345.274712] Starting dynamic subtest: client [346.130358] Dynamic subtest client: SUCCESS (0.868s) [346.146052] Starting dynamic subtest: gem_migrate [347.047812] Dynamic subtest gem_migrate: SUCCESS (0.916s) [347.064086] Starting dynamic subtest: reset [352.243835] Dynamic subtest reset: SUCCESS (5.193s) [352.255059] Starting dynamic subtest: memory_region [353.041202] Dynamic subtest memory_region: SUCCESS (0.797s) [353.055833] Starting dynamic subtest: hangcheck [377.147939] Dynamic subtest hangcheck: SUCCESS (24.104s) [377.159521] Starting dynamic subtest: execlists [386.841060] Dynamic subtest execlists: SUCCESS (9.691s) [386.852694] Starting dynamic subtest: ring_submission [387.728778] Dynamic subtest ring_submission: SUCCESS (0.888s) [387.745081] Starting dynamic subtest: perf [389.018851] Dynamic subtest perf: SUCCESS (1.286s) [389.029956] Starting dynamic subtest: slpc [389.970585] Dynamic subtest slpc: SUCCESS (0.951s) [389.982687] Starting dynamic subtest: guc [390.799805] Dynamic subtest guc: SUCCESS (0.827s) [390.816875] Starting dynamic subtest: guc_multi_lrc [391.717783] Dynamic subtest guc_multi_lrc: SUCCESS (0.918s) [391.732848] Starting dynamic subtest: guc_hang [392.593966] Dynamic subtest guc_hang: SUCCESS (0.875s) [392.607976] Starting dynamic subtest: late_gt_pm [393.593708] Dynamic subtest late_gt_pm: SUCCESS (0.998s) [393.594843] Subtest live: SUCCESS (142.122s) [393.768572] [164/170] (619s left) dmabuf (all-tests) [393.924187] Starting subtest: all-tests [393.928555] Starting dynamic subtest: sanitycheck [393.994774] Dynamic subtest sanitycheck: SUCCESS (0.069s) [394.009034] Starting dynamic subtest: dma_fence [394.167760] Dynamic subtest dma_fence: SUCCESS (0.172s) [394.180169] Starting dynamic subtest: dma_fence_chain [412.071069] Dynamic subtest dma_fence_chain: SUCCESS (17.898s) [412.090417] Starting dynamic subtest: dma_fence_unwrap [412.128758] Dynamic subtest dma_fence_unwrap: SUCCESS (0.060s) [412.143763] Starting dynamic subtest: dma_resv [412.200997] Dynamic subtest dma_resv: SUCCESS (0.070s) [412.203364] Subtest all-tests: SUCCESS (18.279s) [412.229249] [165/170] (601s left) i915_suspend (basic-s2idle-without-i915) [412.371313] Starting subtest: basic-s2idle-without-i915 [431.839252] Subtest basic-s2idle-without-i915: SUCCESS (4.051s) [438.123545] [166/170] (596s left) i915_suspend (basic-s3-without-i915) [438.267945] Starting subtest: basic-s3-without-i915 [459.429671] Subtest basic-s3-without-i915: SUCCESS (4.589s) [462.680995] [167/170] (591s left) gem_exec_suspend (basic-s0) [462.856130] Starting subtest: basic-S0 [462.861639] Starting dynamic subtest: smem [482.645422] Dynamic subtest smem: SUCCESS (4.890s) [482.646513] Subtest basic-S0: SUCCESS (4.892s) [489.824935] [168/170] (586s left) gem_exec_suspend (basic-s3) [489.984743] Starting subtest: basic-S3 [489.991117] Starting dynamic subtest: smem [511.971778] Dynamic subtest smem: SUCCESS (6.156s) [511.972965] Subtest basic-S3: SUCCESS (6.157s) [515.141274] [169/170] (580s left) kms_chamelium_hpd (common-hpd-after-suspend) [515.573567] Subtest common-hpd-after-suspend: SKIP (0.000s) [515.727993] [170/170] (579s left) kms_pipe_crc_basic (suspend-read-crc) [515.946439] Starting subtest: suspend-read-crc [515.952988] Starting dynamic subtest: pipe-A-HDMI-A-2 [536.736976] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (4.341s) [536.763998] Starting dynamic subtest: pipe-B-HDMI-A-2 [558.514589] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (5.549s) [558.545783] Starting dynamic subtest: pipe-C-HDMI-A-2 [580.658950] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (5.777s) [580.661720] Subtest suspend-read-crc: SUCCESS (15.716s) [585.839003] Closing watchdogs Done.