Page MenuHomePhabricator

sdwdate sclockadj ruby-inline require bug
Closed, ResolvedPublic

Description

5767: Launching into background:       sudo          INLINEDIR=/var/cache/sdwdate             /usr/lib/sdwdate/sclockadj                --no-verbose                --no-debug                --no-first-wait                                --move-min 500000                --move-max 500000                --wait-min 1000000000                --wait-max 1000000000                --subtract 1290159494    
5767: Started subshell for sclockadj with pid: 25369
5767: sdwdate_subshell_read: start
5767: dispatching post_success (SDW_MODE: daemon): /usr/lib/timesync/timesync_post_success --autostart --identifier "timesync" --progressbaridx "$ID" --mode "$SDW_MODE" --whoami "$who_ami"
5767: sdwdate_subshell_read: sclockadj reports: Time before running sclockadj: 1418677914.833885947 [Mon Dec 15 21:11:54 UTC 2014]
5767: sdwdate_subshell_read: sclockadj reports: sdwdate_subshell_wait: Waiting for pid to finish SDWDATE_SCLOCKADJ_COMMAND_PID: 25380
5767: sdwdate_subshell_read: sclockadj reports: /usr/lib/ruby/1.9.1/rubygems/custom_require.rb:36:in `require': cannot load such file -- /var/cache/sdwdate/.ruby_inline/ruby-1.9.1/Inline_Cinline_45aeaf467303ff06d9c25b91daa74e32.so (LoadError)
5767: sdwdate_subshell_read: sclockadj reports: from /usr/lib/ruby/1.9.1/rubygems/custom_require.rb:36:in `require'
5767: sdwdate_subshell_read: sclockadj reports: from /usr/lib/ruby/vendor_ruby/inline.rb:531:in `load'
5767: sdwdate_subshell_read: sclockadj reports: from /usr/lib/ruby/vendor_ruby/inline.rb:844:in `inline'
5767: sdwdate_subshell_read: sclockadj reports: from /usr/lib/sdwdate/sclockadj:189:in `<class:Cinline>'
5767: sdwdate_subshell_read: sclockadj reports: from /usr/lib/sdwdate/sclockadj:187:in `<main>'
5767: sdwdate_subshell_read: sclockadj reports: sdwdate_subshell_wait: SDWDATE_SCLOCKADJ_COMMAND_PID: 25380 | SDWDATE_SCLOCKADJ_COMMAND_EXIT_CODE: 1
5767: sdwdate_subshell_read: sclockadj reports: was running for 0 s [~ 0.00 min] [~ 0.00 h].
5767: sdwdate_subshell_read: sclockadj reports: Time after running sclockadj: 1418677914.953156268 [Mon Dec 15 21:11:54 UTC 2014]
5767: sdwdate_subshell_read: sclockadj reports: exit code: 1
5767: sdwdate_subshell_read: end

Spontaneously happened out of nowhere. Worked before.

Could not reproduce this by running

sudo          INLINEDIR=/var/cache/sdwdate             /usr/lib/sdwdate/sclockadj                --no-verbose                --no-debug                --no-first-wait                                --move-min 500000                --move-max 500000                --wait-min 1000000000                --wait-max 1000000000                --subtract 1290159494
`

manually afterwards.

Any idea why this could happen?

Event Timeline

Patrick raised the priority of this task from to Normal.
Patrick updated the task description. (Show Details)
Patrick added a subscriber: Patrick.

After some searching, I conclude, it could be related to permissions:
https://github.com/Whonix/sdwdate/blob/master/debian/sdwdate.postinst#L28
Would perhaps be better if owned by root.

It looks like ruby_inline thinks there's pre-compiled code in the inline dir, tries to load it, but fails. I don't know if that's because there isn't the compiled code (and ruby inline should have compiled it) or some other reason. That load error is too generic to be sure.

Patrick claimed this task.

Ok. Closed for now. Should be fixed. Didn't run into this issue for a while now. And if it happens again, there will be helpful debug output. In case I notice again, I'll reopen.