[39.681523] Initializing watchdogs [39.681593] /dev/watchdog0 [39.692194] [001/164] (960s left) i915_module_load (load) [39.753240] Starting subtest: load [41.540927] Subtest load: SUCCESS (1.793s) [41.574074] [002/164] (958s left) core_auth (basic-auth) [43.123831] Starting subtest: basic-auth [43.130256] Subtest basic-auth: SUCCESS (0.001s) [43.174983] [003/164] (957s left) debugfs_test (read_all_entries) [43.247563] Starting subtest: read_all_entries [43.418408] Subtest read_all_entries: SUCCESS (0.172s) [43.492681] [004/164] (956s left) debugfs_test (basic-hwmon) [43.547589] Starting subtest: basic-hwmon [43.559821] Subtest basic-hwmon: SKIP (0.000s) [43.643452] [005/164] (956s left) fbdev (eof) [43.740377] Starting subtest: eof [43.746560] Subtest eof: SUCCESS (0.000s) [43.783258] [006/164] (956s left) fbdev (info) [43.843629] Starting subtest: info [43.852075] Subtest info: SUCCESS (0.000s) [43.894643] [007/164] (956s left) fbdev (nullptr) [43.949474] Starting subtest: nullptr [43.955189] Subtest nullptr: SUCCESS (0.000s) [43.999323] [008/164] (956s left) fbdev (read) [44.050864] Starting subtest: read [44.655757] Subtest read: SUCCESS (0.598s) [44.699395] [009/164] (955s left) fbdev (write) [44.769065] Starting subtest: write [45.265063] Subtest write: SUCCESS (0.491s) [45.307154] [010/164] (955s left) gem_basic (bad-close) [45.377486] Starting subtest: bad-close [45.388603] Subtest bad-close: SUCCESS (0.000s) [45.431491] [011/164] (955s left) gem_basic (create-close) [45.502109] Starting subtest: create-close [45.513415] Subtest create-close: SUCCESS (0.000s) [45.566556] [012/164] (954s left) gem_basic (create-fd-close) [45.620224] Starting subtest: create-fd-close [45.631915] Subtest create-fd-close: SUCCESS (0.000s) [45.713986] [013/164] (954s left) gem_busy (busy@all-engines) [45.798082] Starting subtest: busy [45.803794] Starting dynamic subtest: all-engines [48.073052] Dynamic subtest all-engines: FAIL (2.198s) [48.079035] Subtest busy: FAIL (2.198s) [49.201101] [014/164] (951s left) gem_close_race (basic-process) [49.289580] Starting subtest: basic-process [49.348775] Subtest basic-process: SUCCESS (0.061s) [49.532739] [015/164] (951s left) gem_close_race (basic-threads) [49.617423] Starting subtest: basic-threads [50.880573] Subtest basic-threads: SUCCESS (1.263s) [51.068288] [016/164] (949s left) gem_ctx_create (basic) [51.149714] Starting subtest: basic [51.155914] Subtest basic: SUCCESS (0.000s) [51.320054] [017/164] (949s left) gem_ctx_create (basic-files) [51.374295] Starting subtest: basic-files [53.395531] Subtest basic-files: SUCCESS (2.010s) [55.207286] [018/164] (945s left) gem_ctx_exec (basic) [55.273215] Starting subtest: basic [55.279171] Subtest basic: SUCCESS (0.004s) [55.375196] [019/164] (945s left) gem_exec_basic (basic) [55.447780] Starting subtest: basic [55.454145] Starting dynamic subtest: rcs0-smem [55.460305] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [55.474572] Starting dynamic subtest: bcs0-smem [55.480838] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [55.494907] Starting dynamic subtest: vcs0-smem [55.501110] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [55.514898] Starting dynamic subtest: vcs1-smem [55.521018] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [55.534507] Starting dynamic subtest: vecs0-smem [55.540707] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [55.554882] Starting dynamic subtest: ccs0-smem [55.560881] Dynamic subtest ccs0-smem: SUCCESS (0.000s) [55.567045] Subtest basic: SUCCESS (0.003s) [57.190828] [020/164] (943s left) gem_exec_create (basic) [57.264073] Starting subtest: basic [57.269855] Starting dynamic subtest: smem [61.105070] Dynamic subtest smem: SUCCESS (3.836s) [61.110910] Subtest basic: SUCCESS (3.836s) [61.279989] [021/164] (939s left) gem_exec_fence (basic-busy) [61.499981] Starting subtest: basic-busy [61.505851] Starting dynamic subtest: rcs0 [61.566536] Dynamic subtest rcs0: SUCCESS (0.075s) [61.583347] Starting dynamic subtest: bcs0 [61.616761] Dynamic subtest bcs0: SUCCESS (0.050s) [61.631267] Starting dynamic subtest: vcs0 [61.643547] Dynamic subtest vcs0: SUCCESS (0.024s) [61.657848] Starting dynamic subtest: vcs1 [61.676589] Dynamic subtest vcs1: SUCCESS (0.032s) [61.691346] Starting dynamic subtest: vecs0 [61.702838] Dynamic subtest vecs0: SUCCESS (0.025s) [61.717751] Starting dynamic subtest: ccs0 [61.747364] Dynamic subtest ccs0: SUCCESS (0.049s) [61.753050] Subtest basic-busy: SUCCESS (0.256s) [63.225482] [022/164] (937s left) gem_exec_fence (basic-wait) [63.415215] Starting subtest: basic-wait [63.421264] Starting dynamic subtest: rcs0 [63.466580] Dynamic subtest rcs0: SUCCESS (0.052s) [63.481284] Starting dynamic subtest: bcs0 [63.523792] Dynamic subtest bcs0: SUCCESS (0.057s) [63.540200] Starting dynamic subtest: vcs0 [63.555152] Dynamic subtest vcs0: SUCCESS (0.031s) [63.570097] Starting dynamic subtest: vcs1 [63.590863] Dynamic subtest vcs1: SUCCESS (0.036s) [63.604984] Starting dynamic subtest: vecs0 [63.631852] Dynamic subtest vecs0: SUCCESS (0.041s) [63.646318] Starting dynamic subtest: ccs0 [63.688838] Dynamic subtest ccs0: SUCCESS (0.056s) [63.694950] Subtest basic-wait: SUCCESS (0.274s) [65.222909] [023/164] (935s left) gem_exec_fence (basic-await) [65.418063] Starting subtest: basic-await [65.423977] Starting dynamic subtest: rcs0 [65.498214] Dynamic subtest rcs0: SUCCESS (0.082s) [65.512764] Starting dynamic subtest: bcs0 [65.579464] Dynamic subtest bcs0: SUCCESS (0.083s) [65.596477] Starting dynamic subtest: vcs0 [65.664617] Dynamic subtest vcs0: SUCCESS (0.085s) [65.681196] Starting dynamic subtest: vcs1 [65.746451] Dynamic subtest vcs1: SUCCESS (0.081s) [65.761778] Starting dynamic subtest: vecs0 [65.832427] Dynamic subtest vecs0: SUCCESS (0.086s) [65.847047] Starting dynamic subtest: ccs0 [65.920515] Dynamic subtest ccs0: SUCCESS (0.086s) [65.926515] Subtest basic-await: SUCCESS (0.504s) [67.194488] [024/164] (933s left) gem_exec_fence (nb-await) [67.381991] Starting subtest: nb-await [67.387742] Starting dynamic subtest: rcs0 [67.448474] Dynamic subtest rcs0: SUCCESS (0.069s) [67.463168] Starting dynamic subtest: bcs0 [67.513486] Dynamic subtest bcs0: SUCCESS (0.062s) [67.528239] Starting dynamic subtest: vcs0 [67.573570] Dynamic subtest vcs0: SUCCESS (0.062s) [67.588553] Starting dynamic subtest: vcs1 [67.639347] Dynamic subtest vcs1: SUCCESS (0.063s) [67.653479] Starting dynamic subtest: vecs0 [67.702541] Dynamic subtest vecs0: SUCCESS (0.063s) [67.716585] Starting dynamic subtest: ccs0 [67.765168] Dynamic subtest ccs0: SUCCESS (0.063s) [67.771258] Subtest nb-await: SUCCESS (0.383s) [69.194801] [025/164] (931s left) gem_exec_gttfill (basic) [69.260032] Starting subtest: basic [71.634719] Subtest basic: SUCCESS (2.374s) [71.806175] [026/164] (929s left) gem_exec_parallel (engines) [71.926662] Starting subtest: engines [71.932527] Starting dynamic subtest: basic [75.123577] Dynamic subtest basic: SUCCESS (3.191s) [75.143415] Starting dynamic subtest: contexts [77.149514] Dynamic subtest contexts: SUCCESS (2.025s) [77.158796] Starting dynamic subtest: fds [79.339324] Dynamic subtest fds: SUCCESS (2.190s) [79.350877] Starting dynamic subtest: userptr [81.145745] Dynamic subtest userptr: SUCCESS (1.806s) [81.152376] Subtest engines: SUCCESS (9.213s) [81.330151] [027/164] (919s left) gem_exec_store (basic) [81.430244] Starting subtest: basic [81.523607] Subtest basic: SUCCESS (0.104s) [81.702862] [028/164] (919s left) gem_flink_basic (bad-flink) [81.771106] Starting subtest: bad-flink [81.776813] Subtest bad-flink: SUCCESS (0.000s) [81.834998] [029/164] (919s left) gem_flink_basic (bad-open) [81.900832] Starting subtest: bad-open [81.908319] Subtest bad-open: SUCCESS (0.000s) [81.964592] [030/164] (919s left) gem_flink_basic (basic) [82.032479] Starting subtest: basic [82.038403] Subtest basic: SUCCESS (0.000s) [82.106418] [031/164] (919s left) gem_flink_basic (double-flink) [82.174586] Starting subtest: double-flink [82.180191] Subtest double-flink: SUCCESS (0.000s) [82.248268] [032/164] (918s left) gem_flink_basic (flink-lifetime) [82.324086] Starting subtest: flink-lifetime [82.329692] Subtest flink-lifetime: SUCCESS (0.001s) [82.397549] [033/164] (918s left) gem_huc_copy (huc-copy) [82.456272] Starting subtest: huc-copy [82.461769] Subtest huc-copy: SUCCESS (0.002s) [82.562864] [034/164] (918s left) gem_linear_blits (basic) [82.670193] Starting subtest: basic [82.676199] Subtest basic: SUCCESS (0.004s) [82.793471] [035/164] (918s left) gem_mmap (basic) [82.914773] Subtest basic: SKIP (0.000s) [82.943180] [036/164] (918s left) gem_mmap_gtt (basic) [83.030320] Subtest basic: SKIP (0.000s) [83.065776] [037/164] (918s left) gem_render_linear_blits (basic) [83.131867] Starting subtest: basic [83.162481] Subtest basic: SUCCESS (0.023s) [83.231476] [038/164] (918s left) gem_render_tiled_blits (basic) [83.302465] Subtest basic: SKIP (0.000s) [83.330928] [039/164] (918s left) gem_ringfill (basic-all) [89.153232] Starting subtest: basic-all [90.281498] Subtest basic-all: SUCCESS (1.132s) [90.388089] [040/164] (911s left) gem_softpin (allocator-basic) [90.460134] Starting subtest: allocator-basic [90.505146] Subtest allocator-basic: SUCCESS (0.048s) [90.608438] [041/164] (910s left) gem_softpin (allocator-basic-reserve) [90.666466] Starting subtest: allocator-basic-reserve [90.722152] Subtest allocator-basic-reserve: SUCCESS (0.056s) [90.825392] [042/164] (910s left) gem_softpin (safe-alignment) [90.885841] Starting subtest: safe-alignment [90.905964] Subtest safe-alignment: SUCCESS (0.026s) [92.199677] [043/164] (909s left) gem_sync (basic-all) [92.310661] Starting subtest: basic-all [96.106336] Subtest basic-all: SUCCESS (3.823s) [96.280783] [044/164] (905s left) gem_sync (basic-each) [96.399934] Starting subtest: basic-each [98.724769] Subtest basic-each: SUCCESS (2.371s) [98.904493] [045/164] (902s left) gem_tiled_blits (basic) [98.983154] Subtest basic: SKIP (0.000s) [99.012982] [046/164] (902s left) gem_tiled_fence_blits (basic) [99.079413] Subtest basic: SKIP (0.000s) [99.106949] [047/164] (902s left) gem_tiled_pread_basic [99.196184] [048/164] (902s left) gem_wait (busy@all-engines) [99.279629] Starting subtest: busy [99.285190] Starting dynamic subtest: all-engines [101.097135] Dynamic subtest all-engines: SUCCESS (1.814s) [101.102987] Subtest busy: SUCCESS (1.815s) [101.297398] [049/164] (900s left) gem_wait (wait@all-engines) [101.378083] Starting subtest: wait [101.383677] Starting dynamic subtest: all-engines [103.144943] Dynamic subtest all-engines: SUCCESS (1.759s) [103.150617] Subtest wait: SUCCESS (1.759s) [103.341408] [050/164] (898s left) i915_getparams_basic (basic-eu-total) [103.413439] Starting subtest: basic-eu-total [103.424532] Subtest basic-eu-total: SUCCESS (0.000s) [103.469174] [051/164] (898s left) i915_getparams_basic (basic-subslice-total) [103.543568] Starting subtest: basic-subslice-total [103.554767] Subtest basic-subslice-total: SUCCESS (0.000s) [103.610894] [052/164] (898s left) i915_hangman (error-state-basic) [103.702108] Starting subtest: error-state-basic [103.842125] Subtest error-state-basic: SUCCESS (0.145s) [103.918374] [053/164] (897s left) i915_pciid [104.058545] [054/164] (897s left) kms_addfb_basic (addfb25-4-tiled) [104.139237] Starting subtest: addfb25-4-tiled [104.144932] Subtest addfb25-4-tiled: SUCCESS (0.000s) [104.228315] [055/164] (897s left) kms_addfb_basic (addfb25-bad-modifier) [104.294904] Starting subtest: addfb25-bad-modifier [104.300614] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [104.408414] [056/164] (897s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [104.484537] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s) [104.563458] [057/164] (897s left) kms_addfb_basic (addfb25-modifier-no-flag) [104.644579] Starting subtest: addfb25-modifier-no-flag [104.650189] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [104.741177] [058/164] (897s left) kms_addfb_basic (addfb25-x-tiled-legacy) [104.810504] Subtest addfb25-x-tiled-legacy: SKIP (0.000s) [104.887825] [059/164] (897s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [104.950070] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [105.050058] [060/164] (897s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [105.118703] Starting subtest: addfb25-yf-tiled-legacy [105.124272] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [105.204854] [061/164] (896s left) kms_addfb_basic (addfb25-y-tiled-legacy) [105.287412] Starting subtest: addfb25-y-tiled-legacy [105.293629] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [105.380781] [062/164] (896s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [105.460172] Starting subtest: addfb25-y-tiled-small-legacy [105.471470] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [105.538969] [063/164] (896s left) kms_addfb_basic (bad-pitch-0) [105.604952] Starting subtest: bad-pitch-0 [105.610646] Subtest bad-pitch-0: SUCCESS (0.000s) [105.699876] [064/164] (896s left) kms_addfb_basic (bad-pitch-1024) [105.772231] Starting subtest: bad-pitch-1024 [105.777832] Subtest bad-pitch-1024: SUCCESS (0.000s) [105.876702] [065/164] (896s left) kms_addfb_basic (bad-pitch-128) [105.950027] Starting subtest: bad-pitch-128 [105.955611] Subtest bad-pitch-128: SUCCESS (0.000s) [106.050910] [066/164] (896s left) kms_addfb_basic (bad-pitch-256) [106.135304] Starting subtest: bad-pitch-256 [106.141550] Subtest bad-pitch-256: SUCCESS (0.000s) [106.241995] [067/164] (896s left) kms_addfb_basic (bad-pitch-32) [106.316368] Starting subtest: bad-pitch-32 [106.322025] Subtest bad-pitch-32: SUCCESS (0.000s) [106.415304] [068/164] (895s left) kms_addfb_basic (bad-pitch-63) [106.486511] Starting subtest: bad-pitch-63 [106.492039] Subtest bad-pitch-63: SUCCESS (0.000s) [106.594876] [069/164] (895s left) kms_addfb_basic (bad-pitch-65536) [106.665315] Starting subtest: bad-pitch-65536 [106.671382] Subtest bad-pitch-65536: SUCCESS (0.000s) [106.741979] [070/164] (895s left) kms_addfb_basic (bad-pitch-999) [106.812718] Starting subtest: bad-pitch-999 [106.818425] Subtest bad-pitch-999: SUCCESS (0.000s) [106.918520] [071/164] (895s left) kms_addfb_basic (basic) [106.990313] Starting subtest: basic [106.996100] Subtest basic: SUCCESS (0.000s) [107.072875] [072/164] (895s left) kms_addfb_basic (basic-x-tiled-legacy) [107.151144] Starting subtest: basic-x-tiled-legacy [107.163123] Subtest basic-x-tiled-legacy: SKIP (0.000s) [107.255269] [073/164] (895s left) kms_addfb_basic (basic-y-tiled-legacy) [107.318950] Starting subtest: basic-y-tiled-legacy [107.330325] Subtest basic-y-tiled-legacy: SKIP (0.000s) [107.391861] [074/164] (895s left) kms_addfb_basic (bo-too-small) [107.485479] Starting subtest: bo-too-small [107.491047] Subtest bo-too-small: SUCCESS (0.000s) [107.565587] [075/164] (894s left) kms_addfb_basic (bo-too-small-due-to-tiling) [107.658403] Starting subtest: bo-too-small-due-to-tiling [107.669453] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [107.738138] [076/164] (894s left) kms_addfb_basic (clobberred-modifier) [107.825794] Starting subtest: clobberred-modifier [107.837270] Subtest clobberred-modifier: SKIP (0.000s) [107.935148] [077/164] (894s left) kms_addfb_basic (framebuffer-vs-set-tiling) [108.006376] Starting subtest: framebuffer-vs-set-tiling [108.017902] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [108.083559] [078/164] (894s left) kms_addfb_basic (invalid-get-prop) [108.147677] Starting subtest: invalid-get-prop [108.153263] Subtest invalid-get-prop: SUCCESS (0.000s) [108.239539] [079/164] (894s left) kms_addfb_basic (invalid-get-prop-any) [108.300954] Starting subtest: invalid-get-prop-any [108.306742] Subtest invalid-get-prop-any: SUCCESS (0.000s) [108.378897] [080/164] (894s left) kms_addfb_basic (invalid-set-prop) [108.448698] Starting subtest: invalid-set-prop [108.454473] Subtest invalid-set-prop: SUCCESS (0.000s) [108.551207] [081/164] (894s left) kms_addfb_basic (invalid-set-prop-any) [108.620503] Starting subtest: invalid-set-prop-any [108.626232] Subtest invalid-set-prop-any: SUCCESS (0.000s) [108.723499] [082/164] (894s left) kms_addfb_basic (no-handle) [108.790049] Starting subtest: no-handle [108.795706] Subtest no-handle: SUCCESS (0.000s) [108.877055] [083/164] (893s left) kms_addfb_basic (size-max) [108.962642] Starting subtest: size-max [108.968212] Subtest size-max: SUCCESS (0.000s) [109.048026] [084/164] (893s left) kms_addfb_basic (small-bo) [109.139414] Starting subtest: small-bo [109.145022] Subtest small-bo: SUCCESS (0.000s) [109.233179] [085/164] (893s left) kms_addfb_basic (tile-pitch-mismatch) [109.298161] Starting subtest: tile-pitch-mismatch [109.309202] Subtest tile-pitch-mismatch: SKIP (0.000s) [109.382207] [086/164] (893s left) kms_addfb_basic (too-high) [109.456786] Starting subtest: too-high [109.462280] Subtest too-high: SUCCESS (0.000s) [109.529883] [087/164] (893s left) kms_addfb_basic (too-wide) [109.601995] Starting subtest: too-wide [109.607471] Subtest too-wide: SUCCESS (0.000s) [109.686538] [088/164] (893s left) kms_addfb_basic (unused-handle) [109.758536] Starting subtest: unused-handle [109.764172] Subtest unused-handle: SUCCESS (0.000s) [109.856352] [089/164] (893s left) kms_addfb_basic (unused-modifier) [109.925140] Starting subtest: unused-modifier [109.930719] Subtest unused-modifier: SUCCESS (0.000s) [110.024435] [090/164] (892s left) kms_addfb_basic (unused-offsets) [110.093839] Starting subtest: unused-offsets [110.100161] Subtest unused-offsets: SUCCESS (0.000s) [110.205911] [091/164] (892s left) kms_addfb_basic (unused-pitches) [110.277735] Starting subtest: unused-pitches [110.283334] Subtest unused-pitches: SUCCESS (0.000s) [110.387699] [092/164] (892s left) kms_busy (basic) [110.471636] Starting subtest: basic [110.477213] Starting dynamic subtest: flip [111.205236] Dynamic subtest flip: SUCCESS (0.735s) [111.218993] Starting dynamic subtest: modeset [114.935924] Dynamic subtest modeset: SUCCESS (3.727s) [114.941750] Subtest basic: SUCCESS (4.465s) [115.850037] [093/164] (887s left) kms_prop_blob (basic) [115.922787] Starting subtest: basic [115.928649] Subtest basic: SUCCESS (0.000s) [115.978130] [094/164] (887s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [116.055726] Starting subtest: basic-busy-flip-before-cursor-atomic [116.066596] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [116.147782] [095/164] (887s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [116.244466] Starting subtest: basic-busy-flip-before-cursor-legacy [116.255589] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [116.333669] [096/164] (886s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [116.451762] Starting subtest: basic-flip-after-cursor-atomic [117.378890] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.928s) [118.272909] [097/164] (884s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [118.376700] Starting subtest: basic-flip-after-cursor-legacy [119.302175] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.927s) [120.192204] [098/164] (883s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [120.294821] Starting subtest: basic-flip-after-cursor-varying-size [121.223267] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.928s) [122.109344] [099/164] (881s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [122.235766] Starting subtest: basic-flip-before-cursor-atomic [123.163325] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.925s) [124.096733] [100/164] (879s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [124.182124] Starting subtest: basic-flip-before-cursor-legacy [125.108986] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.927s) [126.016156] [101/164] (877s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [126.128404] Starting subtest: basic-flip-before-cursor-varying-size [127.079702] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.951s) [127.993987] [102/164] (875s left) kms_flip (basic-flip-vs-dpms) [128.075705] Starting subtest: basic-flip-vs-dpms [128.081375] Starting dynamic subtest: A-eDP1 [130.776489] Dynamic subtest A-eDP1: SUCCESS (2.705s) [130.796962] Starting dynamic subtest: B-eDP1 [133.131754] Dynamic subtest B-eDP1: SUCCESS (2.354s) [133.149662] Starting dynamic subtest: C-eDP1 [135.419774] Dynamic subtest C-eDP1: SUCCESS (2.283s) [135.432098] Starting dynamic subtest: D-eDP1 [137.718484] Dynamic subtest D-eDP1: SUCCESS (2.303s) [137.724497] Subtest basic-flip-vs-dpms: SUCCESS (9.659s) [138.607296] [103/164] (864s left) kms_flip (basic-flip-vs-modeset) [138.684054] Starting subtest: basic-flip-vs-modeset [138.691933] Starting dynamic subtest: A-eDP1 [141.366069] Dynamic subtest A-eDP1: SUCCESS (2.686s) [141.380712] Starting dynamic subtest: B-eDP1 [143.693862] Dynamic subtest B-eDP1: SUCCESS (2.327s) [143.707339] Starting dynamic subtest: C-eDP1 [145.975408] Dynamic subtest C-eDP1: SUCCESS (2.280s) [145.993295] Starting dynamic subtest: D-eDP1 [148.289463] Dynamic subtest D-eDP1: SUCCESS (2.313s) [148.295513] Subtest basic-flip-vs-modeset: SUCCESS (9.618s) [149.168674] [104/164] (854s left) kms_flip (basic-flip-vs-wf_vblank) [149.252254] Starting subtest: basic-flip-vs-wf_vblank [149.257938] Starting dynamic subtest: A-eDP1 [151.250057] Dynamic subtest A-eDP1: SUCCESS (2.001s) [151.268084] Starting dynamic subtest: B-eDP1 [153.236524] Dynamic subtest B-eDP1: SUCCESS (1.983s) [153.254236] Starting dynamic subtest: C-eDP1 [155.211267] Dynamic subtest C-eDP1: SUCCESS (1.971s) [155.227682] Starting dynamic subtest: D-eDP1 [157.198831] Dynamic subtest D-eDP1: SUCCESS (1.984s) [157.204528] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.957s) [158.478576] [105/164] (845s left) kms_flip (basic-plain-flip) [158.562388] Starting subtest: basic-plain-flip [158.568074] Starting dynamic subtest: A-eDP1 [160.298198] Dynamic subtest A-eDP1: SUCCESS (1.736s) [160.316792] Starting dynamic subtest: B-eDP1 [162.088950] Dynamic subtest B-eDP1: SUCCESS (1.789s) [162.106509] Starting dynamic subtest: C-eDP1 [163.875411] Dynamic subtest C-eDP1: SUCCESS (1.781s) [163.892792] Starting dynamic subtest: D-eDP1 [165.666413] Dynamic subtest D-eDP1: SUCCESS (1.791s) [165.672271] Subtest basic-plain-flip: SUCCESS (7.118s) [166.925340] [106/164] (836s left) kms_force_connector_basic (force-connector-state) [166.998261] Starting subtest: force-connector-state [167.511742] Subtest force-connector-state: SUCCESS (0.518s) [168.519289] [107/164] (835s left) kms_force_connector_basic (force-edid) [168.592099] Starting subtest: force-edid [168.838415] Subtest force-edid: SUCCESS (0.254s) [168.980566] [108/164] (834s left) kms_force_connector_basic (force-load-detect) [169.045120] Starting subtest: force-load-detect [169.056991] Subtest force-load-detect: SKIP (0.000s) [169.132528] [109/164] (834s left) kms_force_connector_basic (prune-stale-modes) [169.208491] Starting subtest: prune-stale-modes [169.393868] Subtest prune-stale-modes: SKIP (0.186s) [169.511217] [110/164] (834s left) kms_frontbuffer_tracking (basic) [169.610933] Starting subtest: basic [172.844124] Subtest basic: SUCCESS (3.251s) [172.957638] [111/164] (830s left) kms_hdmi_inject (inject-audio) [173.312520] Starting subtest: inject-audio [173.544034] Subtest inject-audio: SUCCESS (0.223s) [174.502160] [112/164] (829s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [174.589294] Starting subtest: compare-crc-sanitycheck-xr24 [174.594969] Starting dynamic subtest: pipe-A-eDP-1 [175.281329] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.690s) [175.296701] Starting dynamic subtest: pipe-B-eDP-1 [176.692096] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.408s) [176.706212] Starting dynamic subtest: pipe-C-eDP-1 [178.023156] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.327s) [178.039943] Starting dynamic subtest: pipe-D-eDP-1 [179.369049] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.342s) [179.375288] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.778s) [180.301675] [113/164] (823s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [180.368148] Starting subtest: compare-crc-sanitycheck-nv12 [180.374038] Starting dynamic subtest: pipe-A-eDP-1 [181.056584] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.686s) [181.070133] Starting dynamic subtest: pipe-B-eDP-1 [182.425369] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.365s) [182.439762] Starting dynamic subtest: pipe-C-eDP-1 [183.742345] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.313s) [183.754126] Starting dynamic subtest: pipe-D-eDP-1 [185.043360] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.298s) [185.049430] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.675s) [185.916338] [114/164] (817s left) kms_pipe_crc_basic (hang-read-crc) [186.023807] Starting subtest: hang-read-crc [186.029379] Starting dynamic subtest: pipe-A-eDP-1 [188.248276] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.221s) [188.265448] Starting dynamic subtest: pipe-B-eDP-1 [191.164597] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.916s) [191.182500] Starting dynamic subtest: pipe-C-eDP-1 [193.970130] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.802s) [193.988434] Starting dynamic subtest: pipe-D-eDP-1 [196.794821] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.823s) [196.801058] Subtest hang-read-crc: SUCCESS (10.773s) [197.689140] [115/164] (806s left) kms_pipe_crc_basic (nonblocking-crc) [197.768434] Starting subtest: nonblocking-crc [197.774166] Starting dynamic subtest: pipe-A-eDP-1 [198.543537] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.774s) [198.561952] Starting dynamic subtest: pipe-B-eDP-1 [200.080511] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.533s) [200.098968] Starting dynamic subtest: pipe-C-eDP-1 [201.506348] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.423s) [201.521870] Starting dynamic subtest: pipe-D-eDP-1 [203.024226] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.513s) [203.030387] Subtest nonblocking-crc: SUCCESS (5.255s) [203.898076] [116/164] (799s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [203.993664] Starting subtest: nonblocking-crc-frame-sequence [203.999261] Starting dynamic subtest: pipe-A-eDP-1 [204.789051] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.794s) [204.808066] Starting dynamic subtest: pipe-B-eDP-1 [206.321095] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.530s) [206.340663] Starting dynamic subtest: pipe-C-eDP-1 [207.800899] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.477s) [207.815400] Starting dynamic subtest: pipe-D-eDP-1 [209.261325] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.456s) [209.267227] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.270s) [210.177175] [117/164] (793s left) kms_pipe_crc_basic (read-crc) [210.258087] Starting subtest: read-crc [210.264164] Starting dynamic subtest: pipe-A-eDP-1 [210.975072] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.718s) [210.991145] Starting dynamic subtest: pipe-B-eDP-1 [212.498173] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.517s) [212.510768] Starting dynamic subtest: pipe-C-eDP-1 [213.912369] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.412s) [213.931361] Starting dynamic subtest: pipe-D-eDP-1 [215.362091] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.446s) [215.367987] Subtest read-crc: SUCCESS (5.106s) [216.240619] [118/164] (787s left) kms_pipe_crc_basic (read-crc-frame-sequence) [216.333507] Starting subtest: read-crc-frame-sequence [216.339499] Starting dynamic subtest: pipe-A-eDP-1 [217.056851] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s) [217.074118] Starting dynamic subtest: pipe-B-eDP-1 [218.554746] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.493s) [218.573325] Starting dynamic subtest: pipe-C-eDP-1 [219.994404] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.435s) [220.012556] Starting dynamic subtest: pipe-D-eDP-1 [221.441108] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.446s) [221.447170] Subtest read-crc-frame-sequence: SUCCESS (5.106s) [222.337550] [119/164] (781s left) kms_pm_backlight (basic-brightness) [222.438739] Starting subtest: basic-brightness [222.482442] Starting dynamic subtest: eDP-1 [223.003547] Dynamic subtest eDP-1: SUCCESS (0.517s) [223.009347] Subtest basic-brightness: SUCCESS (0.566s) [223.882253] [120/164] (780s left) kms_psr (primary_page_flip) [223.980862] Starting subtest: primary_page_flip [225.787139] Subtest primary_page_flip: SUCCESS (1.803s) [226.702323] [121/164] (777s left) kms_psr (cursor_plane_move) [226.786756] Starting subtest: cursor_plane_move [228.567733] Subtest cursor_plane_move: SUCCESS (1.781s) [229.501544] [122/164] (774s left) kms_psr (sprite_plane_onoff) [229.597716] Starting subtest: sprite_plane_onoff [231.437345] Subtest sprite_plane_onoff: SUCCESS (1.842s) [232.322453] [123/164] (771s left) kms_psr (primary_mmap_gtt) [232.398332] Starting subtest: primary_mmap_gtt [233.918341] Subtest primary_mmap_gtt: SKIP (1.512s) [234.084947] [124/164] (770s left) kms_setmode (basic-clone-single-crtc) [234.149938] Starting subtest: basic-clone-single-crtc [234.167410] Subtest basic-clone-single-crtc: SKIP (0.001s) [234.213264] [125/164] (769s left) i915_pm_rpm (basic-pci-d3-state) [236.324222] Starting subtest: basic-pci-d3-state [240.567191] Subtest basic-pci-d3-state: SUCCESS (4.236s) [240.653181] [126/164] (763s left) i915_pm_rpm (basic-rte) [240.734025] Starting subtest: basic-rte [246.775929] Subtest basic-rte: SUCCESS (6.040s) [251.821256] [127/164] (752s left) i915_pm_rps (basic-api) [251.882937] Starting subtest: basic-api [251.894634] Subtest basic-api: SKIP (0.001s) [251.973996] [128/164] (752s left) prime_self_import (basic-llseek-bad) [252.046572] Starting subtest: basic-llseek-bad [252.058034] Subtest basic-llseek-bad: SUCCESS (0.003s) [252.148713] [129/164] (752s left) prime_self_import (basic-llseek-size) [252.217074] Starting subtest: basic-llseek-size [252.229107] Subtest basic-llseek-size: SUCCESS (0.002s) [252.294103] [130/164] (752s left) prime_self_import (basic-with_fd_dup) [252.350111] Starting subtest: basic-with_fd_dup [252.361379] Subtest basic-with_fd_dup: SUCCESS (0.004s) [252.446593] [131/164] (751s left) prime_self_import (basic-with_one_bo) [252.513177] Starting subtest: basic-with_one_bo [252.525342] Subtest basic-with_one_bo: SUCCESS (0.004s) [252.583267] [132/164] (751s left) prime_self_import (basic-with_one_bo_two_files) [252.650895] Starting subtest: basic-with_one_bo_two_files [252.662486] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [252.743510] [133/164] (751s left) prime_self_import (basic-with_two_bos) [252.807506] Starting subtest: basic-with_two_bos [252.819286] Subtest basic-with_two_bos: SUCCESS (0.001s) [252.892147] [134/164] (751s left) prime_vgem (basic-fence-flip) [252.978894] Starting subtest: basic-fence-flip [253.267250] Subtest basic-fence-flip: SUCCESS (0.292s) [253.368026] [135/164] (751s left) prime_vgem (basic-fence-mmap) [253.475060] Starting subtest: basic-fence-mmap [253.486952] Subtest basic-fence-mmap: SKIP (0.000s) [253.566630] [136/164] (750s left) prime_vgem (basic-fence-read) [253.650637] Starting subtest: basic-fence-read [253.669051] Subtest basic-fence-read: SKIP (0.009s) [253.760685] [137/164] (750s left) prime_vgem (basic-gtt) [253.847901] Starting subtest: basic-gtt [253.859278] Subtest basic-gtt: SKIP (0.000s) [253.937512] [138/164] (750s left) prime_vgem (basic-read) [254.033169] Starting subtest: basic-read [254.044730] Subtest basic-read: SKIP (0.007s) [254.130489] [139/164] (750s left) prime_vgem (basic-write) [254.216373] Starting subtest: basic-write [254.227685] Subtest basic-write: SKIP (0.006s) [254.315263] [140/164] (750s left) vgem_basic (setversion) [254.381780] Starting subtest: setversion [254.394299] Subtest setversion: SUCCESS (0.000s) [254.432583] [141/164] (750s left) vgem_basic (create) [254.503291] Starting subtest: create [254.509071] Subtest create: SUCCESS (0.000s) [254.551537] [142/164] (750s left) vgem_basic (debugfs) [254.630370] Starting subtest: debugfs [254.636115] Subtest debugfs: SUCCESS (0.001s) [254.680481] [143/164] (750s left) vgem_basic (dmabuf-export) [254.760848] Starting subtest: dmabuf-export [254.778770] Subtest dmabuf-export: SUCCESS (0.024s) [254.876640] [144/164] (749s left) vgem_basic (dmabuf-fence) [254.957974] Starting subtest: dmabuf-fence [254.963854] Subtest dmabuf-fence: SUCCESS (0.000s) [254.999275] [145/164] (749s left) vgem_basic (dmabuf-fence-before) [255.076747] Starting subtest: dmabuf-fence-before [255.082568] Subtest dmabuf-fence-before: SUCCESS (0.000s) [255.126820] [146/164] (749s left) vgem_basic (dmabuf-mmap) [255.191454] Starting subtest: dmabuf-mmap [255.203648] Subtest dmabuf-mmap: SUCCESS (0.012s) [255.250889] [147/164] (749s left) vgem_basic (mmap) [255.334248] Starting subtest: mmap [255.347301] Subtest mmap: SUCCESS (0.012s) [255.394643] [148/164] (749s left) vgem_basic (second-client) [255.469327] Starting subtest: second-client [255.492245] Subtest second-client: SUCCESS (0.022s) [255.540670] [149/164] (749s left) vgem_basic (sysfs) [255.625447] Starting subtest: sysfs [255.631860] Subtest sysfs: SUCCESS (0.001s) [255.676247] [150/164] (749s left) core_hotunplug (unbind-rebind) [255.753742] Starting subtest: unbind-rebind [260.000970] Subtest unbind-rebind: SUCCESS (4.247s) [260.035844] [151/164] (745s left) vgem_basic (unload) [260.093267] Starting subtest: unload [289.027747] Subtest unload: SUCCESS (28.931s) [289.130974] [152/164] (715s left) i915_module_load (reload) [289.194205] Starting subtest: reload [291.704283] Subtest reload: SUCCESS (2.503s) [291.739598] [153/164] (713s left) gem_lmem_swapping (basic) [291.801346] Subtest basic: SKIP (0.000s) [291.831428] [154/164] (713s left) gem_lmem_swapping (parallel-random-engines) [291.895056] Subtest parallel-random-engines: SKIP (0.000s) [291.925310] [155/164] (713s left) gem_lmem_swapping (random-engines) [291.988656] Subtest random-engines: SKIP (0.000s) [292.019916] [156/164] (713s left) gem_lmem_swapping (verify-random) [292.098334] Subtest verify-random: SKIP (0.000s) [292.132997] [157/164] (713s left) i915_pm_rpm (module-reload) [298.297931] Starting subtest: module-reload [314.709881] Subtest module-reload: SUCCESS (16.407s) [314.740369] [158/164] (690s left) i915_selftest (live) [314.809191] Starting subtest: live [314.815396] Starting dynamic subtest: sanitycheck [316.366981] Dynamic subtest sanitycheck: SUCCESS (1.549s) [316.383776] Starting dynamic subtest: uncore [317.968877] Dynamic subtest uncore: SUCCESS (1.604s) [317.984367] Starting dynamic subtest: workarounds [319.942406] Dynamic subtest workarounds: SUCCESS (1.978s) [319.958166] Starting dynamic subtest: gt_engines [321.803273] Dynamic subtest gt_engines: SUCCESS (1.853s) [321.825281] Starting dynamic subtest: gt_timelines [327.147503] Dynamic subtest gt_timelines: SUCCESS (5.341s) [327.165280] Starting dynamic subtest: gt_contexts [328.784391] Dynamic subtest gt_contexts: SUCCESS (1.634s) [328.801375] Starting dynamic subtest: gt_lrc [332.240947] Dynamic subtest gt_lrc: SUCCESS (3.455s) [332.261572] Starting dynamic subtest: gt_mocs [334.081979] Dynamic subtest gt_mocs: SUCCESS (1.844s) [334.097647] Starting dynamic subtest: gt_pm [336.536183] Dynamic subtest gt_pm: SUCCESS (2.453s) [336.552265] Starting dynamic subtest: gt_heartbeat [338.206101] Dynamic subtest gt_heartbeat: SUCCESS (1.669s) [338.221648] Starting dynamic subtest: gt_tlb [341.505302] Dynamic subtest gt_tlb: SUCCESS (3.298s) [341.522383] Starting dynamic subtest: requests [471.320265] Per-test timeout exceeded. Killing the current test with SIGQUIT. [582.223996] Timeout. Killing the current test with SIGKILL. [602.694293] Child refuses to die, tainted 0x40. Aborting. [602.700499] Closing watchdogs [602.706637] Closing watchdogs Done.