[51.999630] Initializing watchdogs [51.999778] /dev/watchdog0 [52.009312] [001/171] (960s left) i915_module_load (load) [52.138685] Starting subtest: load [54.191779] Subtest load: SUCCESS (2.047s) [54.252254] [002/171] (958s left) core_auth (basic-auth) [54.509233] Starting subtest: basic-auth [54.510997] Subtest basic-auth: SUCCESS (0.001s) [54.576892] [003/171] (957s left) debugfs_test (read_all_entries) [54.709413] Starting subtest: read_all_entries [54.771231] Subtest read_all_entries: SUCCESS (0.060s) [55.773878] [004/171] (956s left) debugfs_test (basic-hwmon) [55.904512] Starting subtest: basic-hwmon [55.907731] Subtest basic-hwmon: SKIP (0.000s) [56.921578] [005/171] (955s left) fbdev (eof) [57.072256] Starting subtest: eof [57.073969] Subtest eof: SUCCESS (0.001s) [57.145236] [006/171] (955s left) fbdev (info) [57.267355] Starting subtest: info [57.269154] Subtest info: SUCCESS (0.000s) [57.340742] [007/171] (955s left) fbdev (nullptr) [57.462680] Starting subtest: nullptr [57.465757] Subtest nullptr: SUCCESS (0.000s) [57.523432] [008/171] (955s left) fbdev (read) [57.663238] Starting subtest: read [57.871739] Subtest read: SUCCESS (0.207s) [57.922729] [009/171] (954s left) fbdev (write) [58.045383] Starting subtest: write [58.146823] Subtest write: SUCCESS (0.101s) [58.205620] [010/171] (954s left) gem_basic (bad-close) [58.329536] Starting subtest: bad-close [58.332821] Subtest bad-close: SUCCESS (0.000s) [58.404721] [011/171] (954s left) gem_basic (create-close) [58.536504] Starting subtest: create-close [58.539820] Subtest create-close: SUCCESS (0.000s) [58.603987] [012/171] (954s left) gem_basic (create-fd-close) [58.725323] Starting subtest: create-fd-close [58.728688] Subtest create-fd-close: SUCCESS (0.000s) [58.803705] [013/171] (953s left) gem_busy (busy@all-engines) [58.944400] Starting subtest: busy [58.946254] Starting dynamic subtest: all-engines [58.982094] Dynamic subtest all-engines: SUCCESS (0.037s) [58.983838] Subtest busy: SUCCESS (0.038s) [59.350630] [014/171] (953s left) gem_close_race (basic-process) [59.518139] Starting subtest: basic-process [59.563479] Subtest basic-process: SUCCESS (0.045s) [59.751283] [015/171] (953s left) gem_close_race (basic-threads) [59.893234] Starting subtest: basic-threads [61.021680] Subtest basic-threads: SUCCESS (1.127s) [61.200844] [016/171] (951s left) gem_ctx_create (basic) [61.338093] Starting subtest: basic [61.340090] Subtest basic: SUCCESS (0.001s) [61.516922] [017/171] (951s left) gem_ctx_create (basic-files) [61.730630] Starting subtest: basic-files [63.762213] Subtest basic-files: SUCCESS (2.029s) [64.119286] [018/171] (948s left) gem_ctx_exec (basic) [64.325262] Starting subtest: basic [64.329105] Subtest basic: SUCCESS (0.004s) [64.421911] [019/171] (948s left) gem_exec_basic (basic) [64.635308] Starting subtest: basic [64.637095] Starting dynamic subtest: rcs0-smem [64.638733] Dynamic subtest rcs0-smem: SUCCESS (0.000s) [64.646873] Starting dynamic subtest: vcs0-smem [64.648601] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [64.650319] Subtest basic: SUCCESS (0.002s) [64.823350] [020/171] (948s left) gem_exec_create (basic) [64.961111] Starting subtest: basic [64.962846] Starting dynamic subtest: smem [66.998225] Dynamic subtest smem: SUCCESS (2.037s) [66.999918] Subtest basic: SUCCESS (2.037s) [67.186295] [021/171] (945s left) gem_exec_fence (basic-busy) [67.449777] Starting subtest: basic-busy [67.451682] Starting dynamic subtest: rcs0 [67.459908] Dynamic subtest rcs0: SUCCESS (0.013s) [67.468462] Starting dynamic subtest: vcs0 [67.475583] Dynamic subtest vcs0: SUCCESS (0.012s) [67.477556] Subtest basic-busy: SUCCESS (0.026s) [67.984867] [022/171] (945s left) gem_exec_fence (basic-wait) [68.243245] Starting subtest: basic-wait [68.244952] Starting dynamic subtest: rcs0 [68.253237] Dynamic subtest rcs0: SUCCESS (0.011s) [68.261952] Starting dynamic subtest: vcs0 [68.263648] Dynamic subtest vcs0: SUCCESS (0.008s) [68.265319] Subtest basic-wait: SUCCESS (0.020s) [68.718965] [023/171] (944s left) gem_exec_fence (basic-await) [68.980612] Starting subtest: basic-await [68.982298] Starting dynamic subtest: rcs0 [69.053601] Dynamic subtest rcs0: SUCCESS (0.074s) [69.065876] Starting dynamic subtest: vcs0 [69.127988] Dynamic subtest vcs0: SUCCESS (0.075s) [69.129913] Subtest basic-await: SUCCESS (0.149s) [69.598440] [024/171] (943s left) gem_exec_fence (nb-await) [69.860609] Starting subtest: nb-await [69.862363] Starting dynamic subtest: rcs0 [69.913188] Dynamic subtest rcs0: SUCCESS (0.054s) [69.921930] Starting dynamic subtest: vcs0 [69.967250] Dynamic subtest vcs0: SUCCESS (0.053s) [69.969033] Subtest nb-await: SUCCESS (0.107s) [70.430281] [025/171] (942s left) gem_exec_gttfill (basic) [70.565672] Starting subtest: basic [77.971811] Subtest basic: SUCCESS (7.407s) [78.146694] [026/171] (934s left) gem_exec_parallel (engines) [78.377887] Starting subtest: engines [78.379726] Starting dynamic subtest: basic [80.147239] Dynamic subtest basic: SUCCESS (1.769s) [80.156762] Starting dynamic subtest: contexts [82.256858] Dynamic subtest contexts: SUCCESS (2.108s) [82.267969] Starting dynamic subtest: fds [82.271872] Dynamic subtest fds: SKIP (0.001s) [82.281610] Starting dynamic subtest: userptr [84.131906] Dynamic subtest userptr: SUCCESS (1.875s) [84.133679] Subtest engines: SUCCESS (5.754s) [84.322913] [027/171] (928s left) gem_exec_store (basic) [84.453894] Starting subtest: basic [84.488519] Subtest basic: SUCCESS (0.034s) [84.668777] [028/171] (928s left) gem_flink_basic (bad-flink) [84.791317] Starting subtest: bad-flink [84.792981] Subtest bad-flink: SUCCESS (0.000s) [84.853399] [029/171] (928s left) gem_flink_basic (bad-open) [84.974463] Starting subtest: bad-open [84.976088] Subtest bad-open: SUCCESS (0.000s) [85.052922] [030/171] (928s left) gem_flink_basic (basic) [85.174352] Starting subtest: basic [85.176043] Subtest basic: SUCCESS (0.000s) [85.250447] [031/171] (927s left) gem_flink_basic (double-flink) [85.372052] Starting subtest: double-flink [85.373714] Subtest double-flink: SUCCESS (0.000s) [85.450391] [032/171] (927s left) gem_flink_basic (flink-lifetime) [85.571280] Starting subtest: flink-lifetime [85.573478] Subtest flink-lifetime: SUCCESS (0.002s) [85.653277] [033/171] (927s left) gem_huc_copy (huc-copy) [85.795699] Subtest huc-copy: SKIP (0.000s) [85.836244] [034/171] (927s left) gem_linear_blits (basic) [86.087064] Starting subtest: basic [86.100712] Subtest basic: SUCCESS (0.013s) [86.218349] [035/171] (927s left) gem_mmap (basic) [86.438054] Starting subtest: basic [86.446724] Subtest basic: SUCCESS (0.001s) [86.518173] [036/171] (926s left) gem_mmap_gtt (basic) [86.642600] Starting subtest: basic [86.644253] Subtest basic: SUCCESS (0.001s) [86.721201] [037/171] (926s left) gem_render_linear_blits (basic) [86.847779] Starting subtest: basic [86.880876] Subtest basic: SUCCESS (0.038s) [86.936376] [038/171] (926s left) gem_render_tiled_blits (basic) [87.063681] Starting subtest: basic [87.097222] Subtest basic: SUCCESS (0.035s) [87.131447] [039/171] (926s left) gem_ringfill (basic-all) [87.308412] Starting subtest: basic-all [88.423648] Subtest basic-all: SUCCESS (1.118s) [88.497096] [040/171] (924s left) gem_softpin (allocator-basic) [88.625137] Subtest allocator-basic: SKIP (0.000s) [88.695692] [041/171] (924s left) gem_softpin (allocator-basic-reserve) [88.822780] Subtest allocator-basic-reserve: SKIP (0.000s) [88.893376] [042/171] (924s left) gem_softpin (safe-alignment) [89.020155] Starting subtest: safe-alignment [89.021939] Subtest safe-alignment: SUCCESS (0.006s) [89.109373] [043/171] (924s left) gem_sync (basic-all) [89.244602] Starting subtest: basic-all [91.350686] Subtest basic-all: SUCCESS (2.105s) [91.540202] [044/171] (921s left) gem_sync (basic-each) [91.673635] Starting subtest: basic-each [93.719676] Subtest basic-each: SUCCESS (2.045s) [93.903271] [045/171] (919s left) gem_tiled_blits (basic) [94.136162] Starting subtest: basic [94.158795] Subtest basic: SUCCESS (0.021s) [94.267915] [046/171] (919s left) gem_tiled_fence_blits (basic) [94.608688] Starting subtest: basic [94.619657] Subtest basic: SUCCESS (0.011s) [94.734744] [047/171] (918s left) gem_tiled_pread_basic [95.198075] [048/171] (918s left) gem_wait (busy@all-engines) [95.339047] Starting subtest: busy [95.341297] Starting dynamic subtest: all-engines [95.848908] Dynamic subtest all-engines: SUCCESS (0.510s) [95.850672] Subtest busy: SUCCESS (0.510s) [96.065449] [049/171] (917s left) gem_wait (wait@all-engines) [96.205050] Starting subtest: wait [96.207559] Starting dynamic subtest: all-engines [97.217968] Dynamic subtest all-engines: SUCCESS (1.013s) [97.219696] Subtest wait: SUCCESS (1.013s) [97.428635] [050/171] (916s left) i915_getparams_basic (basic-eu-total) [97.551837] Starting subtest: basic-eu-total [97.555077] Subtest basic-eu-total: SUCCESS (0.000s) [97.627673] [051/171] (916s left) i915_getparams_basic (basic-subslice-total) [97.749292] Starting subtest: basic-subslice-total [97.752643] Subtest basic-subslice-total: SUCCESS (0.000s) [97.825378] [052/171] (915s left) i915_hangman (error-state-basic) [97.951929] Starting subtest: error-state-basic [97.961275] Subtest error-state-basic: SUCCESS (0.010s) [98.012308] [053/171] (915s left) i915_pciid [98.209650] [054/171] (915s left) kms_addfb_basic (addfb25-bad-modifier) [98.338101] Starting subtest: addfb25-bad-modifier [98.340675] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [99.338239] [055/171] (914s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [99.461760] Starting subtest: addfb25-framebuffer-vs-set-tiling [99.463487] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [100.420545] [056/171] (913s left) kms_addfb_basic (addfb25-modifier-no-flag) [100.546071] Starting subtest: addfb25-modifier-no-flag [100.547726] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [101.534549] [057/171] (912s left) kms_addfb_basic (addfb25-x-tiled-legacy) [101.658065] Starting subtest: addfb25-x-tiled-legacy [101.659683] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [102.631529] [058/171] (911s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [102.757740] Starting subtest: addfb25-x-tiled-mismatch-legacy [102.759607] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [103.762623] [059/171] (910s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [104.408981] Starting subtest: addfb25-yf-tiled-legacy [104.410977] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s) [104.893762] [060/171] (909s left) kms_addfb_basic (addfb25-y-tiled-legacy) [105.544868] Starting subtest: addfb25-y-tiled-legacy [105.546857] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s) [106.026285] [061/171] (907s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [106.668449] Starting subtest: addfb25-y-tiled-small-legacy [106.672048] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [107.139110] [062/171] (906s left) kms_addfb_basic (bad-pitch-0) [107.264466] Starting subtest: bad-pitch-0 [107.266239] Subtest bad-pitch-0: SUCCESS (0.000s) [108.271225] [063/171] (905s left) kms_addfb_basic (bad-pitch-1024) [108.395672] Starting subtest: bad-pitch-1024 [108.397376] Subtest bad-pitch-1024: SUCCESS (0.000s) [109.384811] [064/171] (904s left) kms_addfb_basic (bad-pitch-128) [109.531727] Starting subtest: bad-pitch-128 [109.533414] Subtest bad-pitch-128: SUCCESS (0.000s) [110.532572] [065/171] (903s left) kms_addfb_basic (bad-pitch-256) [110.656836] Starting subtest: bad-pitch-256 [110.658547] Subtest bad-pitch-256: SUCCESS (0.000s) [111.663491] [066/171] (902s left) kms_addfb_basic (bad-pitch-32) [111.788517] Starting subtest: bad-pitch-32 [111.790221] Subtest bad-pitch-32: SUCCESS (0.000s) [112.811230] [067/171] (901s left) kms_addfb_basic (bad-pitch-63) [112.936965] Starting subtest: bad-pitch-63 [112.938700] Subtest bad-pitch-63: SUCCESS (0.000s) [113.927234] [068/171] (900s left) kms_addfb_basic (bad-pitch-65536) [114.053609] Starting subtest: bad-pitch-65536 [114.055429] Subtest bad-pitch-65536: SUCCESS (0.001s) [115.040270] [069/171] (899s left) kms_addfb_basic (bad-pitch-999) [115.166868] Starting subtest: bad-pitch-999 [115.168653] Subtest bad-pitch-999: SUCCESS (0.000s) [116.170870] [070/171] (898s left) kms_addfb_basic (basic) [116.296057] Starting subtest: basic [116.297705] Subtest basic: SUCCESS (0.000s) [117.286243] [071/171] (896s left) kms_addfb_basic (basic-x-tiled-legacy) [117.412897] Starting subtest: basic-x-tiled-legacy [117.414697] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [118.399930] [072/171] (895s left) kms_addfb_basic (basic-y-tiled-legacy) [118.525824] Starting subtest: basic-y-tiled-legacy [118.527505] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [119.513854] [073/171] (894s left) kms_addfb_basic (bo-too-small) [120.162328] Starting subtest: bo-too-small [120.164404] Subtest bo-too-small: SUCCESS (0.001s) [120.628370] [074/171] (893s left) kms_addfb_basic (bo-too-small-due-to-tiling) [121.284854] Starting subtest: bo-too-small-due-to-tiling [121.286738] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [121.760070] [075/171] (892s left) kms_addfb_basic (clobberred-modifier) [121.885965] Starting subtest: clobberred-modifier [121.888065] Subtest clobberred-modifier: SUCCESS (0.000s) [122.891326] [076/171] (891s left) kms_addfb_basic (framebuffer-vs-set-tiling) [123.020083] Starting subtest: framebuffer-vs-set-tiling [123.021722] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [124.039042] [077/171] (890s left) kms_addfb_basic (invalid-get-prop) [124.166925] Starting subtest: invalid-get-prop [124.168639] Subtest invalid-get-prop: SUCCESS (0.000s) [125.169752] [078/171] (889s left) kms_addfb_basic (invalid-get-prop-any) [125.292702] Starting subtest: invalid-get-prop-any [125.294491] Subtest invalid-get-prop-any: SUCCESS (0.000s) [126.301220] [079/171] (888s left) kms_addfb_basic (invalid-set-prop) [126.423517] Starting subtest: invalid-set-prop [126.425346] Subtest invalid-set-prop: SUCCESS (0.000s) [127.415489] [080/171] (887s left) kms_addfb_basic (invalid-set-prop-any) [127.541871] Starting subtest: invalid-set-prop-any [127.543772] Subtest invalid-set-prop-any: SUCCESS (0.000s) [128.579811] [081/171] (885s left) kms_addfb_basic (no-handle) [128.706279] Starting subtest: no-handle [128.707955] Subtest no-handle: SUCCESS (0.000s) [129.765207] [082/171] (884s left) kms_addfb_basic (size-max) [130.534215] Starting subtest: size-max [130.536070] Subtest size-max: SUCCESS (0.000s) [131.024939] [083/171] (883s left) kms_addfb_basic (small-bo) [131.679313] Starting subtest: small-bo [131.681155] Subtest small-bo: SUCCESS (0.000s) [132.155950] [084/171] (882s left) kms_addfb_basic (tile-pitch-mismatch) [132.281361] Starting subtest: tile-pitch-mismatch [132.283133] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [133.270540] [085/171] (881s left) kms_addfb_basic (too-high) [133.936246] Starting subtest: too-high [133.938281] Subtest too-high: SUCCESS (0.001s) [134.418322] [086/171] (880s left) kms_addfb_basic (too-wide) [135.074302] Starting subtest: too-wide [135.076611] Subtest too-wide: SUCCESS (0.000s) [135.565838] [087/171] (879s left) kms_addfb_basic (unused-handle) [135.690947] Starting subtest: unused-handle [135.692899] Subtest unused-handle: SUCCESS (0.000s) [136.730159] [088/171] (877s left) kms_addfb_basic (unused-modifier) [136.855643] Starting subtest: unused-modifier [136.858135] Subtest unused-modifier: SUCCESS (0.000s) [137.862418] [089/171] (876s left) kms_addfb_basic (unused-offsets) [137.988822] Starting subtest: unused-offsets [137.990710] Subtest unused-offsets: SUCCESS (0.000s) [138.997139] [090/171] (875s left) kms_addfb_basic (unused-pitches) [139.122758] Starting subtest: unused-pitches [139.124471] Subtest unused-pitches: SUCCESS (0.000s) [140.123598] [091/171] (874s left) kms_busy (basic) [140.788594] Starting subtest: basic [140.790814] Starting dynamic subtest: flip [141.606571] Dynamic subtest flip: SUCCESS (0.812s) [141.617049] Starting dynamic subtest: modeset [142.423184] Dynamic subtest modeset: SUCCESS (0.816s) [142.424940] Subtest basic: SUCCESS (1.632s) [142.989043] [092/171] (871s left) kms_chamelium_hpd (dp-hpd-fast) [143.767271] Subtest dp-hpd-fast: SKIP (0.000s) [144.132813] [093/171] (870s left) kms_chamelium_edid (dp-edid-read) [144.893776] Subtest dp-edid-read: SKIP (0.000s) [145.231358] [094/171] (869s left) kms_chamelium_frames (dp-crc-fast) [145.991520] Subtest dp-crc-fast: SKIP (0.000s) [146.340134] [095/171] (868s left) kms_chamelium_hpd (hdmi-hpd-fast) [147.102762] Subtest hdmi-hpd-fast: SKIP (0.000s) [147.434728] [096/171] (867s left) kms_chamelium_edid (hdmi-edid-read) [148.211961] Subtest hdmi-edid-read: SKIP (0.000s) [148.574490] [097/171] (866s left) kms_chamelium_frames (hdmi-crc-fast) [149.367457] Subtest hdmi-crc-fast: SKIP (0.000s) [149.734021] [098/171] (865s left) kms_chamelium_hpd (vga-hpd-fast) [150.493687] Subtest vga-hpd-fast: SKIP (0.000s) [150.843171] [099/171] (864s left) kms_chamelium_edid (vga-edid-read) [151.621281] Subtest vga-edid-read: SKIP (0.000s) [151.986479] [100/171] (862s left) kms_prop_blob (basic) [152.115493] Starting subtest: basic [152.117550] Subtest basic: SUCCESS (0.000s) [152.199429] [101/171] (862s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [152.880203] Starting subtest: basic-busy-flip-before-cursor-atomic [153.908319] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.026s) [154.451125] [102/171] (860s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [155.118284] Starting subtest: basic-busy-flip-before-cursor-legacy [156.148112] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.033s) [156.701381] [103/171] (858s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [157.375763] Starting subtest: basic-flip-after-cursor-atomic [158.405846] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.032s) [158.962625] [104/171] (856s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [159.640747] Starting subtest: basic-flip-after-cursor-legacy [160.678099] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.031s) [161.220355] [105/171] (853s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [161.916940] Starting subtest: basic-flip-after-cursor-varying-size [162.996225] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.084s) [163.552289] [106/171] (851s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [164.246693] Starting subtest: basic-flip-before-cursor-atomic [165.286336] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.043s) [165.834611] [107/171] (849s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [166.537873] Starting subtest: basic-flip-before-cursor-legacy [167.560247] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.030s) [168.099896] [108/171] (847s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [168.789885] Starting subtest: basic-flip-before-cursor-varying-size [169.864546] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.075s) [170.418517] [109/171] (844s left) kms_flip (basic-flip-vs-dpms) [170.944173] Starting subtest: basic-flip-vs-dpms [170.945805] Starting dynamic subtest: A-VGA1 [171.761658] Dynamic subtest A-VGA1: SUCCESS (0.824s) [171.779932] Starting dynamic subtest: B-VGA1 [172.486746] Dynamic subtest B-VGA1: SUCCESS (0.720s) [172.506547] Starting dynamic subtest: A-HDMI-A1 [173.271655] Dynamic subtest A-HDMI-A1: SUCCESS (0.782s) [173.295700] Starting dynamic subtest: B-HDMI-A1 [174.063790] Dynamic subtest B-HDMI-A1: SUCCESS (0.786s) [174.065660] Subtest basic-flip-vs-dpms: SUCCESS (3.131s) [174.677508] [110/171] (840s left) kms_flip (basic-flip-vs-modeset) [175.200403] Starting subtest: basic-flip-vs-modeset [175.202065] Starting dynamic subtest: A-VGA1 [176.015501] Dynamic subtest A-VGA1: SUCCESS (0.822s) [176.033552] Starting dynamic subtest: B-VGA1 [176.714500] Dynamic subtest B-VGA1: SUCCESS (0.696s) [176.731685] Starting dynamic subtest: A-HDMI-A1 [177.583635] Dynamic subtest A-HDMI-A1: SUCCESS (0.859s) [177.601596] Starting dynamic subtest: B-HDMI-A1 [178.485185] Dynamic subtest B-HDMI-A1: SUCCESS (0.899s) [178.486794] Subtest basic-flip-vs-modeset: SUCCESS (3.287s) [179.059547] [111/171] (836s left) kms_flip (basic-flip-vs-wf_vblank) [179.595280] Starting subtest: basic-flip-vs-wf_vblank [179.596890] Starting dynamic subtest: A-VGA1 [180.690867] Dynamic subtest A-VGA1: SUCCESS (1.097s) [180.714493] Starting dynamic subtest: B-VGA1 [181.721601] Dynamic subtest B-VGA1: SUCCESS (1.030s) [181.740722] Starting dynamic subtest: A-HDMI-A1 [182.957441] Dynamic subtest A-HDMI-A1: SUCCESS (1.228s) [182.983681] Starting dynamic subtest: B-HDMI-A1 [184.241516] Dynamic subtest B-HDMI-A1: SUCCESS (1.266s) [184.247605] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.645s) [184.874369] [112/171] (830s left) kms_flip (basic-plain-flip) [185.401818] Starting subtest: basic-plain-flip [185.403594] Starting dynamic subtest: A-VGA1 [186.190543] Dynamic subtest A-VGA1: SUCCESS (0.776s) [186.214414] Starting dynamic subtest: B-VGA1 [186.863911] Dynamic subtest B-VGA1: SUCCESS (0.681s) [186.882945] Starting dynamic subtest: A-HDMI-A1 [187.659909] Dynamic subtest A-HDMI-A1: SUCCESS (0.790s) [187.682990] Starting dynamic subtest: B-HDMI-A1 [188.506222] Dynamic subtest B-HDMI-A1: SUCCESS (0.837s) [188.512343] Subtest basic-plain-flip: SUCCESS (3.110s) [189.166830] [113/171] (826s left) kms_force_connector_basic (force-connector-state) [189.366670] Starting subtest: force-connector-state [190.215926] Subtest force-connector-state: SUCCESS (0.849s) [190.970963] [114/171] (824s left) kms_force_connector_basic (force-edid) [191.165904] Starting subtest: force-edid [191.498330] Subtest force-edid: SUCCESS (0.332s) [192.184996] [115/171] (823s left) kms_force_connector_basic (force-load-detect) [192.380389] Starting subtest: force-load-detect [192.618261] Subtest force-load-detect: SUCCESS (0.236s) [193.182546] [116/171] (822s left) kms_force_connector_basic (prune-stale-modes) [193.385495] Starting subtest: prune-stale-modes [193.713953] Subtest prune-stale-modes: SUCCESS (0.334s) [194.396629] [117/171] (821s left) kms_frontbuffer_tracking (basic) [195.093734] Starting subtest: basic [195.383039] Subtest basic: SKIP (0.284s) [195.895068] [118/171] (819s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [196.586653] Starting subtest: compare-crc-sanitycheck-xr24 [196.588405] Starting dynamic subtest: pipe-A-HDMI-A-1 [196.988760] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.398s) [197.011440] Starting dynamic subtest: pipe-B-HDMI-A-1 [197.482146] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.479s) [197.483782] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.889s) [198.045066] [119/171] (817s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [198.739802] Starting subtest: compare-crc-sanitycheck-nv12 [198.742318] Starting dynamic subtest: pipe-A-HDMI-A-1 [198.745861] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [198.755932] Starting dynamic subtest: pipe-B-HDMI-A-1 [198.768841] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [198.772170] Subtest compare-crc-sanitycheck-nv12: SKIP (0.007s) [199.225671] [120/171] (816s left) kms_pipe_crc_basic (hang-read-crc) [199.913673] Starting subtest: hang-read-crc [199.915456] Starting dynamic subtest: pipe-A-HDMI-A-1 [200.988492] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.078s) [201.007675] Starting dynamic subtest: pipe-B-HDMI-A-1 [202.166819] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.174s) [202.168975] Subtest hang-read-crc: SUCCESS (2.259s) [202.773354] [121/171] (812s left) kms_pipe_crc_basic (nonblocking-crc) [203.528955] Starting subtest: nonblocking-crc [203.530649] Starting dynamic subtest: pipe-A-HDMI-A-1 [204.160362] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.545s) [204.312140] Starting dynamic subtest: pipe-B-HDMI-A-1 [204.726409] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.591s) [204.728229] Subtest nonblocking-crc: SUCCESS (1.143s) [205.169555] [122/171] (810s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [205.845957] Starting subtest: nonblocking-crc-frame-sequence [205.847662] Starting dynamic subtest: pipe-A-HDMI-A-1 [206.410049] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.570s) [206.431678] Starting dynamic subtest: pipe-B-HDMI-A-1 [207.059977] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.646s) [207.062232] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.224s) [207.606132] [123/171] (808s left) kms_pipe_crc_basic (read-crc) [208.298047] Starting subtest: read-crc [208.299771] Starting dynamic subtest: pipe-A-HDMI-A-1 [208.797026] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.507s) [208.815990] Starting dynamic subtest: pipe-B-HDMI-A-1 [209.334759] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.534s) [209.336676] Subtest read-crc: SUCCESS (1.048s) [209.908455] [124/171] (805s left) kms_pipe_crc_basic (read-crc-frame-sequence) [210.591868] Starting subtest: read-crc-frame-sequence [210.593724] Starting dynamic subtest: pipe-A-HDMI-A-1 [211.098930] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.506s) [211.120773] Starting dynamic subtest: pipe-B-HDMI-A-1 [211.650750] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.546s) [211.652545] Subtest read-crc-frame-sequence: SUCCESS (1.060s) [212.212254] [125/171] (803s left) kms_psr (primary_page_flip) [212.344710] Subtest primary_page_flip: SKIP (0.000s) [212.380915] [126/171] (803s left) kms_psr (cursor_plane_move) [212.510237] Subtest cursor_plane_move: SKIP (0.000s) [212.547601] [127/171] (803s left) kms_psr (sprite_plane_onoff) [212.675796] Subtest sprite_plane_onoff: SKIP (0.000s) [212.713660] [128/171] (803s left) kms_psr (primary_mmap_gtt) [212.842230] Subtest primary_mmap_gtt: SKIP (0.000s) [212.879952] [129/171] (802s left) kms_setmode (basic-clone-single-crtc) [213.037349] Starting subtest: basic-clone-single-crtc [213.042812] Subtest basic-clone-single-crtc: SKIP (0.001s) [213.110562] [130/171] (802s left) i915_pm_backlight (basic-brightness) [213.774650] Subtest basic-brightness: SKIP (0.000s) [214.027768] [131/171] (801s left) i915_pm_rpm (basic-pci-d3-state) [226.013848] Subtest basic-pci-d3-state: SKIP (0.000s) [226.286643] [132/171] (789s left) i915_pm_rpm (basic-rte) [226.414495] Starting subtest: basic-rte [238.320323] Subtest basic-rte: SKIP (11.887s) [238.595291] [133/171] (777s left) i915_pm_rps (basic-api) [238.728995] Subtest basic-api: SKIP (0.000s) [238.763458] [134/171] (777s left) prime_self_import (basic-llseek-bad) [238.886749] Starting subtest: basic-llseek-bad [238.890342] Subtest basic-llseek-bad: SUCCESS (0.003s) [238.960366] [135/171] (776s left) prime_self_import (basic-llseek-size) [239.086966] Starting subtest: basic-llseek-size [239.091476] Subtest basic-llseek-size: SUCCESS (0.003s) [239.159623] [136/171] (776s left) prime_self_import (basic-with_fd_dup) [239.284100] Starting subtest: basic-with_fd_dup [239.287411] Subtest basic-with_fd_dup: SUCCESS (0.004s) [239.357760] [137/171] (776s left) prime_self_import (basic-with_one_bo) [239.479692] Starting subtest: basic-with_one_bo [239.483997] Subtest basic-with_one_bo: SUCCESS (0.005s) [239.563736] [138/171] (776s left) prime_self_import (basic-with_one_bo_two_files) [239.703582] Starting subtest: basic-with_one_bo_two_files [239.719861] Subtest basic-with_one_bo_two_files: SUCCESS (0.015s) [239.806288] [139/171] (776s left) prime_self_import (basic-with_two_bos) [239.927498] Starting subtest: basic-with_two_bos [239.931917] Subtest basic-with_two_bos: SUCCESS (0.004s) [240.008601] [140/171] (776s left) prime_vgem (basic-fence-flip) [240.154466] Starting subtest: basic-fence-flip [241.285212] Subtest basic-fence-flip: SUCCESS (1.129s) [241.896861] [141/171] (774s left) prime_vgem (basic-fence-mmap) [242.041420] Starting subtest: basic-fence-mmap [242.088297] Subtest basic-fence-mmap: SUCCESS (0.043s) [242.162606] [142/171] (773s left) prime_vgem (basic-fence-read) [242.307567] Starting subtest: basic-fence-read [242.377842] Subtest basic-fence-read: SUCCESS (0.070s) [242.465313] [143/171] (773s left) prime_vgem (basic-gtt) [242.623206] Starting subtest: basic-gtt [242.625028] Subtest basic-gtt: SUCCESS (0.018s) [242.768036] [144/171] (773s left) prime_vgem (basic-read) [243.018031] Starting subtest: basic-read [243.040819] Subtest basic-read: SUCCESS (0.028s) [243.146078] [145/171] (773s left) prime_vgem (basic-write) [243.393667] Starting subtest: basic-write [243.416319] Subtest basic-write: SUCCESS (0.031s) [243.519882] [146/171] (772s left) vgem_basic (setversion) [243.751478] Starting subtest: setversion [243.755318] Subtest setversion: SUCCESS (0.000s) [243.773504] [147/171] (772s left) vgem_basic (create) [243.901175] Starting subtest: create [243.903139] Subtest create: SUCCESS (0.000s) [243.962627] [148/171] (772s left) vgem_basic (debugfs) [244.102138] Starting subtest: debugfs [244.104522] Subtest debugfs: SUCCESS (0.001s) [244.161417] [149/171] (772s left) vgem_basic (dmabuf-export) [244.303058] Starting subtest: dmabuf-export [244.306802] Subtest dmabuf-export: SUCCESS (0.003s) [244.377317] [150/171] (772s left) vgem_basic (dmabuf-fence) [244.518315] Starting subtest: dmabuf-fence [244.520219] Subtest dmabuf-fence: SUCCESS (0.001s) [244.576516] [151/171] (771s left) vgem_basic (dmabuf-fence-before) [244.717598] Starting subtest: dmabuf-fence-before [244.719598] Subtest dmabuf-fence-before: SUCCESS (0.001s) [244.774778] [152/171] (771s left) vgem_basic (dmabuf-mmap) [244.914666] Starting subtest: dmabuf-mmap [244.937081] Subtest dmabuf-mmap: SUCCESS (0.025s) [244.993341] [153/171] (771s left) vgem_basic (mmap) [245.130696] Starting subtest: mmap [245.147199] Subtest mmap: SUCCESS (0.017s) [245.209065] [154/171] (771s left) vgem_basic (second-client) [245.347526] Starting subtest: second-client [245.381359] Subtest second-client: SUCCESS (0.032s) [245.441693] [155/171] (771s left) vgem_basic (sysfs) [245.580736] Starting subtest: sysfs [245.584084] Subtest sysfs: SUCCESS (0.001s) [245.641094] [156/171] (770s left) core_hotunplug (unbind-rebind) [245.827363] Starting subtest: unbind-rebind [247.281673] Subtest unbind-rebind: SUCCESS (1.451s) [247.338598] [157/171] (769s left) vgem_basic (unload) [247.526260] Starting subtest: unload [276.468691] Subtest unload: SUCCESS (28.942s) [276.583624] [158/171] (740s left) i915_module_load (reload) [276.708401] Starting subtest: reload [279.347822] Subtest reload: SUCCESS (2.640s) [279.407345] [159/171] (737s left) gem_lmem_swapping (basic) [279.665051] Subtest basic: SKIP (0.000s) [279.709862] [160/171] (737s left) gem_lmem_swapping (parallel-random-engines) [279.843177] Subtest parallel-random-engines: SKIP (0.000s) [279.876205] [161/171] (736s left) gem_lmem_swapping (random-engines) [280.010284] Subtest random-engines: SKIP (0.000s) [280.042673] [162/171] (736s left) gem_lmem_swapping (verify-random) [280.177393] Subtest verify-random: SKIP (0.000s) [280.224084] [163/171] (736s left) i915_pm_rpm (module-reload) [292.254909] Subtest module-reload: SKIP (0.000s) [292.534482] [164/171] (724s left) i915_selftest (live) [293.360289] Starting subtest: live [293.362187] Starting dynamic subtest: sanitycheck [294.156313] Dynamic subtest sanitycheck: SUCCESS (0.798s) [294.167336] Starting dynamic subtest: uncore [294.926244] Dynamic subtest uncore: SUCCESS (0.766s) [294.940169] Starting dynamic subtest: workarounds [295.630723] Dynamic subtest workarounds: SUCCESS (0.702s) [295.643687] Starting dynamic subtest: gt_engines [296.405157] Dynamic subtest gt_engines: SUCCESS (0.772s) [296.418480] Starting dynamic subtest: gt_timelines [301.615185] Dynamic subtest gt_timelines: SUCCESS (5.207s) [301.628808] Starting dynamic subtest: gt_contexts [302.378041] Dynamic subtest gt_contexts: SUCCESS (0.760s) [302.392104] Starting dynamic subtest: gt_lrc [303.160227] Dynamic subtest gt_lrc: SUCCESS (0.779s) [303.174582] Starting dynamic subtest: gt_mocs [303.928218] Dynamic subtest gt_mocs: SUCCESS (0.765s) [303.941128] Starting dynamic subtest: gt_pm [305.153115] Dynamic subtest gt_pm: SUCCESS (1.222s) [305.170182] Starting dynamic subtest: gt_heartbeat [305.954181] Dynamic subtest gt_heartbeat: SUCCESS (0.798s) [305.968249] Starting dynamic subtest: gt_tlb [306.851154] Dynamic subtest gt_tlb: SUCCESS (0.892s) [306.868538] Starting dynamic subtest: requests [311.196137] Dynamic subtest requests: SUCCESS (4.345s) [311.210174] Starting dynamic subtest: migrate [311.948305] Dynamic subtest migrate: SUCCESS (0.749s) [311.963209] Starting dynamic subtest: active [312.677663] Dynamic subtest active: SUCCESS (0.727s) [312.690874] Starting dynamic subtest: objects [314.846174] Dynamic subtest objects: SUCCESS (2.164s) [314.859623] Starting dynamic subtest: mman [320.839137] Dynamic subtest mman: SUCCESS (5.990s) [320.853113] Starting dynamic subtest: dmabuf [321.652290] Dynamic subtest dmabuf: SUCCESS (0.808s) [321.665673] Starting dynamic subtest: vma [322.466181] Dynamic subtest vma: SUCCESS (0.811s) [322.479479] Starting dynamic subtest: coherency [324.335173] Dynamic subtest coherency: SUCCESS (1.866s) [324.348408] Starting dynamic subtest: gtt [328.589175] Dynamic subtest gtt: SUCCESS (4.251s) [328.602542] Starting dynamic subtest: gem [329.439093] Dynamic subtest gem: SUCCESS (0.848s) [329.454842] Starting dynamic subtest: evict [330.214222] Dynamic subtest evict: SUCCESS (0.772s) [330.227564] Starting dynamic subtest: hugepages [331.049297] Dynamic subtest hugepages: SUCCESS (0.833s) [331.064027] Starting dynamic subtest: gem_contexts [334.909711] Dynamic subtest gem_contexts: SUCCESS (3.858s) [334.919770] Starting dynamic subtest: client [335.699221] Dynamic subtest client: SUCCESS (0.788s) [335.713194] Starting dynamic subtest: gem_migrate [336.433262] Dynamic subtest gem_migrate: SUCCESS (0.731s) [336.447902] Starting dynamic subtest: reset [337.278094] Dynamic subtest reset: SUCCESS (0.842s) [337.292709] Starting dynamic subtest: memory_region [338.046043] Dynamic subtest memory_region: SUCCESS (0.765s) [338.060555] Starting dynamic subtest: hangcheck [340.419353] Dynamic subtest hangcheck: SUCCESS (2.368s) [340.432593] Starting dynamic subtest: execlists [341.249568] Dynamic subtest execlists: SUCCESS (0.813s) [341.272525] Starting dynamic subtest: ring_submission [342.013109] Dynamic subtest ring_submission: SUCCESS (0.738s) [342.023345] Starting dynamic subtest: perf [342.737107] Dynamic subtest perf: SUCCESS (0.760s) [342.749279] Starting dynamic subtest: slpc [343.479647] Dynamic subtest slpc: SUCCESS (0.740s) [343.492949] Starting dynamic subtest: guc [344.293166] Dynamic subtest guc: SUCCESS (0.812s) [344.308811] Starting dynamic subtest: guc_multi_lrc [345.062203] Dynamic subtest guc_multi_lrc: SUCCESS (0.766s) [345.075886] Starting dynamic subtest: guc_hang [345.811435] Dynamic subtest guc_hang: SUCCESS (0.747s) [345.821559] Starting dynamic subtest: late_gt_pm [346.558323] Dynamic subtest late_gt_pm: SUCCESS (0.744s) [346.560278] Subtest live: SUCCESS (53.201s) [346.719666] [165/171] (670s left) dmabuf (all-tests) [346.863752] Starting subtest: all-tests [346.867244] Starting dynamic subtest: sanitycheck [346.915511] Dynamic subtest sanitycheck: SUCCESS (0.058s) [346.929853] Starting dynamic subtest: dma_fence [347.112031] Dynamic subtest dma_fence: SUCCESS (0.188s) [347.121704] Starting dynamic subtest: dma_fence_chain [364.681065] Dynamic subtest dma_fence_chain: SUCCESS (17.570s) [364.696443] Starting dynamic subtest: dma_fence_unwrap [364.747633] Dynamic subtest dma_fence_unwrap: SUCCESS (0.064s) [364.765486] Starting dynamic subtest: dma_resv [364.812162] Dynamic subtest dma_resv: SUCCESS (0.062s) [364.814601] Subtest all-tests: SUCCESS (17.956s) [364.834281] [166/171] (652s left) i915_suspend (basic-s2idle-without-i915) [364.966976] Starting subtest: basic-s2idle-without-i915 [384.217318] Subtest basic-s2idle-without-i915: SUCCESS (3.694s) [387.456826] [167/171] (648s left) i915_suspend (basic-s3-without-i915) [387.589285] Starting subtest: basic-s3-without-i915 [405.470326] Subtest basic-s3-without-i915: SUCCESS (2.679s) [412.681923] [168/171] (645s left) gem_exec_suspend (basic-s0) [412.834603] Starting subtest: basic-S0 [412.837429] Starting dynamic subtest: smem [430.673595] Dynamic subtest smem: SUCCESS (10.527s) [430.675358] Subtest basic-S0: SUCCESS (10.529s) [433.601560] [169/171] (634s left) gem_exec_suspend (basic-s3) [433.744561] Starting subtest: basic-S3 [433.747115] Starting dynamic subtest: smem [450.874219] Dynamic subtest smem: SUCCESS (2.181s) [450.876160] Subtest basic-S3: SUCCESS (2.183s) [458.067703] [170/171] (631s left) kms_chamelium_hpd (common-hpd-after-suspend) [458.855295] Subtest common-hpd-after-suspend: SKIP (0.000s) [459.237690] [171/171] (630s left) kms_pipe_crc_basic (suspend-read-crc) [459.927631] Starting subtest: suspend-read-crc [459.929538] Starting dynamic subtest: pipe-A-HDMI-A-1 [478.041094] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.179s) [478.065448] Starting dynamic subtest: pipe-B-HDMI-A-1 [495.934322] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.195s) [495.936141] Subtest suspend-read-crc: SUCCESS (4.380s) [503.305000] Closing watchdogs Done.