[44.138426] Initializing watchdogs [44.138595] /dev/watchdog0 [44.148792] [001/171] (960s left) i915_module_load (load) [44.278914] Starting subtest: load [46.699317] Subtest load: SUCCESS (2.420s) [46.738498] [002/171] (957s left) core_auth (basic-auth) [46.869346] Starting subtest: basic-auth [46.870598] Subtest basic-auth: SUCCESS (0.002s) [46.946377] [003/171] (957s left) debugfs_test (read_all_entries) [47.076363] Starting subtest: read_all_entries [47.150658] Subtest read_all_entries: SUCCESS (0.074s) [47.245195] [004/171] (957s left) debugfs_test (basic-hwmon) [47.364184] Starting subtest: basic-hwmon [47.366252] Subtest basic-hwmon: SKIP (0.000s) [47.461318] [005/171] (957s left) fbdev (eof) [47.595227] Starting subtest: eof [47.596255] Subtest eof: SUCCESS (0.000s) [47.657732] [006/171] (957s left) fbdev (info) [47.791828] Starting subtest: info [47.793116] Subtest info: SUCCESS (0.000s) [47.864488] [007/171] (956s left) fbdev (nullptr) [48.016247] Starting subtest: nullptr [48.017466] Subtest nullptr: SUCCESS (0.000s) [48.082135] [008/171] (956s left) fbdev (read) [48.199225] Starting subtest: read [55.300087] Subtest read: SUCCESS (7.067s) [55.328448] [009/171] (949s left) fbdev (write) [55.449946] Starting subtest: write [59.218945] Subtest write: SUCCESS (3.735s) [59.266158] [010/171] (945s left) gem_basic (bad-close) [59.377513] Starting subtest: bad-close [59.379543] Subtest bad-close: SUCCESS (0.000s) [59.452602] [011/171] (945s left) gem_basic (create-close) [59.564999] Starting subtest: create-close [59.567058] Subtest create-close: SUCCESS (0.000s) [59.661499] [012/171] (945s left) gem_basic (create-fd-close) [59.773555] Starting subtest: create-fd-close [59.775633] Subtest create-fd-close: SUCCESS (0.000s) [59.865645] [013/171] (945s left) gem_busy (busy@all-engines) [59.993236] Starting subtest: busy [59.994405] Starting dynamic subtest: all-engines [60.052591] Dynamic subtest all-engines: SUCCESS (0.060s) [60.053913] Subtest busy: SUCCESS (0.060s) [60.440375] [014/171] (944s left) gem_close_race (basic-process) [60.573484] Starting subtest: basic-process [60.637619] Subtest basic-process: SUCCESS (0.065s) [60.834978] [015/171] (944s left) gem_close_race (basic-threads) [60.964818] Starting subtest: basic-threads [62.135612] Subtest basic-threads: SUCCESS (1.170s) [62.348612] [016/171] (942s left) gem_ctx_create (basic) [62.480880] Starting subtest: basic [62.482139] Subtest basic: SUCCESS (0.000s) [62.682338] [017/171] (942s left) gem_ctx_create (basic-files) [62.805376] Starting subtest: basic-files [64.826377] Subtest basic-files: SUCCESS (2.022s) [65.067933] [018/171] (939s left) gem_ctx_exec (basic) [65.225383] Starting subtest: basic [65.229783] Subtest basic: SUCCESS (0.004s) [65.329586] [019/171] (939s left) gem_exec_basic (basic) [65.448101] Starting subtest: basic [65.449255] Starting dynamic subtest: rcs0-smem [65.450346] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [65.461410] Starting dynamic subtest: bcs0-smem [65.462540] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [65.472524] Starting dynamic subtest: vcs0-smem [65.473684] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [65.483599] Starting dynamic subtest: vecs0-smem [65.484762] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [65.486028] Subtest basic: SUCCESS (0.006s) [65.651695] [020/171] (939s left) gem_exec_create (basic) [65.772346] Starting subtest: basic [65.773514] Starting dynamic subtest: smem [67.820361] Dynamic subtest smem: SUCCESS (2.048s) [67.821584] Subtest basic: SUCCESS (2.048s) [68.047262] [021/171] (937s left) gem_exec_fence (basic-busy) [68.315019] Starting subtest: basic-busy [68.316266] Starting dynamic subtest: rcs0 [68.359950] Dynamic subtest rcs0: SUCCESS (0.044s) [68.374901] Starting dynamic subtest: bcs0 [68.388489] Dynamic subtest bcs0: SUCCESS (0.029s) [68.399084] Starting dynamic subtest: vcs0 [68.409616] Dynamic subtest vcs0: SUCCESS (0.021s) [68.420314] Starting dynamic subtest: vecs0 [68.428355] Dynamic subtest vecs0: SUCCESS (0.019s) [68.429509] Subtest basic-busy: SUCCESS (0.114s) [69.040815] [022/171] (936s left) gem_exec_fence (basic-wait) [69.308356] Starting subtest: basic-wait [69.309722] Starting dynamic subtest: rcs0 [69.325910] Dynamic subtest rcs0: SUCCESS (0.027s) [69.338927] Starting dynamic subtest: bcs0 [69.346367] Dynamic subtest bcs0: SUCCESS (0.021s) [69.357564] Starting dynamic subtest: vcs0 [69.369468] Dynamic subtest vcs0: SUCCESS (0.023s) [69.380663] Starting dynamic subtest: vecs0 [69.388281] Dynamic subtest vecs0: SUCCESS (0.019s) [69.389639] Subtest basic-wait: SUCCESS (0.090s) [69.920300] [023/171] (935s left) gem_exec_fence (basic-await) [70.185720] Starting subtest: basic-await [70.186910] Starting dynamic subtest: rcs0 [70.268364] Dynamic subtest rcs0: SUCCESS (0.090s) [70.294823] Starting dynamic subtest: bcs0 [70.383353] Dynamic subtest bcs0: SUCCESS (0.114s) [70.410533] Starting dynamic subtest: vcs0 [70.496249] Dynamic subtest vcs0: SUCCESS (0.113s) [70.524417] Starting dynamic subtest: vecs0 [70.616186] Dynamic subtest vecs0: SUCCESS (0.119s) [70.618192] Subtest basic-await: SUCCESS (0.438s) [71.170283] [024/171] (934s left) gem_exec_fence (nb-await) [71.436889] Starting subtest: nb-await [71.438046] Starting dynamic subtest: rcs0 [71.495826] Dynamic subtest rcs0: SUCCESS (0.067s) [71.513538] Starting dynamic subtest: bcs0 [71.564070] Dynamic subtest bcs0: SUCCESS (0.068s) [71.591049] Starting dynamic subtest: vcs0 [71.638233] Dynamic subtest vcs0: SUCCESS (0.074s) [71.664831] Starting dynamic subtest: vecs0 [71.710774] Dynamic subtest vecs0: SUCCESS (0.072s) [71.713303] Subtest nb-await: SUCCESS (0.282s) [72.285852] [025/171] (932s left) gem_exec_gttfill (basic) [72.408689] Starting subtest: basic [79.803023] Subtest basic: SUCCESS (7.386s) [79.980422] [026/171] (925s left) gem_exec_parallel (engines) [80.178414] Starting subtest: engines [80.179655] Starting dynamic subtest: basic [82.616447] Dynamic subtest basic: SUCCESS (2.413s) [82.629233] Starting dynamic subtest: contexts [85.943078] Dynamic subtest contexts: SUCCESS (3.344s) [85.956887] Starting dynamic subtest: fds [90.548076] Dynamic subtest fds: SUCCESS (4.613s) [90.563392] Starting dynamic subtest: userptr [93.025245] Dynamic subtest userptr: SUCCESS (2.452s) [93.026962] Subtest engines: SUCCESS (12.824s) [93.210572] [027/171] (912s left) gem_exec_store (basic) [93.336394] Starting subtest: basic [93.393831] Subtest basic: SUCCESS (0.057s) [93.584102] [028/171] (911s left) gem_flink_basic (bad-flink) [93.692717] Starting subtest: bad-flink [93.693865] Subtest bad-flink: SUCCESS (0.000s) [93.769474] [029/171] (911s left) gem_flink_basic (bad-open) [93.884214] Starting subtest: bad-open [93.885309] Subtest bad-open: SUCCESS (0.000s) [93.970844] [030/171] (911s left) gem_flink_basic (basic) [94.079271] Starting subtest: basic [94.080433] Subtest basic: SUCCESS (0.000s) [94.186772] [031/171] (911s left) gem_flink_basic (double-flink) [94.294824] Starting subtest: double-flink [94.296128] Subtest double-flink: SUCCESS (0.000s) [94.403392] [032/171] (911s left) gem_flink_basic (flink-lifetime) [94.512259] Starting subtest: flink-lifetime [94.513437] Subtest flink-lifetime: SUCCESS (0.002s) [94.619406] [033/171] (910s left) gem_huc_copy (huc-copy) [94.737081] Starting subtest: huc-copy [94.739467] Subtest huc-copy: SKIP (0.000s) [94.854121] [034/171] (910s left) gem_linear_blits (basic) [95.119595] Starting subtest: basic [95.132662] Subtest basic: SUCCESS (0.013s) [95.276541] [035/171] (910s left) gem_mmap (basic) [95.460706] Starting subtest: basic [95.466268] Subtest basic: SUCCESS (0.001s) [95.548475] [036/171] (909s left) gem_mmap_gtt (basic) [95.659371] Starting subtest: basic [95.660516] Subtest basic: SUCCESS (0.001s) [95.734615] [037/171] (909s left) gem_render_linear_blits (basic) [95.848454] Starting subtest: basic [95.899107] Subtest basic: SUCCESS (0.050s) [95.965255] [038/171] (909s left) gem_render_tiled_blits (basic) [96.081457] Starting subtest: basic [96.139365] Subtest basic: SUCCESS (0.058s) [96.204883] [039/171] (909s left) gem_ringfill (basic-all) [96.473932] Starting subtest: basic-all [97.715613] Subtest basic-all: SUCCESS (1.233s) [97.798726] [040/171] (907s left) gem_softpin (allocator-basic) [97.916187] Starting subtest: allocator-basic [98.081551] Subtest allocator-basic: SUCCESS (0.157s) [98.201371] [041/171] (907s left) gem_softpin (allocator-basic-reserve) [98.314372] Starting subtest: allocator-basic-reserve [98.479204] Subtest allocator-basic-reserve: SUCCESS (0.156s) [98.618192] [042/171] (907s left) gem_softpin (safe-alignment) [98.734896] Starting subtest: safe-alignment [98.751849] Subtest safe-alignment: SUCCESS (0.017s) [98.873510] [043/171] (906s left) gem_sync (basic-all) [98.996848] Starting subtest: basic-all [101.514663] Subtest basic-all: SUCCESS (2.491s) [101.688183] [044/171] (904s left) gem_sync (basic-each) [101.810903] Starting subtest: basic-each [104.140665] Subtest basic-each: SUCCESS (2.330s) [104.343242] [045/171] (901s left) gem_tiled_blits (basic) [104.594336] Starting subtest: basic [104.623681] Subtest basic: SUCCESS (0.030s) [104.755711] [046/171] (901s left) gem_tiled_fence_blits (basic) [105.092034] Starting subtest: basic [105.119238] Subtest basic: SUCCESS (0.027s) [105.251731] [047/171] (900s left) gem_tiled_pread_basic [105.771962] [048/171] (900s left) gem_wait (busy@all-engines) [105.902061] Starting subtest: busy [105.903269] Starting dynamic subtest: all-engines [106.435349] Dynamic subtest all-engines: SUCCESS (0.533s) [106.436537] Subtest busy: SUCCESS (0.534s) [106.697978] [049/171] (899s left) gem_wait (wait@all-engines) [106.825192] Starting subtest: wait [106.826372] Starting dynamic subtest: all-engines [107.870347] Dynamic subtest all-engines: SUCCESS (1.044s) [107.872206] Subtest wait: SUCCESS (1.045s) [108.106411] [050/171] (897s left) i915_getparams_basic (basic-eu-total) [108.215654] Starting subtest: basic-eu-total [108.217786] Subtest basic-eu-total: SUCCESS (0.000s) [108.303469] [051/171] (897s left) i915_getparams_basic (basic-subslice-total) [108.412810] Starting subtest: basic-subslice-total [108.414980] Subtest basic-subslice-total: SUCCESS (0.000s) [108.486441] [052/171] (897s left) i915_hangman (error-state-basic) [108.610707] Starting subtest: error-state-basic [108.625086] Subtest error-state-basic: SUCCESS (0.014s) [108.698917] [053/171] (897s left) i915_pciid [108.887565] [054/171] (897s left) kms_addfb_basic (addfb25-bad-modifier) [109.030793] Starting subtest: addfb25-bad-modifier [109.032063] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [109.182897] [055/171] (896s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [109.320671] Starting subtest: addfb25-framebuffer-vs-set-tiling [109.321714] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [109.466343] [056/171] (896s left) kms_addfb_basic (addfb25-modifier-no-flag) [109.603865] Starting subtest: addfb25-modifier-no-flag [109.604977] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [109.749564] [057/171] (896s left) kms_addfb_basic (addfb25-x-tiled-legacy) [109.887823] Starting subtest: addfb25-x-tiled-legacy [109.888908] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [110.032957] [058/171] (896s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [110.171061] Starting subtest: addfb25-x-tiled-mismatch-legacy [110.172258] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [110.316316] [059/171] (895s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [110.477534] Starting subtest: addfb25-yf-tiled-legacy [110.478742] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [110.599515] [060/171] (895s left) kms_addfb_basic (addfb25-y-tiled-legacy) [110.760065] Starting subtest: addfb25-y-tiled-legacy [110.761115] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [110.883078] [061/171] (895s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [111.046354] Starting subtest: addfb25-y-tiled-small-legacy [111.047406] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [111.166094] [062/171] (895s left) kms_addfb_basic (bad-pitch-0) [111.275127] Starting subtest: bad-pitch-0 [111.276174] Subtest bad-pitch-0: SUCCESS (0.000s) [111.449578] [063/171] (894s left) kms_addfb_basic (bad-pitch-1024) [111.560100] Starting subtest: bad-pitch-1024 [111.561172] Subtest bad-pitch-1024: SUCCESS (0.000s) [111.732681] [064/171] (894s left) kms_addfb_basic (bad-pitch-128) [111.842367] Starting subtest: bad-pitch-128 [111.843480] Subtest bad-pitch-128: SUCCESS (0.000s) [112.016029] [065/171] (894s left) kms_addfb_basic (bad-pitch-256) [112.125983] Starting subtest: bad-pitch-256 [112.127079] Subtest bad-pitch-256: SUCCESS (0.000s) [112.299749] [066/171] (894s left) kms_addfb_basic (bad-pitch-32) [112.410358] Starting subtest: bad-pitch-32 [112.411489] Subtest bad-pitch-32: SUCCESS (0.000s) [112.582927] [067/171] (893s left) kms_addfb_basic (bad-pitch-63) [112.691871] Starting subtest: bad-pitch-63 [112.693053] Subtest bad-pitch-63: SUCCESS (0.000s) [112.866395] [068/171] (893s left) kms_addfb_basic (bad-pitch-65536) [112.975525] Starting subtest: bad-pitch-65536 [112.976598] Subtest bad-pitch-65536: SUCCESS (0.000s) [113.149412] [069/171] (893s left) kms_addfb_basic (bad-pitch-999) [113.260149] Starting subtest: bad-pitch-999 [113.261217] Subtest bad-pitch-999: SUCCESS (0.000s) [113.434048] [070/171] (892s left) kms_addfb_basic (basic) [113.542641] Starting subtest: basic [113.543785] Subtest basic: SUCCESS (0.000s) [113.716723] [071/171] (892s left) kms_addfb_basic (basic-x-tiled-legacy) [113.902765] Starting subtest: basic-x-tiled-legacy [113.903889] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [113.999396] [072/171] (892s left) kms_addfb_basic (basic-y-tiled-legacy) [114.185681] Starting subtest: basic-y-tiled-legacy [114.186955] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [114.266524] [073/171] (892s left) kms_addfb_basic (bo-too-small) [114.405250] Starting subtest: bo-too-small [114.406346] Subtest bo-too-small: SUCCESS (0.000s) [114.549649] [074/171] (891s left) kms_addfb_basic (bo-too-small-due-to-tiling) [114.686906] Starting subtest: bo-too-small-due-to-tiling [114.688089] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [114.832903] [075/171] (891s left) kms_addfb_basic (clobberred-modifier) [114.942740] Starting subtest: clobberred-modifier [114.943996] Subtest clobberred-modifier: SUCCESS (0.000s) [115.116138] [076/171] (891s left) kms_addfb_basic (framebuffer-vs-set-tiling) [115.302235] Starting subtest: framebuffer-vs-set-tiling [115.303370] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [115.399560] [077/171] (891s left) kms_addfb_basic (invalid-get-prop) [115.584446] Starting subtest: invalid-get-prop [115.585544] Subtest invalid-get-prop: SUCCESS (0.000s) [115.682889] [078/171] (890s left) kms_addfb_basic (invalid-get-prop-any) [115.869316] Starting subtest: invalid-get-prop-any [115.870418] Subtest invalid-get-prop-any: SUCCESS (0.000s) [115.966277] [079/171] (890s left) kms_addfb_basic (invalid-set-prop) [116.151655] Starting subtest: invalid-set-prop [116.152715] Subtest invalid-set-prop: SUCCESS (0.000s) [116.249375] [080/171] (890s left) kms_addfb_basic (invalid-set-prop-any) [116.437629] Starting subtest: invalid-set-prop-any [116.438768] Subtest invalid-set-prop-any: SUCCESS (0.000s) [116.532994] [081/171] (890s left) kms_addfb_basic (no-handle) [116.641630] Starting subtest: no-handle [116.642757] Subtest no-handle: SUCCESS (0.000s) [116.799500] [082/171] (889s left) kms_addfb_basic (size-max) [116.937130] Starting subtest: size-max [116.938268] Subtest size-max: SUCCESS (0.000s) [117.083061] [083/171] (889s left) kms_addfb_basic (small-bo) [117.219516] Starting subtest: small-bo [117.220544] Subtest small-bo: SUCCESS (0.000s) [117.366431] [084/171] (889s left) kms_addfb_basic (tile-pitch-mismatch) [117.552354] Starting subtest: tile-pitch-mismatch [117.553515] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [117.649501] [085/171] (889s left) kms_addfb_basic (too-high) [117.785236] Starting subtest: too-high [117.786473] Subtest too-high: SUCCESS (0.001s) [117.949605] [086/171] (888s left) kms_addfb_basic (too-wide) [118.086255] Starting subtest: too-wide [118.087340] Subtest too-wide: SUCCESS (0.000s) [118.233060] [087/171] (888s left) kms_addfb_basic (unused-handle) [118.343670] Starting subtest: unused-handle [118.344926] Subtest unused-handle: SUCCESS (0.000s) [118.516533] [088/171] (888s left) kms_addfb_basic (unused-modifier) [118.625817] Starting subtest: unused-modifier [118.626949] Subtest unused-modifier: SUCCESS (0.000s) [118.799366] [089/171] (888s left) kms_addfb_basic (unused-offsets) [118.907805] Starting subtest: unused-offsets [118.908915] Subtest unused-offsets: SUCCESS (0.000s) [119.082772] [090/171] (887s left) kms_addfb_basic (unused-pitches) [119.191760] Starting subtest: unused-pitches [119.193100] Subtest unused-pitches: SUCCESS (0.000s) [119.366377] [091/171] (887s left) kms_busy (basic) [119.515488] Starting subtest: basic [119.518018] Starting dynamic subtest: flip [120.484797] Dynamic subtest flip: SUCCESS (0.965s) [120.500585] Starting dynamic subtest: modeset [124.300185] Dynamic subtest modeset: SUCCESS (3.818s) [124.301315] Subtest basic: SUCCESS (4.785s) [125.233873] [092/171] (881s left) kms_chamelium_hpd (dp-hpd-fast) [125.688701] Subtest dp-hpd-fast: SKIP (0.000s) [126.575878] [093/171] (880s left) kms_chamelium_edid (dp-edid-read) [127.027103] Subtest dp-edid-read: SKIP (0.000s) [127.918204] [094/171] (879s left) kms_chamelium_frames (dp-crc-fast) [128.369407] Subtest dp-crc-fast: SKIP (0.000s) [129.263269] [095/171] (877s left) kms_chamelium_hpd (hdmi-hpd-fast) [129.711418] Subtest hdmi-hpd-fast: SKIP (0.000s) [130.607546] [096/171] (876s left) kms_chamelium_edid (hdmi-edid-read) [131.059818] Subtest hdmi-edid-read: SKIP (0.000s) [131.952320] [097/171] (875s left) kms_chamelium_frames (hdmi-crc-fast) [132.399997] Subtest hdmi-crc-fast: SKIP (0.000s) [133.293511] [098/171] (873s left) kms_chamelium_hpd (vga-hpd-fast) [133.739717] Subtest vga-hpd-fast: SKIP (0.000s) [134.637637] [099/171] (872s left) kms_chamelium_edid (vga-edid-read) [135.085352] Subtest vga-edid-read: SKIP (0.000s) [135.983472] [100/171] (871s left) kms_prop_blob (basic) [136.095185] Starting subtest: basic [136.096407] Subtest basic: SUCCESS (0.000s) [136.191341] [101/171] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [136.329248] Starting subtest: basic-busy-flip-before-cursor-atomic [136.331502] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [136.413695] [102/171] (870s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [136.551637] Starting subtest: basic-busy-flip-before-cursor-legacy [136.553814] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [136.629769] [103/171] (870s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [136.766263] Starting subtest: basic-flip-after-cursor-atomic [138.076292] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.311s) [139.039805] [104/171] (868s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [139.178045] Starting subtest: basic-flip-after-cursor-legacy [140.458128] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.280s) [141.407637] [105/171] (865s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [141.546289] Starting subtest: basic-flip-after-cursor-varying-size [142.835432] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.289s) [143.775405] [106/171] (863s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [143.913378] Starting subtest: basic-flip-before-cursor-atomic [145.204093] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.290s) [146.143669] [107/171] (861s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [146.282462] Starting subtest: basic-flip-before-cursor-legacy [147.571442] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.290s) [148.510045] [108/171] (858s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [148.646238] Starting subtest: basic-flip-before-cursor-varying-size [149.939748] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.293s) [150.879876] [109/171] (856s left) kms_flip (basic-flip-vs-dpms) [151.000212] Starting subtest: basic-flip-vs-dpms [151.003283] Starting dynamic subtest: A-eDP1 [153.878488] Dynamic subtest A-eDP1: SUCCESS (2.875s) [153.903974] Starting dynamic subtest: B-eDP1 [156.250442] Dynamic subtest B-eDP1: SUCCESS (2.370s) [156.266060] Starting dynamic subtest: C-eDP1 [158.615618] Dynamic subtest C-eDP1: SUCCESS (2.367s) [158.618653] Subtest basic-flip-vs-dpms: SUCCESS (7.619s) [159.583487] [110/171] (847s left) kms_flip (basic-flip-vs-modeset) [159.703303] Starting subtest: basic-flip-vs-modeset [159.706403] Starting dynamic subtest: A-eDP1 [162.581520] Dynamic subtest A-eDP1: SUCCESS (2.875s) [162.600153] Starting dynamic subtest: B-eDP1 [164.950431] Dynamic subtest B-eDP1: SUCCESS (2.367s) [164.966314] Starting dynamic subtest: C-eDP1 [167.326041] Dynamic subtest C-eDP1: SUCCESS (2.372s) [167.327141] Subtest basic-flip-vs-modeset: SUCCESS (7.623s) [168.287261] [111/171] (839s left) kms_flip (basic-flip-vs-wf_vblank) [168.404802] Starting subtest: basic-flip-vs-wf_vblank [168.408917] Starting dynamic subtest: A-eDP1 [170.753745] Dynamic subtest A-eDP1: SUCCESS (2.345s) [170.769743] Starting dynamic subtest: B-eDP1 [173.041413] Dynamic subtest B-eDP1: SUCCESS (2.287s) [173.057515] Starting dynamic subtest: C-eDP1 [175.281534] Dynamic subtest C-eDP1: SUCCESS (2.239s) [175.284039] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.879s) [176.545079] [112/171] (830s left) kms_flip (basic-plain-flip) [176.662411] Starting subtest: basic-plain-flip [176.667890] Starting dynamic subtest: A-eDP1 [178.726499] Dynamic subtest A-eDP1: SUCCESS (2.060s) [178.742686] Starting dynamic subtest: B-eDP1 [180.694263] Dynamic subtest B-eDP1: SUCCESS (1.967s) [180.710501] Starting dynamic subtest: C-eDP1 [182.678173] Dynamic subtest C-eDP1: SUCCESS (1.983s) [182.680699] Subtest basic-plain-flip: SUCCESS (6.019s) [183.967968] [113/171] (823s left) kms_force_connector_basic (force-connector-state) [184.086487] Starting subtest: force-connector-state [184.809393] Subtest force-connector-state: SUCCESS (0.723s) [185.704847] [114/171] (821s left) kms_force_connector_basic (force-edid) [185.821697] Starting subtest: force-edid [186.074303] Subtest force-edid: SUCCESS (0.252s) [186.187693] [115/171] (821s left) kms_force_connector_basic (force-load-detect) [186.302985] Starting subtest: force-load-detect [186.305531] Subtest force-load-detect: SKIP (0.000s) [186.404467] [116/171] (821s left) kms_force_connector_basic (prune-stale-modes) [186.520698] Starting subtest: prune-stale-modes [186.829107] Subtest prune-stale-modes: SUCCESS (0.309s) [186.954218] [117/171] (820s left) kms_frontbuffer_tracking (basic) [187.101265] Starting subtest: basic [190.469450] Subtest basic: SUCCESS (3.369s) [190.572409] [118/171] (817s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [190.717147] Starting subtest: compare-crc-sanitycheck [190.718302] Starting dynamic subtest: pipe-A-eDP-1 [191.403060] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.684s) [191.420783] Starting dynamic subtest: pipe-B-eDP-1 [192.788778] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.383s) [192.805525] Starting dynamic subtest: pipe-C-eDP-1 [194.181422] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.390s) [194.182547] Subtest compare-crc-sanitycheck: SUCCESS (3.465s) [195.121179] [119/171] (812s left) kms_pipe_crc_basic (hang-read-crc) [195.262082] Starting subtest: hang-read-crc [195.263307] Starting dynamic subtest: pipe-A-eDP-1 [197.644729] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.381s) [197.661319] Starting dynamic subtest: pipe-B-eDP-1 [200.662138] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.014s) [200.680160] Starting dynamic subtest: pipe-C-eDP-1 [203.695653] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.032s) [203.696832] Subtest hang-read-crc: SUCCESS (8.435s) [204.638939] [120/171] (803s left) kms_pipe_crc_basic (nonblocking-crc) [204.777835] Starting subtest: nonblocking-crc [204.780798] Starting dynamic subtest: pipe-A-eDP-1 [205.641078] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.860s) [205.656941] Starting dynamic subtest: pipe-B-eDP-1 [207.208924] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.566s) [207.226566] Starting dynamic subtest: pipe-C-eDP-1 [208.796728] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.585s) [208.797937] Subtest nonblocking-crc: SUCCESS (4.019s) [209.760449] [121/171] (797s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [209.903745] Starting subtest: nonblocking-crc-frame-sequence [209.906900] Starting dynamic subtest: pipe-A-eDP-1 [210.772621] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.867s) [210.790475] Starting dynamic subtest: pipe-B-eDP-1 [212.373411] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.597s) [212.391103] Starting dynamic subtest: pipe-C-eDP-1 [213.977908] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.602s) [213.979170] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.075s) [214.943445] [122/171] (792s left) kms_pipe_crc_basic (read-crc) [215.082556] Starting subtest: read-crc [215.085733] Starting dynamic subtest: pipe-A-eDP-1 [215.876078] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.791s) [215.894679] Starting dynamic subtest: pipe-B-eDP-1 [217.370130] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.491s) [217.387927] Starting dynamic subtest: pipe-C-eDP-1 [218.905243] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.531s) [218.906450] Subtest read-crc: SUCCESS (3.822s) [219.870459] [123/171] (787s left) kms_pipe_crc_basic (read-crc-frame-sequence) [220.009376] Starting subtest: read-crc-frame-sequence [220.012460] Starting dynamic subtest: pipe-A-eDP-1 [220.805981] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.794s) [220.823998] Starting dynamic subtest: pipe-B-eDP-1 [222.312682] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.503s) [222.328607] Starting dynamic subtest: pipe-C-eDP-1 [223.845780] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.530s) [223.846960] Subtest read-crc-frame-sequence: SUCCESS (3.835s) [224.800156] [124/171] (782s left) kms_psr (primary_page_flip) [224.943624] Starting subtest: primary_page_flip [227.152491] Subtest primary_page_flip: FAIL (1.904s) [227.181514] [125/171] (780s left) kms_psr (cursor_plane_move) [227.341939] Starting subtest: cursor_plane_move [229.479853] Subtest cursor_plane_move: FAIL (1.856s) [229.505701] [126/171] (778s left) kms_psr (sprite_plane_onoff) [229.646455] Starting subtest: sprite_plane_onoff [231.801884] Subtest sprite_plane_onoff: FAIL (1.865s) [231.828627] [127/171] (776s left) kms_psr (primary_mmap_gtt) [231.969388] Starting subtest: primary_mmap_gtt [234.161977] Subtest primary_mmap_gtt: FAIL (1.907s) [234.188167] [128/171] (773s left) kms_setmode (basic-clone-single-crtc) [234.300450] Starting subtest: basic-clone-single-crtc [234.303714] Subtest basic-clone-single-crtc: SKIP (0.000s) [234.379376] [129/171] (773s left) i915_pm_backlight (basic-brightness) [234.518988] Starting subtest: basic-brightness [234.636892] Starting dynamic subtest: eDP-1 [235.160250] Dynamic subtest eDP-1: SUCCESS (0.531s) [235.161404] Subtest basic-brightness: SUCCESS (0.640s) [236.126983] [130/171] (771s left) i915_pm_rpm (basic-pci-d3-state) [237.979080] Starting subtest: basic-pci-d3-state [242.364503] Subtest basic-pci-d3-state: SUCCESS (4.385s) [242.565404] [131/171] (765s left) i915_pm_rpm (basic-rte) [242.674807] Starting subtest: basic-rte [248.829342] Subtest basic-rte: SUCCESS (6.151s) [254.131516] [132/171] (753s left) i915_pm_rps (basic-api) [254.251328] Starting subtest: basic-api [254.255554] Subtest basic-api: SUCCESS (0.004s) [254.330941] [133/171] (753s left) prime_self_import (basic-llseek-bad) [254.440271] Starting subtest: basic-llseek-bad [254.443738] Subtest basic-llseek-bad: SUCCESS (0.003s) [254.552069] [134/171] (753s left) prime_self_import (basic-llseek-size) [254.664306] Starting subtest: basic-llseek-size [254.665613] Subtest basic-llseek-size: SUCCESS (0.004s) [254.768302] [135/171] (753s left) prime_self_import (basic-with_fd_dup) [254.879433] Starting subtest: basic-with_fd_dup [254.882707] Subtest basic-with_fd_dup: SUCCESS (0.004s) [254.984451] [136/171] (753s left) prime_self_import (basic-with_one_bo) [255.092331] Starting subtest: basic-with_one_bo [255.097847] Subtest basic-with_one_bo: SUCCESS (0.005s) [255.183350] [137/171] (752s left) prime_self_import (basic-with_one_bo_two_files) [255.295478] Starting subtest: basic-with_one_bo_two_files [255.296809] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [255.384894] [138/171] (752s left) prime_self_import (basic-with_two_bos) [255.493495] Starting subtest: basic-with_two_bos [255.499324] Subtest basic-with_two_bos: SUCCESS (0.004s) [255.601474] [139/171] (752s left) prime_vgem (basic-fence-flip) [255.737266] Starting subtest: basic-fence-flip [256.262099] Subtest basic-fence-flip: SUCCESS (0.524s) [256.383246] [140/171] (751s left) prime_vgem (basic-fence-mmap) [256.503385] Starting subtest: basic-fence-mmap [256.545356] Subtest basic-fence-mmap: SUCCESS (0.042s) [256.655269] [141/171] (751s left) prime_vgem (basic-fence-read) [256.787176] Starting subtest: basic-fence-read [256.853927] Subtest basic-fence-read: SUCCESS (0.066s) [256.937305] [142/171] (751s left) prime_vgem (basic-gtt) [257.073818] Starting subtest: basic-gtt [257.096036] Subtest basic-gtt: SUCCESS (0.022s) [257.186346] [143/171] (751s left) prime_vgem (basic-read) [257.326620] Starting subtest: basic-read [257.361454] Subtest basic-read: SUCCESS (0.035s) [257.468349] [144/171] (750s left) prime_vgem (basic-write) [257.605030] Starting subtest: basic-write [257.645307] Subtest basic-write: SUCCESS (0.040s) [257.735324] [145/171] (750s left) prime_vgem (basic-userptr) [257.871538] Starting subtest: basic-userptr [257.886382] Subtest basic-userptr: SKIP (0.013s) [258.007794] [146/171] (750s left) vgem_basic (setversion) [258.129019] Starting subtest: setversion [258.131369] Subtest setversion: SUCCESS (0.000s) [258.201088] [147/171] (750s left) vgem_basic (create) [258.329454] Starting subtest: create [258.330636] Subtest create: SUCCESS (0.000s) [258.401414] [148/171] (750s left) vgem_basic (debugfs) [258.530174] Starting subtest: debugfs [258.531450] Subtest debugfs: SUCCESS (0.001s) [258.597865] [149/171] (749s left) vgem_basic (dmabuf-export) [258.712367] Starting subtest: dmabuf-export [258.716036] Subtest dmabuf-export: SUCCESS (0.003s) [258.818238] [150/171] (749s left) vgem_basic (dmabuf-fence) [258.946468] Starting subtest: dmabuf-fence [258.947700] Subtest dmabuf-fence: SUCCESS (0.001s) [259.018584] [151/171] (749s left) vgem_basic (dmabuf-fence-before) [259.145984] Starting subtest: dmabuf-fence-before [259.147267] Subtest dmabuf-fence-before: SUCCESS (0.000s) [259.216693] [152/171] (749s left) vgem_basic (dmabuf-mmap) [259.346300] Starting subtest: dmabuf-mmap [259.371757] Subtest dmabuf-mmap: SUCCESS (0.025s) [259.430425] [153/171] (749s left) vgem_basic (mmap) [259.545693] Starting subtest: mmap [259.562376] Subtest mmap: SUCCESS (0.017s) [259.632423] [154/171] (748s left) vgem_basic (second-client) [259.745557] Starting subtest: second-client [259.798618] Subtest second-client: SUCCESS (0.050s) [259.868510] [155/171] (748s left) vgem_basic (sysfs) [259.996415] Starting subtest: sysfs [259.997593] Subtest sysfs: SUCCESS (0.001s) [260.068629] [156/171] (748s left) core_hotunplug (unbind-rebind) [260.212511] Starting subtest: unbind-rebind [262.553627] Subtest unbind-rebind: SUCCESS (2.341s) [262.586285] [157/171] (746s left) vgem_basic (unload) [262.707193] Starting subtest: unload [291.552138] Subtest unload: SUCCESS (28.811s) [291.662231] [158/171] (717s left) i915_module_load (reload) [291.774648] Starting subtest: reload [294.979742] Subtest reload: SUCCESS (3.205s) [295.007571] [159/171] (713s left) gem_lmem_swapping (basic) [295.141203] Subtest basic: SKIP (0.000s) [295.180806] [160/171] (713s left) gem_lmem_swapping (parallel-random-engines) [295.299234] Subtest parallel-random-engines: SKIP (0.000s) [295.346673] [161/171] (713s left) gem_lmem_swapping (random-engines) [295.471395] Subtest random-engines: SKIP (0.000s) [295.513553] [162/171] (713s left) gem_lmem_swapping (verify-random) [295.634640] Subtest verify-random: SKIP (0.000s) [295.680884] [163/171] (713s left) i915_pm_rpm (module-reload) [308.165569] Starting subtest: module-reload [342.392800] Subtest module-reload: SUCCESS (34.219s) [342.412565] [164/171] (666s left) i915_selftest (live) [342.537874] Starting subtest: live [342.539440] Starting dynamic subtest: sanitycheck [344.336994] Dynamic subtest sanitycheck: SUCCESS (1.798s) [344.350232] Starting dynamic subtest: uncore [346.133589] Dynamic subtest uncore: SUCCESS (1.787s) [346.148257] Starting dynamic subtest: workarounds [348.133302] Dynamic subtest workarounds: SUCCESS (1.999s) [348.148218] Starting dynamic subtest: gt_engines [350.366509] Dynamic subtest gt_engines: SUCCESS (2.232s) [350.381153] Starting dynamic subtest: gt_timelines [362.244675] Dynamic subtest gt_timelines: SUCCESS (11.877s) [362.259440] Starting dynamic subtest: gt_contexts [364.126382] Dynamic subtest gt_contexts: SUCCESS (1.881s) [364.141156] Starting dynamic subtest: gt_lrc [368.427405] Dynamic subtest gt_lrc: SUCCESS (4.300s) [368.442199] Starting dynamic subtest: gt_mocs [370.330514] Dynamic subtest gt_mocs: SUCCESS (1.902s) [370.345369] Starting dynamic subtest: gt_pm [375.335590] Dynamic subtest gt_pm: SUCCESS (5.004s) [375.350610] Starting dynamic subtest: gt_heartbeat [377.171481] Dynamic subtest gt_heartbeat: SUCCESS (1.835s) [377.186508] Starting dynamic subtest: requests [384.779690] Dynamic subtest requests: SUCCESS (7.607s) [384.794615] Starting dynamic subtest: migrate [389.312546] Dynamic subtest migrate: SUCCESS (4.532s) [389.327451] Starting dynamic subtest: active [391.134415] Dynamic subtest active: SUCCESS (1.821s) [391.149328] Starting dynamic subtest: objects [394.597359] Dynamic subtest objects: SUCCESS (3.462s) [394.612323] Starting dynamic subtest: mman [401.500524] Dynamic subtest mman: SUCCESS (6.902s) [401.515513] Starting dynamic subtest: dmabuf [403.305454] Dynamic subtest dmabuf: SUCCESS (1.804s) [403.320486] Starting dynamic subtest: vma [405.092388] Dynamic subtest vma: SUCCESS (1.786s) [405.107396] Starting dynamic subtest: coherency [409.454420] Dynamic subtest coherency: SUCCESS (4.361s) [409.468915] Starting dynamic subtest: gtt [420.608618] Dynamic subtest gtt: SUCCESS (11.153s) [420.623782] Starting dynamic subtest: gem [422.522323] Dynamic subtest gem: SUCCESS (1.913s) [422.537398] Starting dynamic subtest: evict [426.205457] Dynamic subtest evict: SUCCESS (3.682s) [426.220330] Starting dynamic subtest: hugepages [433.079662] Dynamic subtest hugepages: SUCCESS (6.873s) [433.094899] Starting dynamic subtest: gem_contexts [448.016741] Dynamic subtest gem_contexts: SUCCESS (14.936s) [448.032166] Starting dynamic subtest: client [449.819474] Dynamic subtest client: SUCCESS (1.802s) [449.835022] Starting dynamic subtest: gem_migrate [451.603455] Dynamic subtest gem_migrate: SUCCESS (1.783s) [451.619050] Starting dynamic subtest: reset [456.941556] Dynamic subtest reset: SUCCESS (5.337s) [456.957331] Starting dynamic subtest: memory_region [458.706525] Dynamic subtest memory_region: SUCCESS (1.764s) [458.722179] Starting dynamic subtest: hangcheck [483.129503] Dynamic subtest hangcheck: SUCCESS (24.422s) [483.145120] Starting dynamic subtest: execlists [493.107536] Dynamic subtest execlists: SUCCESS (9.977s) [493.123183] Starting dynamic subtest: ring_submission [494.873351] Dynamic subtest ring_submission: SUCCESS (1.765s) [494.889472] Starting dynamic subtest: perf [496.738418] Dynamic subtest perf: SUCCESS (1.864s) [496.753987] Starting dynamic subtest: slpc [528.882681] Dynamic subtest slpc: SUCCESS (1.789s) [528.903534] Starting dynamic subtest: guc [528.905188] Dynamic subtest guc: SUCCESS (1.716s) [528.916491] Starting dynamic subtest: guc_multi_lrc [528.917753] Dynamic subtest guc_multi_lrc: SUCCESS (1.787s) [528.928878] Starting dynamic subtest: guc_hang